[ 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 449048890 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, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003170] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005012] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010011] pid_max: default: 32768 minimum: 301 [ 0.011354] LSM: Security Framework initializing [ 0.012054] Yama: becoming mindful. [ 0.013036] SELinux: Initializing. [ 0.014067] *** VALIDATE selinux *** [ 0.022568] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026775] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027142] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028098] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029096] *** VALIDATE tmpfs *** [ 0.030431] *** VALIDATE proc *** [ 0.032093] *** VALIDATE cgroup *** [ 0.033008] *** VALIDATE cgroup2 *** [ 0.034267] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035143] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037026] Spectre V2 : User space: Vulnerable [ 0.038006] Speculative Store Bypass: Vulnerable [ 0.040881] debug: unmapping init [mem 0xffffffff85659000-0xffffffff85660fff] [ 0.042248] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043657] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044022] ... version: 2 [ 0.045013] ... bit width: 48 [ 0.046012] ... generic registers: 4 [ 0.047013] ... value mask: 0000ffffffffffff [ 0.048014] ... max period: 00007fffffffffff [ 0.049014] ... fixed-purpose events: 3 [ 0.050013] ... event mask: 000000070000000f [ 0.051349] rcu: Hierarchical SRCU implementation. [ 0.053509] smp: Bringing up secondary CPUs ... [ 0.054635] x86: Booting SMP configuration: [ 0.055025] .... node #0, CPUs: #1 #2 #3 [ 0.060011] smp: Brought up 1 node, 4 CPUs [ 0.062015] smpboot: Max logical packages: 1 [ 0.063014] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.126475] node 0 deferred pages initialised in 60ms [ 0.132172] devtmpfs: initialized [ 0.133240] x86/mm: Memory block size: 128MB [ 0.135984] gcov: version magic: 0x41383552 [ 0.137336] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.138329] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.139441] pinctrl core: initialized pinctrl subsystem [ 0.140187] [ 0.140659] ************************************************************* [ 0.141032] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.142015] ** ** [ 0.143010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.144013] ** ** [ 0.145014] ** This means that this kernel is built to expose internal ** [ 0.146140] ** IOMMU data structures, which may compromise security on ** [ 0.147016] ** your system. ** [ 0.148014] ** ** [ 0.149013] ** If you see this message and you are not debugging the ** [ 0.150014] ** kernel, report this immediately to your vendor! ** [ 0.151015] ** ** [ 0.152012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.153013] ************************************************************* [ 0.154828] NET: Registered protocol family 16 [ 0.155510] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.156060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.157079] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.158630] cpuidle: using governor menu [ 0.160889] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.163519] PCI: Using configuration type 1 for base access [ 0.166197] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.173051] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.175038] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.179071] cryptd: max_cpu_qlen set to 1000 [ 0.182224] ACPI: Added _OSI(Module Device) [ 0.184019] ACPI: Added _OSI(Processor Device) [ 0.185029] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.187013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.192345] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.198588] ACPI: Interpreter enabled [ 0.200063] ACPI: PM: (supports S0 S3 S4 S5) [ 0.202014] ACPI: Using IOAPIC for interrupt routing [ 0.203099] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.207370] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.219604] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.222046] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.225022] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.229080] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.235309] acpiphp: Slot [2] registered [ 0.236164] acpiphp: Slot [5] registered [ 0.238153] acpiphp: Slot [6] registered [ 0.239116] acpiphp: Slot [3] registered [ 0.240091] acpiphp: Slot [4] registered [ 0.241094] acpiphp: Slot [7] registered [ 0.242098] acpiphp: Slot [8] registered [ 0.243110] acpiphp: Slot [9] registered [ 0.245134] acpiphp: Slot [10] registered [ 0.246104] acpiphp: Slot [11] registered [ 0.247095] acpiphp: Slot [12] registered [ 0.248094] acpiphp: Slot [13] registered [ 0.250145] acpiphp: Slot [14] registered [ 0.251083] acpiphp: Slot [15] registered [ 0.252133] acpiphp: Slot [16] registered [ 0.253101] acpiphp: Slot [17] registered [ 0.255124] acpiphp: Slot [18] registered [ 0.256165] acpiphp: Slot [19] registered [ 0.258145] acpiphp: Slot [20] registered [ 0.260137] acpiphp: Slot [21] registered [ 0.262142] acpiphp: Slot [22] registered [ 0.263331] acpiphp: Slot [23] registered [ 0.265171] acpiphp: Slot [24] registered [ 0.267127] acpiphp: Slot [25] registered [ 0.268139] acpiphp: Slot [26] registered [ 0.270171] acpiphp: Slot [27] registered [ 0.272141] acpiphp: Slot [28] registered [ 0.273105] acpiphp: Slot [29] registered [ 0.275131] acpiphp: Slot [30] registered [ 0.277107] acpiphp: Slot [31] registered [ 0.279063] PCI host bridge to bus 0000:00 [ 0.281025] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.283025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.286023] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.289025] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.292026] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.296029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.298153] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.301217] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.305482] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.315015] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.321041] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.324021] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.327019] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.330018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.333620] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.335714] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.338044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.340796] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.344927] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.352986] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.358679] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.364277] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.370013] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.378014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.395033] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.408053] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.415014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.424016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.437000] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.447427] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.450459] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.452356] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.455501] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.457196] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.462038] iommu: Default domain type: Passthrough [ 0.464644] SCSI subsystem initialized [ 0.466181] ACPI: bus type USB registered [ 0.468191] usbcore: registered new interface driver usbfs [ 0.470216] usbcore: registered new interface driver hub [ 0.474173] usbcore: registered new device driver usb [ 0.477313] pps_core: LinuxPPS API ver. 1 registered [ 0.480016] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.483112] PTP clock support registered [ 0.486103] EDAC MC: Ver: 3.0.0 [ 0.488140] PCI: Using ACPI for IRQ routing [ 0.492496] NetLabel: Initializing [ 0.495027] NetLabel: domain hash size = 128 [ 0.497012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.499143] NetLabel: unlabeled traffic allowed by default [ 0.503155] vgaarb: loaded [ 0.504438] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.506022] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.512659] clocksource: Switched to clocksource kvm-clock [ 0.693545] VFS: Disk quotas dquot_6.6.0 [ 0.696432] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.701537] *** VALIDATE ramfs *** [ 0.703128] *** VALIDATE hugetlbfs *** [ 0.706797] pnp: PnP ACPI init [ 0.709168] pnp: PnP ACPI: found 6 devices [ 0.724993] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.728539] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.731277] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.734125] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.737654] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.740140] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.743110] NET: Registered protocol family 2 [ 0.745625] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.750635] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.753510] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.759069] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.762510] TCP: Hash tables configured (established 65536 bind 65536) [ 0.765521] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.768532] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.771385] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.774403] NET: Registered protocol family 1 [ 0.777049] RPC: Registered named UNIX socket transport module. [ 0.779239] RPC: Registered udp transport module. [ 0.780973] RPC: Registered tcp transport module. [ 0.782740] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.785063] NET: Registered protocol family 44 [ 0.786542] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.788641] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.791018] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.793186] PCI: CLS 0 bytes, default 64 [ 0.794758] Unpacking initramfs... [ 2.474235] debug: unmapping init [mem 0xffff8c347cc64000-0xffff8c347ffcffff] [ 2.490359] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.495583] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.503981] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.110425] Initialise system trusted keyrings [ 3.112176] Key type blacklist registered [ 3.113976] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.123520] zbud: loaded [ 3.126754] *** VALIDATE nfs *** [ 3.128153] *** VALIDATE nfs4 *** [ 3.129751] pstore: using deflate compression [ 3.133628] Platform Keyring initialized [ 3.239913] NET: Registered protocol family 38 [ 3.241732] Key type asymmetric registered [ 3.243309] Asymmetric key parser 'x509' registered [ 3.245492] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.248822] io scheduler mq-deadline registered [ 3.250726] io scheduler kyber registered [ 3.252405] io scheduler bfq registered [ 3.255498] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.258759] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.261907] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.265239] ACPI: Power Button [PWRF] [ 3.272666] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.280287] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.303746] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.337731] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.372538] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.377670] Non-volatile memory driver v1.3 [ 3.379600] Linux agpgart interface v0.103 [ 3.414572] virtio_blk virtio1: [vda] 149768 512-byte logical blocks (76.7 MB/73.1 MiB) [ 3.419367] vda: detected capacity change from 0 to 76681216 [ 3.440529] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.526753] vdb: detected capacity change from 0 to 1073741824 [ 3.536322] libphy: Fixed MDIO Bus: probed [ 3.540986] usbcore: registered new interface driver usbserial_generic [ 3.543209] usbserial: USB Serial support registered for generic [ 3.545446] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.549997] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.551819] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.554331] mousedev: PS/2 mouse device common for all mice [ 3.557326] rtc_cmos 00:05: RTC can wake from S4 [ 3.560124] rtc_cmos 00:05: registered as rtc0 [ 3.561828] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.564701] intel_pstate: CPU model not supported [ 3.568027] hid: raw HID events driver (C) Jiri Kosina [ 3.570413] usbcore: registered new interface driver usbhid [ 3.574363] usbhid: USB HID core driver [ 3.576133] drop_monitor: Initializing network drop monitor service [ 3.577438] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.582017] Initializing XFRM netlink socket [ 3.582400] NET: Registered protocol family 10 [ 3.586707] Segment Routing with IPv6 [ 3.589341] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.592262] NET: Registered protocol family 17 [ 3.597063] mpls_gso: MPLS GSO support [ 3.599578] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.609767] RAS: Correctable Errors collector initialized. [ 3.612134] AVX version of gcm_enc/dec engaged. [ 3.615979] AES CTR mode by8 optimization enabled [ 3.696698] sched_clock: Marking stable (3696559118, 0)->(4626559683, -930000565) [ 3.700865] registered taskstats version 1 [ 3.702619] Loading compiled-in X.509 certificates [ 3.704717] zswap: loaded using pool lzo/zbud [ 3.732660] Key type big_key registered [ 3.744883] Key type encrypted registered [ 3.746345] ima: No TPM chip found, activating TPM-bypass! [ 3.748403] ima: Allocated hash algorithm: sha1 [ 3.749995] ima: No architecture policies found [ 3.751894] evm: Initialising EVM extended attributes: [ 3.754393] evm: security.selinux [ 3.757185] evm: security.ima [ 3.758230] evm: security.capability [ 3.759262] evm: HMAC attrs: 0x1 [ 3.761455] rtc_cmos 00:05: setting system clock to 2026-09-03 19:16:01 UTC (1788462961) [ 3.768473] debug: unmapping init [mem 0xffffffff86603000-0xffffffff867fffff] [ 3.771398] debug: unmapping init [mem 0xffffffff85382000-0xffffffff85658fff] [ 3.780604] Write protecting the kernel read-only data: 28672k [ 3.789465] debug: unmapping init [mem 0xffffffff83a03000-0xffffffff83bfffff] [ 3.793548] debug: unmapping init [mem 0xffffffff84314000-0xffffffff843fffff] [ 3.831445] 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.841413] systemd[1]: Detected virtualization kvm. [ 3.843863] systemd[1]: Detected architecture x86-64. [ 3.846240] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.874324] systemd[1]: No hostname configured. [ 3.876188] systemd[1]: Set hostname to . [ 3.878078] random: systemd: uninitialized urandom read (16 bytes read) [ 3.880606] systemd[1]: Initializing machine ID from random generator. [ 3.925811] random: ln: uninitialized urandom read (6 bytes read) [ 4.202381] random: systemd: uninitialized urandom read (16 bytes read) [ 4.205733] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 4.292154] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 4.303240] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Reached target Paths. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... [ OK ] Reached target Initrd Root Device. Starting Apply Kernel Variables... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Swap. [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 5.902693] device-mapper: uevent: version 1.0.3 [ 5.905645] 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.[ 6.897292] random: fast init done [ 6.961095] virtio_net virtio0 ens2: renamed from eth0 [ 7.244492] scsi host0: ata_piix [ 7.297446] scsi host1: ata_piix [ 7.299587] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 7.305186] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 12.273754] random: crng init done [ 12.278960] random: 7 urandom warning(s) missed due to ratelimiting [ 13.154477] dracut-initqueue[586]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 15.076364] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Kernel Device Manager. [ 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... [ 20.693753] printk: systemd: 26 output lines suppressed due to ratelimiting [ 21.344897] SELinux: Disabled at runtime. [ 21.631657] 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) [ 21.653373] systemd[1]: Detected virtualization kvm. [ 21.655884] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 24.152179] systemd[1]: initrd-switch-root.service: Succeeded. [ 24.176607] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 24.290222] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 24.316559] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 24.345190] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 24.415711] systemd[1]: Starting Journal Service... Starting Journal Service... [ 24.469357] systemd[1]: proc-sys-fs-binfmt_misc.automount: Refusing to start, unit to trigger not loaded. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. Mounting Huge Pages File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Starting Apply Kernel Variables... Starting Remount Root and Kernel File Systems... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting POSIX Message Queue File System... [ 25.125134] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Stopped target Initrd File Systems. Mounting Kernel Debug File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... Starting Create Static Device Nodes in /dev... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 26.589198] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 28.194935] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 28.234181] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 29.451871] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 29.700275] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (9s / no limit) [** ] A start job is running for Configur…only root support (10s / no limit) [*** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit) [ *** ] A start job is running for Configur…only root support (12s / no limit) [ ***] A start job is running for Configur…only root support (13s / no limit) [ **] A start job is running for Configur…only root support (13s / no limit)[ 37.766671] Key type dns_resolver registered [ *] A start job is running for Configur…only root support (14s / no limit)[ 38.537208] NFS: Registering the id_resolver key type [ 38.545503] Key type id_resolver registered [ 38.548897] Key type id_legacy registered [ **] A start job is running for Configur…only root support (14s / no limit) [ ***] A start job is running for Configur…only root support (15s / no limit) [ 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 ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... [ OK ] Started dnf makecache --timer. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. Starting Hostname Service... [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg323-client login: [ 64.054131] hrtimer: interrupt took 3141789 ns [ 108.344772] libcfs: loading out-of-tree module taints kernel. [ 108.504676] Key type ._llcrypt registered [ 108.506509] Key type .llcrypt registered [ 108.926591] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 108.939855] alg: No test for adler32 (adler32-zlib) [ 110.456425] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 111.293573] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 113.071175] Key type lgssc registered [ 115.728342] Lustre: Echo OBD driver; http://www.lustre.org/ [ 283.426517] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 288.697363] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 303.335729] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing check_logdir /tmp/testlogs/ [ 309.229869] Lustre: lustre-OST0000-osc-ffff8c34d1372800: disconnect after 23s idle [ 309.293799] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing yml_node [ 313.766556] Lustre: DEBUG MARKER: Client: 2.17.58.2 [ 316.183937] Lustre: DEBUG MARKER: MDS: 2.17.58.2 [ 319.000534] Lustre: DEBUG MARKER: OSS: 2.17.58.2 [ 320.882553] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 3 15:21:17 EDT 2026 [ 339.620055] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 341.457540] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 344.522861] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 354.850488] Lustre: Unmounted lustre-client [ 476.026272] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 482.951780] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 507.355572] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 546.541061] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 15:25:02 (1788463502) [ 549.083238] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 550.569913] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 15:25:07 (1788463507) [ 586.913387] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 593.636589] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 615.045035] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 615.678362] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 623.304362] Lustre: Unmounted lustre-client [ 659.022238] Key type lgssc unregistered [ 659.195752] LNet: 15047:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 659.206586] LNetError: 15047:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 659.223287] LNet: Removed LNI 192.168.203.23@tcp [ 659.842618] Key type .llcrypt unregistered [ 659.850840] Key type ._llcrypt unregistered [ 672.942762] Key type ._llcrypt registered [ 672.945645] Key type .llcrypt registered [ 674.413409] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 15:27:10 (1788463630) [ 675.875065] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 675.987018] alg: No test for adler32 (adler32-zlib) [ 677.078406] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 677.314513] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 678.983341] Key type lgssc registered [ 680.217134] Lustre: Echo OBD driver; http://www.lustre.org/ [ 751.388712] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 836.364526] Lustre: Unmounted lustre-client [ 858.665845] Key type lgssc unregistered [ 858.946320] LNet: 18830:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 858.957672] LNetError: 18830:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 858.990128] LNet: Removed LNI 192.168.203.23@tcp [ 859.796969] Key type .llcrypt unregistered [ 859.800144] Key type ._llcrypt unregistered [ 869.658268] Key type ._llcrypt registered [ 869.660481] Key type .llcrypt registered [ 870.838536] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 15:30:27 (1788463827) [ 873.041856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 873.150317] alg: No test for adler32 (adler32-zlib) [ 874.205981] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 874.473588] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 876.199821] Key type lgssc registered [ 877.458581] Lustre: Echo OBD driver; http://www.lustre.org/ [ 925.194674] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 930.424105] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 949.568904] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 951.140732] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 961.280874] Lustre: Unmounted lustre-client [ 987.224174] Key type lgssc unregistered [ 987.562208] LNet: 22428:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 987.574038] LNetError: 22428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 987.593970] LNet: Removed LNI 192.168.203.23@tcp [ 988.233800] Key type .llcrypt unregistered [ 988.235682] Key type ._llcrypt unregistered [ 996.834395] Key type ._llcrypt registered [ 996.837311] Key type .llcrypt registered [ 998.426586] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 15:32:34 (1788463954) [ 1001.131212] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1001.190280] alg: No test for adler32 (adler32-zlib) [ 1002.414185] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 1002.774056] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 1004.538084] Key type lgssc registered [ 1006.481674] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1058.562181] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1064.447266] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1086.342784] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1089.064590] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 1095.322622] Lustre: Unmounted lustre-client [ 1122.149920] Key type lgssc unregistered [ 1122.348190] LNet: 25612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1122.361202] LNetError: 25612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1122.378887] LNet: Removed LNI 192.168.203.23@tcp [ 1123.102684] Key type .llcrypt unregistered [ 1123.105419] Key type ._llcrypt unregistered [ 1138.637651] Key type ._llcrypt registered [ 1138.640808] Key type .llcrypt registered [ 1139.865669] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 15:34:56 (1788464096) [ 1142.155897] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1142.226667] alg: No test for adler32 (adler32-zlib) [ 1143.308645] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 1143.620749] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 1145.303520] Key type lgssc registered [ 1146.639207] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1195.690651] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1201.021947] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1219.498410] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1222.222965] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 1227.246457] Lustre: lustre-MDT0000-mdc-ffff8c34d063a800: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1232.376369] Lustre: lustre-MDT0001-mdc-ffff8c34d063a800: Connection to lustre-MDT0001 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1238.449206] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1242.591149] Lustre: 26568:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788464184/real 1788464184] req@000000007c93302e x1875340533175168/t0(0) o400->MGC192.168.203.123@tcp@192.168.203.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788464200 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1242.649164] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [ 1248.811555] Lustre: Unmounted lustre-client [ 1267.955561] Key type lgssc unregistered [ 1268.151404] LNet: 29263:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1268.168729] LNetError: 29263:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1268.193523] LNet: Removed LNI 192.168.203.23@tcp [ 1269.618351] Key type .llcrypt unregistered [ 1269.626451] Key type ._llcrypt unregistered [ 1286.735933] Key type ._llcrypt registered [ 1286.738449] Key type .llcrypt registered [ 1288.071208] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 15:37:24 (1788464244) [ 1290.340175] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1290.425114] alg: No test for adler32 (adler32-zlib) [ 1291.523808] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 1291.701937] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 1293.343408] Key type lgssc registered [ 1294.466133] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1345.300770] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1350.851469] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1372.943790] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1375.633839] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 1380.842826] Lustre: lustre-OST0000-osc-ffff8c34c80c0000: Connection to lustre-OST0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1387.737520] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1398.091638] Lustre: Unmounted lustre-client [ 1426.005686] Key type lgssc unregistered [ 1426.320489] LNet: 32871:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1426.327108] LNetError: 32871:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1427.369709] LNet: Removed LNI 192.168.203.23@tcp [ 1428.131671] Key type .llcrypt unregistered [ 1428.138023] Key type ._llcrypt unregistered [ 1443.467655] Key type ._llcrypt registered [ 1443.472653] Key type .llcrypt registered [ 1444.517824] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 15:40:01 (1788464401) [ 1446.751863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1446.793589] alg: No test for adler32 (adler32-zlib) [ 1447.943350] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 1448.221715] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 1449.887187] Key type lgssc registered [ 1450.972821] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1507.076651] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1512.459214] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1531.891839] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1533.560322] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 1536.938915] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1540.297828] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1551.596424] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-0315h41m48s [ 1553.410180] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1559.024360] Lustre: lustre-MDT0000-mdc-ffff8c34c3104800: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1563.197924] LustreError: 36658:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8c34c3104800: can't stat MDS #0: rc = -19 [ 1564.535573] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1571.324142] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [ 1571.341065] Lustre: Evicted from MGS (at 192.168.203.123@tcp) after server handle changed from 0xc824733db62da7f6 to 0xc824733db62da931 [ 1571.350432] Lustre: MGC192.168.203.123@tcp: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 1577.449118] LustreError: lustre-MDT0000-mdc-ffff8c34c3104800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1577.473475] Lustre: lustre-MDT0000-mdc-ffff8c34c3104800: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 1578.177151] Lustre: DEBUG MARKER: Wait for df (36658) ... [ 1579.368748] Lustre: DEBUG MARKER: done [ 1580.703754] Lustre: Unmounted lustre-client [ 1624.927594] Key type lgssc unregistered [ 1625.173481] LNet: 37675:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1625.181935] LNetError: 37675:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1625.195431] LNet: Removed LNI 192.168.203.23@tcp [ 1625.710778] Key type .llcrypt unregistered [ 1625.716549] Key type ._llcrypt unregistered [ 1654.368165] Key type ._llcrypt registered [ 1654.371330] Key type .llcrypt registered [ 1655.684274] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 15:43:31 (1788464611) [ 1657.980328] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1658.105697] alg: No test for adler32 (adler32-zlib) [ 1659.334461] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 1659.710330] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 1661.447276] Key type lgssc registered [ 1662.638692] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1709.112653] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1717.406291] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1742.266147] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1745.137288] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 1750.102350] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-0315h45m06s [ 1751.991734] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1759.243170] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1761.293689] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1781.727177] Lustre: 41815:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788464719/real 1788464719] req@00000000f1ac89be x1875341074242304/t0(0) o101->lustre-MDT0000-mdc-ffff8c34c484b800@192.168.203.123@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788464739 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1781.753523] Lustre: lustre-MDT0000-mdc-ffff8c34c484b800: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1781.778449] Lustre: lustre-MDT0000-mdc-ffff8c34c484b800: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 1802.895620] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1805.437203] Lustre: DEBUG MARKER: done [ 1808.961817] Lustre: Unmounted lustre-client [ 1834.406896] Key type lgssc unregistered [ 1834.744398] LNet: 42702:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1834.758759] LNetError: 42702:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1834.787738] LNet: Removed LNI 192.168.203.23@tcp [ 1835.849564] Key type .llcrypt unregistered [ 1835.851168] Key type ._llcrypt unregistered [ 1864.860571] Key type ._llcrypt registered [ 1864.868328] Key type .llcrypt registered [ 1866.525363] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 15:47:02 (1788464822) [ 1867.899468] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1869.527037] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 15:47:05 (1788464825) [ 1873.820324] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1873.853892] alg: No test for adler32 (adler32-zlib) [ 1874.840621] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 1875.056541] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 1876.728081] Key type lgssc registered [ 1878.125773] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1904.271141] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 15:47:40 (1788464860) [ 1939.006304] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1944.091449] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1964.252875] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1966.868590] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 1970.568924] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1973.764861] Lustre: Unmounted lustre-client [ 1983.067657] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2031.323929] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2036.550343] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2037.036390] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 2040.054994] Lustre: Unmounted lustre-client [ 2103.451676] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2109.274265] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2110.487685] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 2115.339326] Lustre: Unmounted lustre-client [ 2138.560619] Lustre: DEBUG MARKER: files compared the same [ 2160.258671] Key type lgssc unregistered [ 2160.549818] LNet: 50316:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2160.559623] LNetError: 50316:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2160.583316] LNet: Removed LNI 192.168.203.23@tcp [ 2161.087338] Key type .llcrypt unregistered [ 2161.089970] Key type ._llcrypt unregistered [ 2177.268705] Key type ._llcrypt registered [ 2177.270785] Key type .llcrypt registered [ 2179.243903] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 15:52:14 (1788465134) [ 2181.605220] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2181.630362] alg: No test for adler32 (adler32-zlib) [ 2182.679645] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 2182.881789] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 2184.535145] Key type lgssc registered [ 2185.939330] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2236.717741] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2242.298750] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2264.025260] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2266.816944] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 2274.649167] Lustre: Unmounted lustre-client [ 2310.738372] Key type lgssc unregistered [ 2311.047759] LNet: 53899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2311.062024] LNetError: 53899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2311.084177] LNet: Removed LNI 192.168.203.23@tcp [ 2311.809786] Key type .llcrypt unregistered [ 2311.815471] Key type ._llcrypt unregistered [ 2328.248185] Key type ._llcrypt registered [ 2328.252388] Key type .llcrypt registered [ 2329.689687] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 15:54:45 (1788465285) [ 2331.928253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2331.983283] alg: No test for adler32 (adler32-zlib) [ 2333.048490] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 2333.233357] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 2334.919192] Key type lgssc registered [ 2335.881972] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2418.125274] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2450.892878] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2456.208491] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2485.070602] Key type lgssc unregistered [ 2485.425453] LNet: 57379:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2485.438605] LNetError: 57379:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2485.458891] LNet: Removed LNI 192.168.203.23@tcp [ 2486.359499] Key type .llcrypt unregistered [ 2486.361226] Key type ._llcrypt unregistered [ 2501.398914] Key type ._llcrypt registered [ 2501.403089] Key type .llcrypt registered [ 2502.681484] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 15:57:38 (1788465458) [ 2507.132684] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2507.199666] alg: No test for adler32 (adler32-zlib) [ 2508.255708] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 2508.393389] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 2510.106305] Key type lgssc registered [ 2511.830485] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2591.908690] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 2599.832755] Lustre: Unmounted lustre-client [ 2646.413858] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 16:00:02 (1788465602) [ 2756.827382] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2777.654254] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 2784.424440] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2784.429907] LustreError: 63862:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8c34d0b5b000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2784.446957] Lustre: 58359:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.123@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2794.796052] Lustre: Unmounted lustre-client [ 2833.947499] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 16:03:10 (1788465790) [ 2846.179435] Key type lgssc unregistered [ 2846.554073] LNet: 65071:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2846.564538] LNetError: 65071:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2846.584428] LNet: Removed LNI 192.168.203.23@tcp [ 2847.394616] Key type .llcrypt unregistered [ 2847.401376] Key type ._llcrypt unregistered [ 2857.187054] Key type ._llcrypt registered [ 2857.190816] Key type .llcrypt registered [ 2857.597277] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2857.609097] alg: No test for adler32 (adler32-zlib) [ 2858.653336] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 2858.905216] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 2860.567279] Key type lgssc registered [ 2861.395206] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2916.854477] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2923.924689] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2948.079781] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2959.377277] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 2962.583645] Lustre: Unmounted lustre-client [ 2989.206556] Key type lgssc unregistered [ 2989.453178] LNet: 68081:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2989.474434] LNetError: 68081:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2989.491382] LNet: Removed LNI 192.168.203.23@tcp [ 2990.317619] Key type .llcrypt unregistered [ 2990.320907] Key type ._llcrypt unregistered [ 3006.343937] Key type ._llcrypt registered [ 3006.351065] Key type .llcrypt registered [ 3006.909807] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3006.982555] alg: No test for adler32 (adler32-zlib) [ 3008.249886] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 3008.578446] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 3010.263176] Key type lgssc registered [ 3011.617360] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3127.704300] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3133.940774] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3153.721472] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3155.330841] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 3163.436397] Lustre: Unmounted lustre-client [ 3188.749858] Key type lgssc unregistered [ 3188.957685] LNet: 71513:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3188.964836] LNetError: 71513:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3188.978894] LNet: Removed LNI 192.168.203.23@tcp [ 3189.553139] Key type .llcrypt unregistered [ 3189.559409] Key type ._llcrypt unregistered [ 3203.664955] Key type ._llcrypt registered [ 3203.666495] Key type .llcrypt registered [ 3204.832148] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 16:09:21 (1788466161) [ 3207.366874] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3207.406550] alg: No test for adler32 (adler32-zlib) [ 3208.553788] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 3208.808635] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 3210.576499] Key type lgssc registered [ 3211.552780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3258.264412] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3262.717163] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3281.881496] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3284.549568] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 3289.726436] Lustre: Unmounted lustre-client [ 3290.192949] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 3293.175274] Lustre: Unmounted lustre-client [ 3328.968231] Key type lgssc unregistered [ 3329.200285] LNet: 75193:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3329.215618] LNetError: 75193:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3329.255472] LNet: Removed LNI 192.168.203.23@tcp [ 3330.075822] Key type .llcrypt unregistered [ 3330.078243] Key type ._llcrypt unregistered [ 3343.250540] Key type ._llcrypt registered [ 3343.256724] Key type .llcrypt registered [ 3343.677529] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3343.699189] alg: No test for adler32 (adler32-zlib) [ 3344.739887] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 3345.044558] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 3346.720297] Key type lgssc registered [ 3347.964290] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3389.643703] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3395.653672] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3415.780329] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3421.759217] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 3426.383187] Lustre: Unmounted lustre-client [ 3462.068791] Key type lgssc unregistered [ 3462.379651] LNet: 78218:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3462.390481] LNetError: 78218:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3462.403468] LNet: Removed LNI 192.168.203.23@tcp [ 3463.159376] Key type .llcrypt unregistered [ 3463.165405] Key type ._llcrypt unregistered [ 3478.033824] Key type ._llcrypt registered [ 3478.036710] Key type .llcrypt registered [ 3479.245425] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 16:13:55 (1788466435) [ 3481.365643] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3481.599026] alg: No test for adler32 (adler32-zlib) [ 3482.661724] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 3482.887693] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 3484.591183] Key type lgssc registered [ 3485.742726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3534.250132] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3539.682588] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3560.853294] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3562.451300] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 3570.444387] Lustre: lustre: root_squash is set to 0:0 [ 3570.490933] Lustre: lustre: nosquash_nids is cleared [ 3579.929615] Lustre: lustre: root_squash is set to 500:500 [ 3587.810541] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.23@tcp 192.168.0.[2,10]@tcp [ 3594.213396] Lustre: lustre: nosquash_nids set to 192.168.203.23/24@tcp [ 3599.334516] Lustre: Unmounted lustre-client [ 3630.056165] Key type lgssc unregistered [ 3630.349328] LNet: 82155:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3630.367713] LNetError: 82155:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3630.396347] LNet: Removed LNI 192.168.203.23@tcp [ 3631.035829] Key type .llcrypt unregistered [ 3631.037953] Key type ._llcrypt unregistered [ 3644.739386] Key type ._llcrypt registered [ 3644.742475] Key type .llcrypt registered [ 3646.006586] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 16:16:42 (1788466602) [ 3648.398414] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3649.999432] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 16:16:46 (1788466606) [ 3652.024569] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3652.136879] alg: No test for adler32 (adler32-zlib) [ 3653.256220] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 3653.583621] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 3655.279322] Key type lgssc registered [ 3656.510540] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3706.539368] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3712.550405] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3731.879424] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3732.623752] Lustre: lustre: root_squash is set to 500:500 [ 3732.661701] Lustre: lustre: nosquash_nids set to 192.168.203.23/24@tcp [ 3733.780738] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 3743.568474] Lustre: Unmounted lustre-client [ 3769.630971] Key type lgssc unregistered [ 3769.890103] LNet: 86105:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3769.900178] LNetError: 86105:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3770.920807] LNet: Removed LNI 192.168.203.23@tcp [ 3771.552565] Key type .llcrypt unregistered [ 3771.555310] Key type ._llcrypt unregistered [ 3784.979195] Key type ._llcrypt registered [ 3784.983233] Key type .llcrypt registered [ 3786.292517] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3787.710142] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 16:19:04 (1788466744) [ 3803.466059] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3803.541306] alg: No test for adler32 (adler32-zlib) [ 3804.613504] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 3804.938405] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 3806.655177] Key type lgssc registered [ 3807.753514] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3881.182133] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3885.822567] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3904.569519] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3972.827617] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3977.497861] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3997.451485] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4008.157327] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 4038.712676] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8c34d0b58000.ost_server_uuid 50 [ 4039.974842] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8c34d0b58000.ost_server_uuid in IDLE state after 0 sec [ 4040.451145] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 4043.658802] Lustre: Unmounted lustre-client [ 4045.313328] Lustre: Unmounted lustre-client [ 4092.941951] Key type lgssc unregistered [ 4093.154054] LNet: 93760:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4093.163155] LNetError: 93760:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4093.199674] LNet: Removed LNI 192.168.203.23@tcp [ 4093.907224] Key type .llcrypt unregistered [ 4093.912343] Key type ._llcrypt unregistered [ 4119.671198] Key type ._llcrypt registered [ 4119.673157] Key type .llcrypt registered [ 4121.051475] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 16:24:37 (1788467077) [ 4137.930709] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4138.093875] alg: No test for adler32 (adler32-zlib) [ 4139.088598] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 4139.224489] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 4140.872175] Key type lgssc registered [ 4142.119597] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4202.214183] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4206.677428] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4224.165705] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4226.690153] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 4247.519818] Lustre: 95120:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788467189/real 1788467189] req@00000000ad328e4b x1875343673660672/t0(0) o400->lustre-OST0000-osc-ffff8c34c8fbb800@192.168.203.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788467205 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4247.537973] Lustre: lustre-OST0000-osc-ffff8c34c8fbb800: Connection to lustre-OST0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4249.484221] Lustre: lustre-OST0000-osc-ffff8c34c8fbb800: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 4252.650072] Lustre: lustre-MDT0000-mdc-ffff8c34c8fbb800: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4253.663148] Lustre: 95120:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788467195/real 1788467195] req@000000005e2eb7ed x1875343673661184/t0(0) o400->lustre-OST0000-osc-ffff8c34c8fbb800@192.168.203.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788467211 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4258.785053] Lustre: 95121:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788467200/real 1788467200] req@000000003c7ea228 x1875343673661696/t0(0) o400->lustre-OST0000-osc-ffff8c34c8fbb800@192.168.203.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788467216 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4271.080954] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [ 4271.100270] Lustre: Evicted from MGS (at 192.168.203.123@tcp) after server handle changed from 0x7d2c9b13fee71c8a to 0x7d2c9b13fee71f1c [ 4271.116435] Lustre: MGC192.168.203.123@tcp: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 4274.833361] Lustre: lustre-MDT0000-mdc-ffff8c34c8fbb800: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 4277.133376] Lustre: Unmounted lustre-client [ 4300.261759] Key type lgssc unregistered [ 4300.517245] LNet: 99411:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4300.525905] LNetError: 99411:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4300.541093] LNet: Removed LNI 192.168.203.23@tcp [ 4301.113369] Key type .llcrypt unregistered [ 4301.115620] Key type ._llcrypt unregistered [ 4316.061640] Key type ._llcrypt registered [ 4316.070333] Key type .llcrypt registered [ 4317.438608] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 16:27:53 (1788467273) [ 4331.927824] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4332.022985] alg: No test for adler32 (adler32-zlib) [ 4333.076031] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 4333.335309] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 4335.040053] Key type lgssc registered [ 4336.021555] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4369.067207] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4448.784985] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4453.846952] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4473.480400] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4475.986628] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 4477.603252] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4478.933390] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 16:30:35 (1788467435) [ 4670.796204] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4681.125778] Lustre: Unmounted lustre-client [ 4796.352479] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4802.644585] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4825.454200] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4864.274173] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 16:37:00 (1788467820) [ 4968.325600] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4973.781760] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4996.579122] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4997.377473] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 5002.086794] Lustre: Unmounted lustre-client [ 5033.784587] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 16:39:50 (1788467990) [ 5138.304727] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5144.014886] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5164.431721] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5165.015267] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 5170.375671] Lustre: Unmounted lustre-client [ 5199.863151] Key type lgssc unregistered [ 5200.253076] LNet: 122410:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5200.260695] LNetError: 122410:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5200.286236] LNet: Removed LNI 192.168.203.23@tcp [ 5201.275519] Key type .llcrypt unregistered [ 5201.277049] Key type ._llcrypt unregistered [ 5217.399406] Key type ._llcrypt registered [ 5217.401538] Key type .llcrypt registered [ 5218.692576] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 16:42:54 (1788468174) [ 5221.040592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5221.128409] alg: No test for adler32 (adler32-zlib) [ 5222.259417] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 5222.609332] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 5224.312116] Key type lgssc registered [ 5225.645413] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5277.547910] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5283.170278] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5306.300374] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5308.828814] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 5325.492506] Lustre: Unmounted lustre-client [ 5355.425442] Key type lgssc unregistered [ 5355.794184] LNet: 126000:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5355.811098] LNetError: 126000:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5355.836153] LNet: Removed LNI 192.168.203.23@tcp [ 5356.586065] Key type .llcrypt unregistered [ 5356.589416] Key type ._llcrypt unregistered [ 5374.576982] Key type ._llcrypt registered [ 5374.584181] Key type .llcrypt registered [ 5375.944871] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 16:45:32 (1788468332) [ 5378.089617] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5378.123930] alg: No test for adler32 (adler32-zlib) [ 5379.386336] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 5379.539115] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 5381.183373] Key type lgssc registered [ 5382.778509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5439.354623] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5444.870321] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5466.152207] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5467.637311] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 5472.747449] Lustre: lustre-OST0000-osc-ffff8c34d02b6000: Connection to lustre-OST0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5485.215304] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8c34d02b6000.ost_server_uuid 50 [ 5486.619207] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5497.522143] Lustre: Unmounted lustre-client [ 5520.951786] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 16:47:56 (1788468476) [ 5557.159589] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5564.503179] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5585.853639] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5608.273638] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5609.216383] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 5614.572542] Lustre: lustre-OST0000-osc-ffff8c34c3345000: Connection to lustre-OST0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5640.894292] Lustre: Unmounted lustre-client [ 5687.651442] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 16:50:43 (1788468643) [ 5720.631942] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5727.068033] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5751.015077] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5769.708245] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5770.259850] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 5775.343969] Lustre: lustre-OST0000-osc-ffff8c34d8ca5000: Connection to lustre-OST0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5791.214406] Lustre: Unmounted lustre-client [ 5836.342542] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 16:53:13 (1788468793) [ 5920.210874] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5927.276894] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5951.116660] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6026.774400] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6033.956348] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6056.617099] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6089.111870] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 6133.465561] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6136.996521] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 6139.804556] Lustre: Unmounted lustre-client [ 6171.652724] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 16:58:47 (1788469127) [ 6201.866149] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6207.990892] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6230.245834] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6265.105876] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6303.627216] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 6347.650593] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6349.988599] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6362.404743] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6372.746284] Lustre: Unmounted lustre-client [ 6426.466377] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 17:03:02 (1788469382) [ 6461.528282] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6468.479784] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6489.461427] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6490.564420] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 6522.110880] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6524.291126] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6539.290828] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8c34d861a800.ost_server_uuid 50 [ 6541.040754] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8c34d861a800.ost_server_uuid in IDLE state after 0 sec [ 6543.955155] Lustre: Unmounted lustre-client [ 6544.410412] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6544.426545] Lustre: Skipped 3 previous similar messages [ 6544.538771] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 6545.719560] LustreError: 149424:0:(sec.c:403:import_sec_validate_get()) import 00000000e63bdb95 (NEW) with no sec [ 6602.601685] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 17:05:59 (1788469559) [ 6636.825221] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6641.794563] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6663.000621] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6684.514656] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6685.016799] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6685.166646] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 6698.390550] Lustre: Unmounted lustre-client [ 6698.398646] Lustre: Skipped 1 previous similar message [ 6747.489401] Key type lgssc unregistered [ 6747.716393] LNet: 152834:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6747.735755] LNetError: 152834:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6747.766272] LNet: Removed LNI 192.168.203.23@tcp [ 6748.779528] Key type .llcrypt unregistered [ 6748.782208] Key type ._llcrypt unregistered [ 6768.327459] Key type ._llcrypt registered [ 6768.329315] Key type .llcrypt registered [ 6769.836429] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 17:08:45 (1788469725) [ 6771.486765] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6771.525416] alg: No test for adler32 (adler32-zlib) [ 6772.970576] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 6773.485902] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 6775.264271] Key type lgssc registered [ 6777.390516] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6833.275446] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6838.997232] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6861.390655] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6881.825797] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6883.491049] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6884.621334] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 6888.558391] LustreError: lustre-MDT0001-mdc-ffff8c34c3347000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6888.596627] Lustre: lustre-MDT0001-mdc-ffff8c34c3347000: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 6895.230432] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6897.015317] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6921.218669] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6927.898326] Lustre: Unmounted lustre-client [ 6967.433594] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 17:12:03 (1788469923) [ 7079.338225] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7084.931696] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7109.506221] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7110.175204] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 7135.556480] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7137.336214] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7150.473954] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7160.819139] Lustre: Unmounted lustre-client [ 7195.228880] Key type lgssc unregistered [ 7195.434925] LNet: 162440:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7195.439721] LNetError: 162440:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7195.452681] LNet: Removed LNI 192.168.203.23@tcp [ 7195.962213] Key type .llcrypt unregistered [ 7195.974484] Key type ._llcrypt unregistered [ 7228.353691] Key type ._llcrypt registered [ 7228.355984] Key type .llcrypt registered [ 7229.885319] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 17:16:25 (1788470185) [ 7232.521821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7232.564857] alg: No test for adler32 (adler32-zlib) [ 7233.644989] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 7233.932722] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 7235.615324] Key type lgssc registered [ 7236.651276] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7291.706144] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7298.394900] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7318.856532] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7321.537344] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 7367.976083] Lustre: Unmounted lustre-client [ 7429.252053] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7429.905799] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 7467.410414] Lustre: Unmounted lustre-client [ 7497.103463] Key type lgssc unregistered [ 7497.488821] LNet: 166882:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7497.507165] LNetError: 166882:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7497.544802] LNet: Removed LNI 192.168.203.23@tcp [ 7498.709101] Key type .llcrypt unregistered [ 7498.714772] Key type ._llcrypt unregistered [ 7516.918217] Key type ._llcrypt registered [ 7516.925204] Key type .llcrypt registered [ 7518.403478] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 17:21:14 (1788470474) [ 7521.012152] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7521.076796] alg: No test for adler32 (adler32-zlib) [ 7522.352555] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 7522.606205] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 7524.367224] Key type lgssc registered [ 7525.436533] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7575.979171] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7581.627899] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7601.175297] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7603.790704] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 7622.405765] Lustre: Unmounted lustre-client [ 7649.340685] Key type lgssc unregistered [ 7649.691545] LNet: 170629:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7649.704486] LNetError: 170629:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7649.724022] LNet: Removed LNI 192.168.203.23@tcp [ 7650.453087] Key type .llcrypt unregistered [ 7650.456097] Key type ._llcrypt unregistered [ 7662.205798] Key type ._llcrypt registered [ 7662.208836] Key type .llcrypt registered [ 7662.595395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7662.611436] alg: No test for adler32 (adler32-zlib) [ 7663.686834] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 7663.943888] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 7665.639170] Key type lgssc registered [ 7667.240196] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7724.838518] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7731.201937] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7754.126915] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7756.817746] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 7764.558145] Lustre: Unmounted lustre-client [ 7793.316233] Key type lgssc unregistered [ 7793.595399] LNet: 173687:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7793.611712] LNetError: 173687:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7793.635612] LNet: Removed LNI 192.168.203.23@tcp [ 7794.342082] Key type .llcrypt unregistered [ 7794.344989] Key type ._llcrypt unregistered [ 7810.853606] Key type ._llcrypt registered [ 7810.855967] Key type .llcrypt registered [ 7812.394715] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 17:26:08 (1788470768) [ 7814.824890] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7814.941818] alg: No test for adler32 (adler32-zlib) [ 7816.308979] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 7816.683160] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 7818.415275] Key type lgssc registered [ 7819.900444] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7871.878636] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7877.434795] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7900.108592] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7901.950103] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 7923.180445] Lustre: Unmounted lustre-client [ 7949.244709] Key type lgssc unregistered [ 7949.555239] LNet: 177437:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7949.564595] LNetError: 177437:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7949.584461] LNet: Removed LNI 192.168.203.23@tcp [ 7950.360771] Key type .llcrypt unregistered [ 7950.366278] Key type ._llcrypt unregistered [ 7961.479438] Key type ._llcrypt registered [ 7961.484985] Key type .llcrypt registered [ 7961.835372] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7961.847993] alg: No test for adler32 (adler32-zlib) [ 7963.071581] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 7963.291779] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 7964.991239] Key type lgssc registered [ 7966.203076] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8016.795224] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8022.293984] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8042.882220] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8044.613886] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 8051.833627] Lustre: Unmounted lustre-client [ 8078.341977] Key type lgssc unregistered [ 8078.686368] LNet: 180492:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8078.697863] LNetError: 180492:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8078.722381] LNet: Removed LNI 192.168.203.23@tcp [ 8079.492163] Key type .llcrypt unregistered [ 8079.504109] Key type ._llcrypt unregistered [ 8096.469939] Key type ._llcrypt registered [ 8096.472470] Key type .llcrypt registered [ 8098.008078] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 17:30:54 (1788471054) [ 8123.635534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8123.711562] alg: No test for adler32 (adler32-zlib) [ 8124.818333] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 8125.133808] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 8126.841046] Key type lgssc registered [ 8128.005369] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8207.566345] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8213.371482] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8236.730916] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8290.786272] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 17:34:06 (1788471246) [ 8326.715730] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8332.577928] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8353.180822] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8355.886938] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 8365.193518] Lustre: Unmounted lustre-client [ 8400.791481] Key type lgssc unregistered [ 8401.112299] LNet: 187588:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8401.132529] LNetError: 187588:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8401.165494] LNet: Removed LNI 192.168.203.23@tcp [ 8402.135096] Key type .llcrypt unregistered [ 8402.140285] Key type ._llcrypt unregistered [ 8422.388273] Key type ._llcrypt registered [ 8422.391628] Key type .llcrypt registered [ 8424.007774] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8426.551743] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 17:36:22 (1788471382) [ 8449.036291] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8449.059852] alg: No test for adler32 (adler32-zlib) [ 8450.276594] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 8450.616379] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 8452.375426] Key type lgssc registered [ 8453.989412] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8550.487207] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8556.204589] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8577.605460] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8594.012646] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8596.553996] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 8616.782829] Lustre: Unmounted lustre-client [ 8732.836932] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8738.330320] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8761.613820] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8810.593432] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 17:42:46 (1788471766) [ 8812.293416] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8813.824629] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 17:42:50 (1788471770) [ 8901.564970] Key type lgssc unregistered [ 8901.756775] LNet: 199020:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8901.764404] LNetError: 199020:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8901.775449] LNet: Removed LNI 192.168.203.23@tcp [ 8902.422810] Key type .llcrypt unregistered [ 8902.425588] Key type ._llcrypt unregistered [ 8920.133364] Key type ._llcrypt registered [ 8920.138063] Key type .llcrypt registered [ 8921.481151] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 17:44:37 (1788471877) [ 8964.468387] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8964.515787] alg: No test for adler32 (adler32-zlib) [ 8965.771519] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 8966.050596] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 8967.783739] Key type lgssc registered [ 8968.776537] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9008.102608] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9012.605189] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9042.457937] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9072.254424] Key type lgssc unregistered [ 9072.497766] LNet: 202750:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9072.506635] LNetError: 202750:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9072.544519] LNet: Removed LNI 192.168.203.23@tcp [ 9073.145869] Key type .llcrypt unregistered [ 9073.153400] Key type ._llcrypt unregistered [ 9087.028897] Key type ._llcrypt registered [ 9087.032432] Key type .llcrypt registered [ 9088.058033] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 17:47:24 (1788472044) [ 9090.097332] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9090.173084] alg: No test for adler32 (adler32-zlib) [ 9091.151657] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 9091.365390] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 9093.023241] Key type lgssc registered [ 9094.074337] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9135.400330] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9140.143722] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9159.916557] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9162.545207] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 9167.851791] Lustre: lustre-MDT0000-mdc-ffff8c34d056b800: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9178.092178] Lustre: lustre-MDT0001-mdc-ffff8c34d056b800: Connection to lustre-MDT0001 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9193.439179] Lustre: 203737:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788472135/real 1788472135] req@00000000b0d08004 x1875348867334272/t0(0) o400->MGC192.168.203.123@tcp@192.168.203.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788472151 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9193.475819] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [ 9203.753436] Lustre: Evicted from MGS (at 192.168.203.123@tcp) after server handle changed from 0x2974b1ed5403e64 to 0x2974b1ed5405d5f [ 9203.766214] Lustre: MGC192.168.203.123@tcp: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 9220.075408] LustreError: lustre-MDT0000-mdc-ffff8c34d056b800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9220.131633] Lustre: lustre-MDT0000-mdc-ffff8c34d056b800: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 9223.796962] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9225.025619] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9229.747185] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9230.999828] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9233.563085] Lustre: Unmounted lustre-client [ 9256.961290] Key type lgssc unregistered [ 9257.202996] LNet: 207686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9257.212273] LNetError: 207686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9257.232197] LNet: Removed LNI 192.168.203.23@tcp [ 9257.860628] Key type .llcrypt unregistered [ 9257.862696] Key type ._llcrypt unregistered [ 9268.822629] Key type ._llcrypt registered [ 9268.828674] Key type .llcrypt registered [ 9269.995465] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 17:50:26 (1788472226) [ 9271.542643] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9271.564660] alg: No test for adler32 (adler32-zlib) [ 9272.583428] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 9272.835864] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 9274.463232] Key type lgssc registered [ 9275.414338] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9316.891276] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9321.528258] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9370.957737] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9375.512993] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9407.944248] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9427.154827] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9461.079237] Key type lgssc unregistered [ 9461.270298] LNet: 212970:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9461.275442] LNetError: 212970:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9461.289982] LNet: Removed LNI 192.168.203.23@tcp [ 9461.814660] Key type .llcrypt unregistered [ 9461.818942] Key type ._llcrypt unregistered [ 9499.372863] Key type ._llcrypt registered [ 9499.375544] Key type .llcrypt registered [ 9500.577391] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 17:54:16 (1788472456) [ 9531.993906] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9532.003947] alg: No test for adler32 (adler32-zlib) [ 9533.110259] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 9533.317804] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 9534.951892] Key type lgssc registered [ 9536.290747] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9616.874077] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9621.478437] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9639.769669] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9674.763945] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 17:57:11 (1788472631) [ 9681.169815] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 17:57:17 (1788472637) [ 9709.562599] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9713.960592] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9729.115524] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9735.705443] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 9740.579497] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9742.596867] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9743.946049] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9745.215327] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9751.022525] Lustre: lustre-MDT0000-mdc-ffff8c34c817c000: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9766.367181] Lustre: 214862:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788472708/real 1788472708] req@00000000aa91398e x1875349330733056/t0(0) o400->MGC192.168.203.123@tcp@192.168.203.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788472724 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9766.397615] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [ 9766.419589] Lustre: Evicted from MGS (at 192.168.203.123@tcp) after server handle changed from 0xbe47d03a8defdfcb to 0xbe47d03a8defe241 [ 9766.438505] Lustre: MGC192.168.203.123@tcp: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 9770.123298] Lustre: lustre-MDT0000-mdc-ffff8c34c817c000: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 9776.631507] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9777.984884] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9781.311358] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9786.864921] Lustre: lustre-MDT0000-mdc-ffff8c34c817c000: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9803.039156] Lustre: 214861:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788472744/real 1788472744] req@00000000b620f932 x1875349330740480/t0(0) o400->MGC192.168.203.123@tcp@192.168.203.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788472760 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9803.066649] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [ 9803.112709] Lustre: Evicted from MGS (at 192.168.203.123@tcp) after server handle changed from 0xbe47d03a8defe241 to 0xbe47d03a8defe455 [ 9803.121424] Lustre: MGC192.168.203.123@tcp: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 9816.760586] Lustre: lustre-MDT0000-mdc-ffff8c34c817c000: Connection restored to 192.168.203.123@tcp (at 192.168.203.123@tcp) [ 9823.392104] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9824.495236] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9827.806098] Lustre: Unmounted lustre-client [ 9889.281110] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9894.278035] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9912.939342] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9913.414504] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [ 9915.545830] Lustre: Unmounted lustre-client [ 9936.986897] Key type lgssc unregistered [ 9937.228909] LNet: 225438:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9937.235367] LNetError: 225438:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9937.252377] LNet: Removed LNI 192.168.203.23@tcp [ 9937.962628] Key type .llcrypt unregistered [ 9937.966568] Key type ._llcrypt unregistered [ 9950.926198] Key type ._llcrypt registered [ 9950.928585] Key type .llcrypt registered [ 9951.917250] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 18:01:48 (1788472908) [ 9955.064393] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9955.128064] alg: No test for adler32 (adler32-zlib) [ 9956.173104] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [ 9956.384272] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [ 9958.047955] Key type lgssc registered [ 9959.193929] Lustre: Echo OBD driver; http://www.lustre.org/ [10005.725890] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10011.437833] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10032.875627] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10035.414819] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [10044.252545] Lustre: Unmounted lustre-client [10097.369435] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10101.586857] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10121.147312] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10126.917713] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [10135.433014] Lustre: Unmounted lustre-client [10199.024723] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10204.062153] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10224.257562] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10224.801215] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [10226.487158] Lustre: Unmounted lustre-client [10251.703302] Key type lgssc unregistered [10251.933451] LNet: 232469:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10251.940633] LNetError: 232469:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10251.963237] LNet: Removed LNI 192.168.203.23@tcp [10252.574179] Key type .llcrypt unregistered [10252.576931] Key type ._llcrypt unregistered [10267.114404] Key type ._llcrypt registered [10267.117435] Key type .llcrypt registered [10268.280763] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 18:07:04 (1788473224) [10271.375260] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10271.395894] alg: No test for adler32 (adler32-zlib) [10272.413457] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [10272.633268] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [10274.279545] Key type lgssc registered [10275.389910] Lustre: Echo OBD driver; http://www.lustre.org/ [10318.634326] Key type lgssc unregistered [10319.015445] LNet: 234786:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10319.018785] LNetError: 234786:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10319.040137] LNet: Removed LNI 192.168.203.23@tcp [10320.157734] Key type .llcrypt unregistered [10320.160300] Key type ._llcrypt unregistered [10344.643691] Key type ._llcrypt registered [10344.655948] Key type .llcrypt registered [10345.020851] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10345.032857] alg: No test for adler32 (adler32-zlib) [10346.078636] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [10346.319566] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [10347.967239] Key type lgssc registered [10348.792388] Lustre: Echo OBD driver; http://www.lustre.org/ [10427.246470] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10433.084420] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10455.972275] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10505.990506] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10507.956878] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 18:11:03 (1788473463) [10540.364252] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10546.579897] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10567.510707] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10587.577847] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10589.114370] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [10594.288227] Lustre: lustre-OST0001-osc-ffff8c34d8ca5000: Connection to lustre-OST0001 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [10600.726941] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10611.034624] Lustre: Unmounted lustre-client [10643.455439] Key type lgssc unregistered [10643.649643] LNet: 241893:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10643.654496] LNetError: 241893:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10643.662981] LNet: Removed LNI 192.168.203.23@tcp [10644.350410] Key type .llcrypt unregistered [10644.356217] Key type ._llcrypt unregistered [10674.422558] Key type ._llcrypt registered [10674.426494] Key type .llcrypt registered [10675.601839] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 18:13:51 (1788473631) [10688.113169] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10688.141368] alg: No test for adler32 (adler32-zlib) [10689.207985] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [10689.461358] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [10691.143542] Key type lgssc registered [10692.236302] Lustre: Echo OBD driver; http://www.lustre.org/ [10736.710634] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10742.576101] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10767.457892] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 18:15:23 (1788473723) [10799.113257] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10806.710405] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10828.776515] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10830.474189] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [10837.957067] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10848.625303] Lustre: Unmounted lustre-client [10944.882207] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10949.854693] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10999.007656] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10999.790782] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [11002.428836] Lustre: Unmounted lustre-client [11023.372745] Key type lgssc unregistered [11023.599087] LNet: 249581:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11023.605399] LNetError: 249581:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11023.621223] LNet: Removed LNI 192.168.203.23@tcp [11024.167650] Key type .llcrypt unregistered [11024.171858] Key type ._llcrypt unregistered [11052.271102] Key type ._llcrypt registered [11052.272873] Key type .llcrypt registered [11052.569619] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11052.582696] alg: No test for adler32 (adler32-zlib) [11053.573083] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [11053.744772] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [11055.359316] Key type lgssc registered [11056.489531] Lustre: Echo OBD driver; http://www.lustre.org/ [11131.060859] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11135.789892] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11161.866299] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11209.373414] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11210.667725] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 18:22:47 (1788474167) [11242.838338] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11247.180983] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11266.903174] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11271.099161] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [11274.142175] Lustre: Unmounted lustre-client [11300.342548] Key type lgssc unregistered [11300.672513] LNet: 256209:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11300.694546] LNetError: 256209:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11300.714745] LNet: Removed LNI 192.168.203.23@tcp [11301.404626] Key type .llcrypt unregistered [11301.408519] Key type ._llcrypt unregistered [11317.173894] Key type ._llcrypt registered [11317.176666] Key type .llcrypt registered [11318.466544] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11319.977683] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 18:24:36 (1788474276) [11329.472442] Key type .llcrypt unregistered [11329.474723] Key type ._llcrypt unregistered [11341.303271] Key type ._llcrypt registered [11341.307724] Key type .llcrypt registered [11342.374578] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11342.398100] alg: No test for adler32 (adler32-zlib) [11343.588710] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [11344.002139] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [11345.863177] Key type lgssc registered [11347.233405] Lustre: Echo OBD driver; http://www.lustre.org/ [11399.304895] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11411.917832] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [11414.199111] Lustre: Unmounted lustre-client [11448.952212] Key type lgssc unregistered [11449.204733] LNet: 259666:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11449.213846] LNetError: 259666:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11449.234093] LNet: Removed LNI 192.168.203.23@tcp [11449.859740] Key type .llcrypt unregistered [11449.861957] Key type ._llcrypt unregistered [11469.399346] Key type ._llcrypt registered [11469.403616] Key type .llcrypt registered [11471.257353] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 18:27:06 (1788474426) [11474.486989] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11474.506874] alg: No test for adler32 (adler32-zlib) [11475.610598] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [11475.862755] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [11477.608053] Key type lgssc registered [11479.513257] Lustre: Echo OBD driver; http://www.lustre.org/ [11559.659156] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11586.510734] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11590.782993] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11592.224032] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [11594.884941] Lustre: Unmounted lustre-client [11621.976848] Key type lgssc unregistered [11622.260751] LNet: 263207:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11622.280305] LNetError: 263207:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11622.301632] LNet: Removed LNI 192.168.203.23@tcp [11622.984591] Key type .llcrypt unregistered [11622.990173] Key type ._llcrypt unregistered [11638.374404] Key type ._llcrypt registered [11638.376944] Key type .llcrypt registered [11639.761512] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 18:29:55 (1788474595) [11641.958975] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11642.100080] alg: No test for adler32 (adler32-zlib) [11643.128460] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [11643.437889] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [11645.160091] Key type lgssc registered [11646.409453] Lustre: Echo OBD driver; http://www.lustre.org/ [11697.784997] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11702.768379] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11719.312855] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11721.870181] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [11727.343185] Lustre: lustre-MDT0000-mdc-ffff8c34c49aa800: Connection to lustre-MDT0000 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [11731.616086] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11731.652868] LustreError: 266355:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11732.097824] LustreError: MGC192.168.203.123@tcp: Connection to MGS (at 192.168.203.123@tcp) was lost; in progress operations using this service will fail [11732.156121] Lustre: Unmounted lustre-client [11752.190882] Key type lgssc unregistered [11752.528807] LNet: 266767:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11752.538269] LNetError: 266767:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11752.579186] LNet: Removed LNI 192.168.203.23@tcp [11753.218226] Key type .llcrypt unregistered [11753.221400] Key type ._llcrypt unregistered [11767.548651] Key type ._llcrypt registered [11767.552504] Key type .llcrypt registered [11768.668590] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 18:32:05 (1788474725) [11770.826935] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11770.837684] alg: No test for adler32 (adler32-zlib) [11771.933906] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [11772.127373] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [11773.775368] Key type lgssc registered [11774.921830] Lustre: Echo OBD driver; http://www.lustre.org/ [11818.051923] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11822.730846] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11841.139324] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11843.817494] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [11849.195218] Lustre: lustre-MDT0001-mdc-ffff8c34c49ac000: Connection to lustre-MDT0001 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [11853.492826] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [11855.290588] Lustre: Unmounted lustre-client [11871.954282] Key type lgssc unregistered [11872.197925] LNet: 270343:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11872.204871] LNetError: 270343:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11872.222746] LNet: Removed LNI 192.168.203.23@tcp [11872.716225] Key type .llcrypt unregistered [11872.720405] Key type ._llcrypt unregistered [11884.235233] Key type ._llcrypt registered [11884.241826] Key type .llcrypt registered [11885.308710] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 18:34:01 (1788474841) [11902.057313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11902.081358] alg: No test for adler32 (adler32-zlib) [11903.212574] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [11903.478732] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [11905.183659] Key type lgssc registered [11906.489125] Lustre: Echo OBD driver; http://www.lustre.org/ [12008.083884] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12010.648349] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [12042.230089] Lustre: lustre-MDT0001-mdc-ffff8c34c8206000: Connection to lustre-MDT0001 (at 192.168.203.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [12051.803567] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12062.116209] Lustre: Unmounted lustre-client [12093.128793] Key type lgssc unregistered [12093.384226] LNet: 276117:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12093.394637] LNetError: 276117:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12093.413237] LNet: Removed LNI 192.168.203.23@tcp [12094.064514] Key type .llcrypt unregistered [12094.077707] Key type ._llcrypt unregistered [12108.494341] Key type ._llcrypt registered [12108.499506] Key type .llcrypt registered [12109.757948] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 18:37:46 (1788475066) [12111.276359] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12112.857605] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 18:37:49 (1788475069) [12114.414782] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12115.912187] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 18:37:52 (1788475072) [12117.246454] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12118.749382] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 18:37:55 (1788475075) [12120.595722] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12122.216652] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 18:37:58 (1788475078) [12123.753359] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12125.286954] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 18:38:01 (1788475081) [12133.614404] Key type .llcrypt unregistered [12133.617787] Key type ._llcrypt unregistered [12141.833579] Key type ._llcrypt registered [12141.835231] Key type .llcrypt registered [12142.637677] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12142.655086] alg: No test for adler32 (adler32-zlib) [12143.948417] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [12144.323154] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [12146.023215] Key type lgssc registered [12147.938106] Lustre: Echo OBD driver; http://www.lustre.org/ [12227.092267] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12232.629843] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12255.541871] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12257.027384] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [12260.348518] Lustre: Unmounted lustre-client [12295.052518] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 18:40:51 (1788475251) [12324.709822] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12330.304176] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12365.905451] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12377.123831] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [12378.809625] Lustre: Unmounted lustre-client [12421.934753] LNet: 1 local NIs in recovery (showing 1): 192.168.203.23@tcp [12423.665754] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 18:42:59 (1788475379) [13065.884712] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13071.950325] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13107.571465] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13189.092438] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 18:55:45 (1788476145) [13199.212189] Key type lgssc unregistered [13199.494798] LNet: 289633:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13199.510866] LNetError: 289633:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13199.525428] LNet: Removed LNI 192.168.203.23@tcp [13200.184404] Key type .llcrypt unregistered [13200.187472] Key type ._llcrypt unregistered [13306.810507] Key type ._llcrypt registered [13306.812495] Key type .llcrypt registered [13307.515723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13307.530153] alg: No test for adler32 (adler32-zlib) [13308.740982] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [13309.044838] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [13310.735241] Key type lgssc registered [13312.211652] Lustre: Echo OBD driver; http://www.lustre.org/ [13401.458339] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13407.116461] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13430.526696] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13470.660801] Key type lgssc unregistered [13470.934718] LNet: 293336:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13470.944644] LNetError: 293336:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13470.964790] LNet: Removed LNI 192.168.203.23@tcp [13471.632373] Key type .llcrypt unregistered [13471.638711] Key type ._llcrypt unregistered [13507.286833] Key type ._llcrypt registered [13507.292499] Key type .llcrypt registered [13509.318761] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 19:01:04 (1788476464) [13532.660291] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13532.692376] alg: No test for adler32 (adler32-zlib) [13533.690962] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [13534.002251] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [13535.751241] Key type lgssc registered [13537.064755] Lustre: Echo OBD driver; http://www.lustre.org/ [13590.756506] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 19:02:26 (1788476546) [13603.654923] Key type lgssc unregistered [13604.057227] LNet: 296899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13604.065825] LNetError: 296899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13604.091650] LNet: Removed LNI 192.168.203.23@tcp [13604.763949] Key type .llcrypt unregistered [13604.766506] Key type ._llcrypt unregistered [13615.600757] Key type ._llcrypt registered [13615.608155] Key type .llcrypt registered [13616.424600] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13616.451234] alg: No test for adler32 (adler32-zlib) [13617.415708] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [13617.658770] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [13619.444914] Key type lgssc registered [13620.738784] Lustre: Echo OBD driver; http://www.lustre.org/ [13678.577337] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13683.795995] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13706.040587] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14005.298168] LNet: Added LNI 192.168.203.23@tcp50 [8/256/0/180] [14007.841363] LNet: Removed LNI 192.168.203.23@tcp [14010.098341] Lustre: 301292:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8c34d0b59000: config has no valid NIDs, force dynamic NIDs [14011.290863] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [14011.492731] Lustre: Unmounted lustre-client [14014.239661] Key type lgssc unregistered [14014.518294] LNet: 301551:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14014.523665] LNetError: 301551:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14014.541324] LNet: Removed LNI 192.168.203.23@tcp50 [14015.132658] Key type .llcrypt unregistered [14015.139103] Key type ._llcrypt unregistered [14033.285026] Key type ._llcrypt registered [14033.301547] Key type .llcrypt registered [14033.679625] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14033.700895] alg: No test for adler32 (adler32-zlib) [14034.813884] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [14035.121807] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [14036.775196] Key type lgssc registered [14038.203137] Lustre: Echo OBD driver; http://www.lustre.org/ [14103.304673] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14108.987887] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14116.869644] LNet: Added LNI 192.168.203.23@tcp50 [8/256/0/180] [14117.841400] LNet: Removed LNI 192.168.203.23@tcp [14119.058268] Lustre: 304239:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8c34d0fab800: config has no valid NIDs, force dynamic NIDs [14120.260050] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [14120.882165] Lustre: Unmounted lustre-client [14163.008795] Key type lgssc unregistered [14163.350769] LNet: 305108:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14163.373886] LNetError: 305108:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14163.399713] LNet: Removed LNI 192.168.203.23@tcp50 [14164.148217] Key type .llcrypt unregistered [14164.152345] Key type ._llcrypt unregistered [14176.044743] Key type ._llcrypt registered [14176.056340] Key type .llcrypt registered [14177.680969] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 19:12:13 (1788477133) [14196.558719] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14196.671375] alg: No test for adler32 (adler32-zlib) [14197.855696] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [14198.122187] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [14199.839170] Key type lgssc registered [14201.204555] Lustre: Echo OBD driver; http://www.lustre.org/ [14282.324263] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14287.240883] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14309.514553] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14350.650546] Key type lgssc unregistered [14350.866909] LNet: 309850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14350.871494] LNetError: 309850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14350.893260] LNet: Removed LNI 192.168.203.23@tcp [14351.582213] Key type .llcrypt unregistered [14351.588429] Key type ._llcrypt unregistered [14363.143675] Key type ._llcrypt registered [14363.145608] Key type .llcrypt registered [14364.364638] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 19:15:20 (1788477320) [14366.579869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14366.591225] alg: No test for adler32 (adler32-zlib) [14367.625468] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [14367.790148] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [14369.439189] Key type lgssc registered [14370.685849] Lustre: Echo OBD driver; http://www.lustre.org/ [14428.491916] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14433.294675] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14451.648821] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14454.285407] Lustre: Mounted lustre-client - version 2.17.58_2_gbb63b80 [14511.782189] Lustre: Mounted fs15246-client - version 2.17.58_2_gbb63b80 [14526.361154] Lustre: Unmounted fs15246-client [14551.926291] Lustre: Unmounted lustre-client [14587.521276] Key type lgssc unregistered [14587.813487] LNet: 314703:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14587.827909] LNetError: 314703:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14587.867871] LNet: Removed LNI 192.168.203.23@tcp [14588.536230] Key type .llcrypt unregistered [14588.538563] Key type ._llcrypt unregistered [14598.158618] Key type ._llcrypt registered [14598.163779] Key type .llcrypt registered [14599.623920] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 19:19:15 (1788477555) [14601.922667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14601.936888] alg: No test for adler32 (adler32-zlib) [14603.046762] Lustre: Lustre: Build Version: 2.17.58_2_gbb63b80 [14603.363865] LNet: Added LNI 192.168.203.23@tcp [8/256/0/180] [14605.081893] Key type lgssc registered [14606.581260] Lustre: Echo OBD driver; http://www.lustre.org/ [14732.986924] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14739.273980] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14766.350924] Lustre: DEBUG MARKER: oleg323-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14871.965343] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14549 sec ========= 19:23:47 (1788477827) [14873.906599] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 19:23:49 (1788477829) === [14877.714307] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 19:23:53 (1788477833) === [14912.963270] Key type lgssc unregistered [14913.218275] LNet: 323960:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14913.223844] LNetError: 323960:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14913.235154] LNet: Removed LNI 192.168.203.23@tcp [14913.899723] Key type .llcrypt unregistered [14913.902772] Key type ._llcrypt unregistered