[ 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 442930815 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.001013] APIC: Switch to symmetric I/O mode setup [ 0.003181] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008520] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009025] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010013] pid_max: default: 32768 minimum: 301 [ 0.011157] LSM: Security Framework initializing [ 0.012056] Yama: becoming mindful. [ 0.014028] SELinux: Initializing. [ 0.015071] *** VALIDATE selinux *** [ 0.023486] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027764] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028169] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029115] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030112] *** VALIDATE tmpfs *** [ 0.032364] *** VALIDATE proc *** [ 0.033254] *** VALIDATE cgroup *** [ 0.034013] *** VALIDATE cgroup2 *** [ 0.035272] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036157] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038026] Spectre V2 : User space: Vulnerable [ 0.039009] Speculative Store Bypass: Vulnerable [ 0.042469] debug: unmapping init [mem 0xffffffffba659000-0xffffffffba660fff] [ 0.044175] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045702] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046023] ... version: 2 [ 0.047012] ... bit width: 48 [ 0.048012] ... generic registers: 4 [ 0.049014] ... value mask: 0000ffffffffffff [ 0.050015] ... max period: 00007fffffffffff [ 0.051014] ... fixed-purpose events: 3 [ 0.052012] ... event mask: 000000070000000f [ 0.053297] rcu: Hierarchical SRCU implementation. [ 0.055259] smp: Bringing up secondary CPUs ... [ 0.056585] x86: Booting SMP configuration: [ 0.057032] .... node #0, CPUs: #1 #2 #3 [ 0.060070] smp: Brought up 1 node, 4 CPUs [ 0.062013] smpboot: Max logical packages: 1 [ 0.063013] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.142046] node 0 deferred pages initialised in 77ms [ 0.145007] devtmpfs: initialized [ 0.146187] x86/mm: Memory block size: 128MB [ 0.149973] gcov: version magic: 0x41383552 [ 0.151251] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.154068] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.155266] pinctrl core: initialized pinctrl subsystem [ 0.156200] [ 0.156725] ************************************************************* [ 0.157021] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.158014] ** ** [ 0.159013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.160015] ** ** [ 0.161014] ** This means that this kernel is built to expose internal ** [ 0.162016] ** IOMMU data structures, which may compromise security on ** [ 0.163012] ** your system. ** [ 0.164030] ** ** [ 0.165014] ** If you see this message and you are not debugging the ** [ 0.166012] ** kernel, report this immediately to your vendor! ** [ 0.167015] ** ** [ 0.168014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.169015] ************************************************************* [ 0.170680] NET: Registered protocol family 16 [ 0.171387] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.172067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.173066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.174447] cpuidle: using governor menu [ 0.175157] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.177529] PCI: Using configuration type 1 for base access [ 0.179128] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.190067] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.192037] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.197048] cryptd: max_cpu_qlen set to 1000 [ 0.198213] ACPI: Added _OSI(Module Device) [ 0.200014] ACPI: Added _OSI(Processor Device) [ 0.201013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.202028] ACPI: Added _OSI(Processor Aggregator Device) [ 0.207286] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.212626] ACPI: Interpreter enabled [ 0.214057] ACPI: PM: (supports S0 S3 S4 S5) [ 0.215012] ACPI: Using IOAPIC for interrupt routing [ 0.217092] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.220723] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.231508] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.234043] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.236025] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.240092] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.245520] acpiphp: Slot [2] registered [ 0.247099] acpiphp: Slot [5] registered [ 0.248136] acpiphp: Slot [6] registered [ 0.249107] acpiphp: Slot [3] registered [ 0.251116] acpiphp: Slot [4] registered [ 0.252109] acpiphp: Slot [7] registered [ 0.254090] acpiphp: Slot [8] registered [ 0.255299] acpiphp: Slot [9] registered [ 0.257113] acpiphp: Slot [10] registered [ 0.259837] acpiphp: Slot [11] registered [ 0.261144] acpiphp: Slot [12] registered [ 0.262104] acpiphp: Slot [13] registered [ 0.264103] acpiphp: Slot [14] registered [ 0.265135] acpiphp: Slot [15] registered [ 0.267098] acpiphp: Slot [16] registered [ 0.269104] acpiphp: Slot [17] registered [ 0.270097] acpiphp: Slot [18] registered [ 0.272100] acpiphp: Slot [19] registered [ 0.273096] acpiphp: Slot [20] registered [ 0.275115] acpiphp: Slot [21] registered [ 0.276093] acpiphp: Slot [22] registered [ 0.278107] acpiphp: Slot [23] registered [ 0.279103] acpiphp: Slot [24] registered [ 0.281097] acpiphp: Slot [25] registered [ 0.283089] acpiphp: Slot [26] registered [ 0.284094] acpiphp: Slot [27] registered [ 0.286126] acpiphp: Slot [28] registered [ 0.287087] acpiphp: Slot [29] registered [ 0.289098] acpiphp: Slot [30] registered [ 0.290094] acpiphp: Slot [31] registered [ 0.292086] PCI host bridge to bus 0000:00 [ 0.293017] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.296025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.298021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.300023] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.302019] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.305021] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.306166] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.309530] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.311930] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.317985] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.321827] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.325020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.327015] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.328015] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.331414] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.333447] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.337048] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.338692] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.342011] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.351018] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.356011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.359985] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.366015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.371018] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.384023] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.391277] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.399018] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.407016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.422019] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.431581] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.433344] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.434299] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.436314] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.438177] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.442315] iommu: Default domain type: Passthrough [ 0.444528] SCSI subsystem initialized [ 0.445116] ACPI: bus type USB registered [ 0.447148] usbcore: registered new interface driver usbfs [ 0.449077] usbcore: registered new interface driver hub [ 0.451185] usbcore: registered new device driver usb [ 0.453126] pps_core: LinuxPPS API ver. 1 registered [ 0.454005] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.455053] PTP clock support registered [ 0.457081] EDAC MC: Ver: 3.0.0 [ 0.458464] PCI: Using ACPI for IRQ routing [ 0.459610] NetLabel: Initializing [ 0.461013] NetLabel: domain hash size = 128 [ 0.462007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.464082] NetLabel: unlabeled traffic allowed by default [ 0.466292] vgaarb: loaded [ 0.467251] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.469014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.477000] clocksource: Switched to clocksource kvm-clock [ 0.582883] VFS: Disk quotas dquot_6.6.0 [ 0.584373] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.586733] *** VALIDATE ramfs *** [ 0.588049] *** VALIDATE hugetlbfs *** [ 0.589559] pnp: PnP ACPI init [ 0.591957] pnp: PnP ACPI: found 6 devices [ 0.609256] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.612459] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.614567] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.616273] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.618213] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.620370] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.622828] NET: Registered protocol family 2 [ 0.625253] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.629532] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.633225] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.638924] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.642616] TCP: Hash tables configured (established 65536 bind 65536) [ 0.645621] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.648448] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.650712] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.653199] NET: Registered protocol family 1 [ 0.655376] RPC: Registered named UNIX socket transport module. [ 0.657415] RPC: Registered udp transport module. [ 0.658923] RPC: Registered tcp transport module. [ 0.660600] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.662868] NET: Registered protocol family 44 [ 0.664250] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.666167] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.667571] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.669209] PCI: CLS 0 bytes, default 64 [ 0.670732] Unpacking initramfs... [ 2.032875] debug: unmapping init [mem 0xffff8bee7cc64000-0xffff8bee7ffcffff] [ 2.037034] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.039380] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.041740] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.538173] Initialise system trusted keyrings [ 2.540067] Key type blacklist registered [ 2.542088] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.554243] zbud: loaded [ 2.558320] *** VALIDATE nfs *** [ 2.559290] *** VALIDATE nfs4 *** [ 2.560806] pstore: using deflate compression [ 2.564243] Platform Keyring initialized [ 2.690751] NET: Registered protocol family 38 [ 2.692593] Key type asymmetric registered [ 2.693900] Asymmetric key parser 'x509' registered [ 2.695408] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.698738] io scheduler mq-deadline registered [ 2.700559] io scheduler kyber registered [ 2.702372] io scheduler bfq registered [ 2.704321] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.707500] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.710457] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.713567] ACPI: Power Button [PWRF] [ 2.722533] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.730146] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.742819] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.771082] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.800265] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.805739] Non-volatile memory driver v1.3 [ 2.807592] Linux agpgart interface v0.103 [ 2.845183] virtio_blk virtio1: [vda] 149896 512-byte logical blocks (76.7 MB/73.2 MiB) [ 2.848765] vda: detected capacity change from 0 to 76746752 [ 2.863980] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.866511] vdb: detected capacity change from 0 to 1073741824 [ 2.873263] libphy: Fixed MDIO Bus: probed [ 2.880336] usbcore: registered new interface driver usbserial_generic [ 2.882833] usbserial: USB Serial support registered for generic [ 2.885345] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.890124] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.892492] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.895649] mousedev: PS/2 mouse device common for all mice [ 2.898549] rtc_cmos 00:05: RTC can wake from S4 [ 2.901779] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.901868] rtc_cmos 00:05: registered as rtc0 [ 2.907271] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.910220] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.911110] intel_pstate: CPU model not supported [ 2.916270] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.920733] hid: raw HID events driver (C) Jiri Kosina [ 2.924168] usbcore: registered new interface driver usbhid [ 2.926216] usbhid: USB HID core driver [ 2.927877] drop_monitor: Initializing network drop monitor service [ 2.930277] Initializing XFRM netlink socket [ 2.932326] NET: Registered protocol family 10 [ 2.935625] Segment Routing with IPv6 [ 2.939111] NET: Registered protocol family 17 [ 2.941455] mpls_gso: MPLS GSO support [ 2.947141] RAS: Correctable Errors collector initialized. [ 2.949648] AVX version of gcm_enc/dec engaged. [ 2.951610] AES CTR mode by8 optimization enabled [ 3.031233] sched_clock: Marking stable (3031199122, 0)->(3997349359, -966150237) [ 3.035645] registered taskstats version 1 [ 3.037887] Loading compiled-in X.509 certificates [ 3.040250] zswap: loaded using pool lzo/zbud [ 3.071599] Key type big_key registered [ 3.086994] Key type encrypted registered [ 3.088703] ima: No TPM chip found, activating TPM-bypass! [ 3.090982] ima: Allocated hash algorithm: sha1 [ 3.093194] ima: No architecture policies found [ 3.095096] evm: Initialising EVM extended attributes: [ 3.097203] evm: security.selinux [ 3.098465] evm: security.ima [ 3.099629] evm: security.capability [ 3.101121] evm: HMAC attrs: 0x1 [ 3.103565] rtc_cmos 00:05: setting system clock to 2026-09-03 08:01:33 UTC (1788422493) [ 3.112119] debug: unmapping init [mem 0xffffffffbb603000-0xffffffffbb7fffff] [ 3.115633] debug: unmapping init [mem 0xffffffffba382000-0xffffffffba658fff] [ 3.124545] Write protecting the kernel read-only data: 28672k [ 3.128419] debug: unmapping init [mem 0xffffffffb8a03000-0xffffffffb8bfffff] [ 3.131371] debug: unmapping init [mem 0xffffffffb9314000-0xffffffffb93fffff] [ 3.165613] 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.174464] systemd[1]: Detected virtualization kvm. [ 3.176536] systemd[1]: Detected architecture x86-64. [ 3.178409] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.205139] systemd[1]: No hostname configured. [ 3.206573] systemd[1]: Set hostname to . [ 3.208783] random: systemd: uninitialized urandom read (16 bytes read) [ 3.211498] systemd[1]: Initializing machine ID from random generator. [ 3.371352] random: systemd: uninitialized urandom read (16 bytes read) [ 3.373549] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.376664] random: systemd: uninitialized urandom read (16 bytes read) [ 3.378403] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.381507] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Reached target Timers. [ OK ] Reached target Initrd Root Device. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket. Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.967702] device-mapper: uevent: version 1.0.3 [ 3.970338] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.689842] virtio_net virtio0 ens2: renamed from eth0 [ 4.782705] scsi host0: ata_piix [ 4.789094] scsi host1: ata_piix [ 4.791865] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.793889] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.539302] dracut-initqueue[584]: RTNETLINK answers: File exists [ 8.993400] random: fast init done [ 9.606290] random: crng init done [ 9.607946] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.199040] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ 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 Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped target Slices. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.436400] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.672062] SELinux: Disabled at runtime. [ 11.730338] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.743667] systemd[1]: Detected virtualization kvm. [ 11.745776] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.342096] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.344782] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.350255] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.354935] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.359134] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.366636] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.375876] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... Mounting Kernel Debug File System... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target rpc_pipefs.target. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. Mounting Huge Pages File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Apply Kernel Variables... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on Process Core Dump Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ 12.571145] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 12.920145] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.329549] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.378891] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.570194] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.633764] EDAC sbridge: Ver: 1.1.2 [ 15.124683] Key type dns_resolver registered [ 15.449119] NFS: Registering the id_resolver key type [ 15.450675] Key type id_resolver registered [ 15.452071] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started daily update of the root trust anchor for DNSSEC. Starting Restore /run/initramfs on shutdown... Starting Network Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started 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. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Started Authorization Manager. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg228-client login: [ 50.126714] libcfs: loading out-of-tree module taints kernel. [ 50.198356] Key type ._llcrypt registered [ 50.202084] Key type .llcrypt registered [ 50.755333] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 50.765409] alg: No test for adler32 (adler32-zlib) [ 52.031282] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 52.567767] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 54.247233] Key type lgssc registered [ 55.268377] Lustre: Echo OBD driver; http://www.lustre.org/ [ 114.501016] hrtimer: interrupt took 3417420 ns [ 260.701469] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 265.983927] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 284.687463] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing check_logdir /tmp/testlogs/ [ 286.177553] Lustre: lustre-OST0000-osc-ffff8beec7e93800: disconnect after 23s idle [ 290.535970] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing yml_node [ 296.549245] Lustre: DEBUG MARKER: Client: 2.17.58.7 [ 299.424095] Lustre: DEBUG MARKER: MDS: 2.17.58.7 [ 302.652575] Lustre: DEBUG MARKER: OSS: 2.17.58.7 [ 304.525256] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 3 04:06:33 EDT 2026 [ 326.114350] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 328.259847] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 332.254399] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 342.626514] Lustre: Unmounted lustre-client [ 474.114127] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 481.814409] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 510.264806] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 551.893545] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 04:10:40 (1788423040) [ 555.443188] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 558.643564] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 04:10:46 (1788423046) [ 598.185237] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 605.433913] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 633.021858] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 639.580410] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 645.553063] Lustre: Unmounted lustre-client [ 676.800160] Key type lgssc unregistered [ 677.024047] LNet: 15074:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 677.031607] LNetError: 15074:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 677.058452] LNet: Removed LNI 192.168.202.28@tcp [ 678.328163] Key type .llcrypt unregistered [ 678.334228] Key type ._llcrypt unregistered [ 697.876819] Key type ._llcrypt registered [ 697.878687] Key type .llcrypt registered [ 699.028340] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 04:13:08 (1788423188) [ 701.142190] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 701.254851] alg: No test for adler32 (adler32-zlib) [ 702.434513] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 702.877631] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 704.687947] Key type lgssc registered [ 706.996771] Lustre: Echo OBD driver; http://www.lustre.org/ [ 789.551534] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 876.421528] Lustre: Unmounted lustre-client [ 917.716870] Key type lgssc unregistered [ 918.124722] LNet: 18884:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 918.133239] LNetError: 18884:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 918.164768] LNet: Removed LNI 192.168.202.28@tcp [ 918.970744] Key type .llcrypt unregistered [ 918.972800] Key type ._llcrypt unregistered [ 931.707584] Key type ._llcrypt registered [ 931.718912] Key type .llcrypt registered [ 932.875733] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 04:17:01 (1788423421) [ 936.655408] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 936.699448] alg: No test for adler32 (adler32-zlib) [ 938.080652] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 938.445772] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 940.159171] Key type lgssc registered [ 942.228513] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1004.536595] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1011.262304] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1037.864849] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1039.900019] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 1053.301197] Lustre: Unmounted lustre-client [ 1083.413840] Key type lgssc unregistered [ 1083.641137] LNet: 22482:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1083.645159] LNetError: 22482:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1083.671430] LNet: Removed LNI 192.168.202.28@tcp [ 1084.275398] Key type .llcrypt unregistered [ 1084.277183] Key type ._llcrypt unregistered [ 1096.245438] Key type ._llcrypt registered [ 1096.247597] Key type .llcrypt registered [ 1097.724398] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 04:19:46 (1788423586) [ 1101.719297] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1101.761792] alg: No test for adler32 (adler32-zlib) [ 1102.842686] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 1103.191089] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 1105.055243] Key type lgssc registered [ 1106.119427] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1172.270643] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1182.747779] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1210.171432] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1211.476413] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 1219.956881] Lustre: Unmounted lustre-client [ 1251.453117] Key type lgssc unregistered [ 1251.666092] LNet: 25676:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1251.675563] LNetError: 25676:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1251.700693] LNet: Removed LNI 192.168.202.28@tcp [ 1252.410485] Key type .llcrypt unregistered [ 1252.414471] Key type ._llcrypt unregistered [ 1270.780733] Key type ._llcrypt registered [ 1270.784797] Key type .llcrypt registered [ 1272.320944] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 04:22:41 (1788423761) [ 1275.016682] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1275.047545] alg: No test for adler32 (adler32-zlib) [ 1276.122690] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 1276.390034] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 1278.047176] Key type lgssc registered [ 1279.288508] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1337.285699] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1345.031293] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1375.529210] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1378.640205] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 1383.929560] Lustre: lustre-MDT0000-mdc-ffff8beec76fa800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1394.198281] Lustre: lustre-MDT0001-mdc-ffff8beec76fa800: Connection to lustre-MDT0001 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1410.189327] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1410.528192] Lustre: 26634:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788423884/real 1788423884] req@00000000365a8c02 x1875298238863360/t0(0) o400->MGC192.168.202.128@tcp@192.168.202.128@tcp:26/25 lens 224/224 e 0 to 1 dl 1788423900 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1410.571329] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [ 1420.528141] Lustre: Unmounted lustre-client [ 1435.605785] Key type lgssc unregistered [ 1435.879547] LNet: 29333:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1435.891085] LNetError: 29333:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1435.914218] LNet: Removed LNI 192.168.202.28@tcp [ 1436.449682] Key type .llcrypt unregistered [ 1436.451208] Key type ._llcrypt unregistered [ 1455.086180] Key type ._llcrypt registered [ 1455.097092] Key type .llcrypt registered [ 1456.583833] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 04:25:45 (1788423945) [ 1458.717972] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1458.868207] alg: No test for adler32 (adler32-zlib) [ 1459.924349] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 1460.250253] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 1461.991204] Key type lgssc registered [ 1463.810535] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1524.491791] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1533.797808] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1564.988166] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1568.133666] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 1573.357359] Lustre: lustre-OST0000-osc-ffff8beed8148800: Connection to lustre-OST0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1580.788769] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1591.230980] Lustre: Unmounted lustre-client [ 1625.362503] Key type lgssc unregistered [ 1625.765655] LNet: 32948:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1625.771533] LNetError: 32948:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1625.796659] LNet: Removed LNI 192.168.202.28@tcp [ 1626.833855] Key type .llcrypt unregistered [ 1626.839516] Key type ._llcrypt unregistered [ 1646.513626] Key type ._llcrypt registered [ 1646.516685] Key type .llcrypt registered [ 1648.458898] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 04:28:56 (1788424136) [ 1651.107266] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1651.167771] alg: No test for adler32 (adler32-zlib) [ 1652.524710] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 1652.939859] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 1654.687335] Key type lgssc registered [ 1656.453691] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1717.717854] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1728.671282] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1755.849174] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1757.700201] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 1762.505464] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1766.586817] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1778.482333] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-03 4h31m07s [ 1781.294580] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1788.399769] Lustre: lustre-MDT0000-mdc-ffff8beec51be800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1792.920027] LustreError: 36738:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8beec51be800: can't stat MDS #0: rc = -19 [ 1794.859928] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1806.822518] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [ 1806.855977] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0x5e7a98c580c7ed84 to 0x5e7a98c580c7f071 [ 1806.878105] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [ 1807.928197] LustreError: lustre-MDT0000-mdc-ffff8beec51be800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1807.961693] Lustre: lustre-MDT0000-mdc-ffff8beec51be800: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [ 1813.769065] Lustre: DEBUG MARKER: Wait for df (36738) ... [ 1816.114824] Lustre: DEBUG MARKER: done [ 1818.781697] Lustre: Unmounted lustre-client [ 1849.108766] Key type lgssc unregistered [ 1849.622768] LNet: 37753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1849.626174] LNetError: 37753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1849.642284] LNet: Removed LNI 192.168.202.28@tcp [ 1850.408299] Key type .llcrypt unregistered [ 1850.410344] Key type ._llcrypt unregistered [ 1889.632914] Key type ._llcrypt registered [ 1889.637725] Key type .llcrypt registered [ 1891.594939] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 04:32:59 (1788424379) [ 1895.352096] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1895.485796] alg: No test for adler32 (adler32-zlib) [ 1896.679893] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 1897.061651] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 1898.743172] Key type lgssc registered [ 1901.254037] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1970.506562] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1978.206698] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2006.858881] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2010.215401] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 2016.831363] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-03 4h35m04s [ 2018.724229] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 2029.841597] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 2033.653916] Lustre: DEBUG MARKER: Creating a test file and stat it [ 2054.111258] Lustre: 41904:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788424524/real 1788424524] req@00000000f1ebf3db x1875298890030336/t0(0) o101->lustre-MDT0000-mdc-ffff8beec51bf800@192.168.202.128@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788424544 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 2054.144523] Lustre: lustre-MDT0000-mdc-ffff8beec51bf800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2054.202204] Lustre: lustre-MDT0000-mdc-ffff8beec51bf800: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [ 2075.838888] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 2079.095909] Lustre: DEBUG MARKER: done [ 2083.963898] Lustre: Unmounted lustre-client [ 2120.803886] Key type lgssc unregistered [ 2121.162974] LNet: 42792:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2121.177934] LNetError: 42792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2121.216655] LNet: Removed LNI 192.168.202.28@tcp [ 2121.935611] Key type .llcrypt unregistered [ 2121.938154] Key type ._llcrypt unregistered [ 2170.070409] Key type ._llcrypt registered [ 2170.078177] Key type .llcrypt registered [ 2172.468697] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 04:37:40 (1788424660) [ 2174.496708] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2176.415640] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 04:37:45 (1788424665) [ 2181.410082] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2181.483935] alg: No test for adler32 (adler32-zlib) [ 2182.737063] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 2183.126398] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 2184.871221] Key type lgssc registered [ 2186.279074] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2219.755116] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 04:38:28 (1788424708) [ 2253.999047] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2260.536736] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2286.887643] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2288.861500] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 2293.289353] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2297.694377] Lustre: Unmounted lustre-client [ 2324.262726] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2374.417520] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2380.753667] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2381.548424] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 2386.364876] Lustre: Unmounted lustre-client [ 2454.350730] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2460.693962] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2461.767869] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 2466.047403] Lustre: Unmounted lustre-client [ 2490.513633] Lustre: DEBUG MARKER: files compared the same [ 2515.710352] Key type lgssc unregistered [ 2516.051948] LNet: 50425:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2516.060273] LNetError: 50425:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2516.082849] LNet: Removed LNI 192.168.202.28@tcp [ 2517.001967] Key type .llcrypt unregistered [ 2517.004060] Key type ._llcrypt unregistered [ 2536.048964] Key type ._llcrypt registered [ 2536.051926] Key type .llcrypt registered [ 2537.521924] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 04:43:46 (1788425026) [ 2539.859355] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2539.955466] alg: No test for adler32 (adler32-zlib) [ 2541.027702] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 2541.373188] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 2543.119486] Key type lgssc registered [ 2544.628108] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2594.971517] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2601.123283] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2623.699649] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2626.427997] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 2630.802238] Lustre: Unmounted lustre-client [ 2660.122557] Key type lgssc unregistered [ 2660.368621] LNet: 54005:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2660.379472] LNetError: 54005:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2660.401945] LNet: Removed LNI 192.168.202.28@tcp [ 2661.094074] Key type .llcrypt unregistered [ 2661.098227] Key type ._llcrypt unregistered [ 2676.206331] Key type ._llcrypt registered [ 2676.210517] Key type .llcrypt registered [ 2677.531471] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 04:46:06 (1788425166) [ 2680.369464] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2680.396629] alg: No test for adler32 (adler32-zlib) [ 2681.549872] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 2681.783993] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 2683.471213] Key type lgssc registered [ 2684.675494] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2772.790576] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2808.190958] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2815.398239] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2843.375301] Key type lgssc unregistered [ 2843.700884] LNet: 57491:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2843.717494] LNetError: 57491:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2843.747959] LNet: Removed LNI 192.168.202.28@tcp [ 2844.696853] Key type .llcrypt unregistered [ 2844.700989] Key type ._llcrypt unregistered [ 2860.907992] Key type ._llcrypt registered [ 2860.910327] Key type .llcrypt registered [ 2862.615900] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 04:49:11 (1788425351) [ 2866.649091] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2866.720226] alg: No test for adler32 (adler32-zlib) [ 2867.898943] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 2868.193919] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 2869.847456] Key type lgssc registered [ 2871.377809] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2948.840460] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 2956.540359] Lustre: Unmounted lustre-client [ 2993.073909] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 04:51:22 (1788425482) [ 3113.828424] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3131.792480] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3138.907845] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3138.920245] LustreError: 63963:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8beee0060800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3138.945392] Lustre: 58476:0:(llite_lib.c:4341:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.128@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3149.306820] Lustre: Unmounted lustre-client [ 3191.116758] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 04:54:40 (1788425680) [ 3201.232270] Key type lgssc unregistered [ 3201.526365] LNet: 65174:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3201.531258] LNetError: 65174:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3201.543145] LNet: Removed LNI 192.168.202.28@tcp [ 3202.212949] Key type .llcrypt unregistered [ 3202.217389] Key type ._llcrypt unregistered [ 3213.380349] Key type ._llcrypt registered [ 3213.388977] Key type .llcrypt registered [ 3214.188761] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3214.240154] alg: No test for adler32 (adler32-zlib) [ 3215.477387] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 3215.792053] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 3217.599223] Key type lgssc registered [ 3219.227984] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3264.616947] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3269.861811] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3288.725920] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3290.375441] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3293.940546] Lustre: Unmounted lustre-client [ 3322.221386] Key type lgssc unregistered [ 3322.489214] LNet: 68184:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3322.497464] LNetError: 68184:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3322.531551] LNet: Removed LNI 192.168.202.28@tcp [ 3323.244771] Key type .llcrypt unregistered [ 3323.248413] Key type ._llcrypt unregistered [ 3335.497400] Key type ._llcrypt registered [ 3335.506253] Key type .llcrypt registered [ 3335.990394] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3336.017103] alg: No test for adler32 (adler32-zlib) [ 3337.312839] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 3337.483489] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 3339.192693] Key type lgssc registered [ 3340.098994] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3458.324867] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3464.786203] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3487.160913] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3488.879336] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3492.706858] Lustre: Unmounted lustre-client [ 3519.897938] Key type lgssc unregistered [ 3520.141491] LNet: 71612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3520.151770] LNetError: 71612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3520.177794] LNet: Removed LNI 192.168.202.28@tcp [ 3520.975960] Key type .llcrypt unregistered [ 3520.980938] Key type ._llcrypt unregistered [ 3536.094217] Key type ._llcrypt registered [ 3536.100221] Key type .llcrypt registered [ 3537.429667] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 05:00:26 (1788426026) [ 3539.916775] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3539.948683] alg: No test for adler32 (adler32-zlib) [ 3541.091726] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 3541.360804] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 3543.063149] Key type lgssc registered [ 3544.139649] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3601.578261] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3610.157872] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3634.470079] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3645.486278] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3650.440175] Lustre: Unmounted lustre-client [ 3650.898270] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3653.534074] Lustre: Unmounted lustre-client [ 3678.215726] Key type lgssc unregistered [ 3678.585981] LNet: 75309:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3678.594679] LNetError: 75309:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3678.612216] LNet: Removed LNI 192.168.202.28@tcp [ 3679.564706] Key type .llcrypt unregistered [ 3679.569549] Key type ._llcrypt unregistered [ 3692.865349] Key type ._llcrypt registered [ 3692.878280] Key type .llcrypt registered [ 3693.385049] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3693.422272] alg: No test for adler32 (adler32-zlib) [ 3694.390795] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 3694.695213] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 3696.407200] Key type lgssc registered [ 3697.776624] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3750.014581] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3756.624344] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3783.507586] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3786.393922] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3791.605525] Lustre: Unmounted lustre-client [ 3821.216233] Key type lgssc unregistered [ 3821.664876] LNet: 78348:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3821.683381] LNetError: 78348:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3821.704350] LNet: Removed LNI 192.168.202.28@tcp [ 3822.802246] Key type .llcrypt unregistered [ 3822.805179] Key type ._llcrypt unregistered [ 3841.634608] Key type ._llcrypt registered [ 3841.639937] Key type .llcrypt registered [ 3843.575543] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 05:05:31 (1788426331) [ 3846.931913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3846.960301] alg: No test for adler32 (adler32-zlib) [ 3848.309420] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 3848.633941] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 3850.375271] Key type lgssc registered [ 3851.846526] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3910.655581] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3919.207669] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3944.658725] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3951.686794] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 3960.454190] Lustre: lustre: root_squash is set to 0:0 [ 3960.500768] Lustre: lustre: nosquash_nids is cleared [ 3969.064725] Lustre: lustre: root_squash is set to 500:500 [ 3988.541488] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.28@tcp 192.168.0.[2,10]@tcp [ 4002.366507] Lustre: lustre: nosquash_nids set to 192.168.202.28/24@tcp [ 4005.972330] Lustre: Unmounted lustre-client [ 4036.681118] Key type lgssc unregistered [ 4036.983327] LNet: 82357:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4036.993656] LNetError: 82357:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4037.018624] LNet: Removed LNI 192.168.202.28@tcp [ 4037.877263] Key type .llcrypt unregistered [ 4037.878982] Key type ._llcrypt unregistered [ 4054.021781] Key type ._llcrypt registered [ 4054.026480] Key type .llcrypt registered [ 4055.542658] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 05:09:04 (1788426544) [ 4057.908384] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4059.975954] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 05:09:08 (1788426548) [ 4061.894976] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4061.914730] alg: No test for adler32 (adler32-zlib) [ 4063.206364] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 4063.481736] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 4065.199461] Key type lgssc registered [ 4066.593327] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4127.419517] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4134.525735] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4158.857756] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4160.463447] Lustre: lustre: root_squash is set to 500:500 [ 4160.512879] Lustre: lustre: nosquash_nids set to 192.168.202.28/24@tcp [ 4161.644258] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 4168.834035] Lustre: Unmounted lustre-client [ 4195.292592] Key type lgssc unregistered [ 4195.682843] LNet: 86314:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4195.693741] LNetError: 86314:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4195.747708] LNet: Removed LNI 192.168.202.28@tcp [ 4196.632136] Key type .llcrypt unregistered [ 4196.633891] Key type ._llcrypt unregistered [ 4218.914694] Key type ._llcrypt registered [ 4218.916324] Key type .llcrypt registered [ 4220.070890] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4221.929386] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 05:11:50 (1788426710) [ 4242.956010] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4243.083501] alg: No test for adler32 (adler32-zlib) [ 4244.263712] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 4244.603333] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 4246.287192] Key type lgssc registered [ 4247.748654] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4353.706574] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4360.776909] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4384.824167] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4471.773721] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4478.980095] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4504.215803] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4520.673741] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 4561.786182] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8beec7e92000.ost_server_uuid 50 [ 4563.910157] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8beec7e92000.ost_server_uuid in IDLE state after 0 sec [ 4564.612397] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 4569.759971] Lustre: Unmounted lustre-client [ 4573.731643] Lustre: Unmounted lustre-client [ 4624.067600] Key type lgssc unregistered [ 4624.393728] LNet: 93987:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4624.404440] LNetError: 93987:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4624.443153] LNet: Removed LNI 192.168.202.28@tcp [ 4625.525952] Key type .llcrypt unregistered [ 4625.527429] Key type ._llcrypt unregistered [ 4666.394421] Key type ._llcrypt registered [ 4666.401662] Key type .llcrypt registered [ 4667.907854] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 05:19:16 (1788427156) [ 4690.284432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4690.415226] alg: No test for adler32 (adler32-zlib) [ 4691.782783] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 4692.129418] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 4693.928356] Key type lgssc registered [ 4695.232239] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4806.474720] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4815.464442] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4847.555362] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4849.451774] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 4854.775411] Lustre: lustre-OST0000-osc-ffff8beec2fed800: Connection to lustre-OST0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4890.601815] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [ 4890.602176] Lustre: lustre-MDT0000-mdc-ffff8beec2fed800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4890.656801] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0x628dabf42d2b96d4 to 0x628dabf42d2b987f [ 4890.705902] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [ 4911.107553] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [ 4911.148622] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0x628dabf42d2b987f to 0x628dabf42d2b9a62 [ 4911.159477] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [ 4918.597857] Lustre: Unmounted lustre-client [ 4958.997299] Key type lgssc unregistered [ 4959.382930] LNet: 99659:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4959.390821] LNetError: 99659:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4959.413412] LNet: Removed LNI 192.168.202.28@tcp [ 4960.296107] Key type .llcrypt unregistered [ 4960.311506] Key type ._llcrypt unregistered [ 4983.464913] Key type ._llcrypt registered [ 4983.467988] Key type .llcrypt registered [ 4985.793244] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 05:24:33 (1788427473) [ 5002.299879] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5002.320604] alg: No test for adler32 (adler32-zlib) [ 5003.340936] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 5003.673269] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 5005.416503] Key type lgssc registered [ 5006.825462] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5052.500259] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5163.154698] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5169.753617] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5199.510940] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5202.381052] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 5204.989967] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5208.291036] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 05:28:16 (1788427696) [ 5482.224787] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5492.587166] Lustre: Unmounted lustre-client [ 5634.555626] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5641.132289] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5667.886589] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5716.310310] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:36:44 (1788428204) [ 5834.916964] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5843.645352] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5871.022881] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5871.699640] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 5876.263706] Lustre: Unmounted lustre-client [ 5910.992229] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:39:59 (1788428399) [ 6029.146737] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6038.769658] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6065.203604] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6065.844249] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 6071.849013] Lustre: Unmounted lustre-client [ 6103.507360] Key type lgssc unregistered [ 6103.792565] LNet: 122693:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6103.803674] LNetError: 122693:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6103.826571] LNet: Removed LNI 192.168.202.28@tcp [ 6104.771054] Key type .llcrypt unregistered [ 6104.773052] Key type ._llcrypt unregistered [ 6121.611739] Key type ._llcrypt registered [ 6121.613951] Key type .llcrypt registered [ 6123.019846] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 05:43:31 (1788428611) [ 6125.604860] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6125.794995] alg: No test for adler32 (adler32-zlib) [ 6126.977392] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 6127.293910] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 6129.015418] Key type lgssc registered [ 6130.466350] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6182.580892] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6187.457668] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6208.451853] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6210.378399] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 6225.405727] Lustre: Unmounted lustre-client [ 6255.929872] Key type lgssc unregistered [ 6256.207489] LNet: 126282:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6256.226359] LNetError: 126282:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6256.269033] LNet: Removed LNI 192.168.202.28@tcp [ 6257.053651] Key type .llcrypt unregistered [ 6257.058428] Key type ._llcrypt unregistered [ 6277.256345] Key type ._llcrypt registered [ 6277.257783] Key type .llcrypt registered [ 6278.623501] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 05:46:07 (1788428767) [ 6281.154915] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6281.390088] alg: No test for adler32 (adler32-zlib) [ 6282.658985] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 6283.014774] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 6284.911261] Key type lgssc registered [ 6286.281785] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6342.281832] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6348.774764] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6372.510470] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6375.450995] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 6380.534202] Lustre: lustre-OST0000-osc-ffff8beec5a92000: Connection to lustre-OST0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6395.879291] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8beec5a92000.ost_server_uuid 50 [ 6397.913041] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6409.227558] Lustre: Unmounted lustre-client [ 6432.760501] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 05:48:41 (1788428921) [ 6469.355708] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6474.770484] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6497.915817] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6526.065994] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6527.046816] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 6532.089928] Lustre: lustre-OST0000-osc-ffff8beec4d37800: Connection to lustre-OST0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6571.025360] Lustre: Unmounted lustre-client [ 6625.560274] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 05:51:54 (1788429114) [ 6661.567404] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6668.266379] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6691.785290] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6716.749401] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6717.452521] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 6722.550853] Lustre: lustre-OST0000-osc-ffff8beec3310000: Connection to lustre-OST0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6739.781190] Lustre: Unmounted lustre-client [ 6793.993218] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 05:54:42 (1788429282) [ 6902.410266] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6908.661267] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6931.311929] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7008.940576] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7015.478276] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7037.718585] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7081.555485] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 7127.169022] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7128.687616] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7131.271512] Lustre: Unmounted lustre-client [ 7162.604884] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 06:00:51 (1788429651) [ 7204.235110] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7212.093939] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7237.487802] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7279.218921] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7311.725867] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 7355.720992] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7357.569936] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7370.248363] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7380.589972] Lustre: Unmounted lustre-client [ 7438.269749] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 06:05:27 (1788429927) [ 7474.722750] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7481.313932] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7505.163179] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7505.789626] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 7531.153671] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7533.131680] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7550.307850] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8beee01cd000.ost_server_uuid 50 [ 7552.049279] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8beee01cd000.ost_server_uuid in IDLE state after 0 sec [ 7555.798477] Lustre: Unmounted lustre-client [ 7556.151978] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7556.157412] Lustre: Skipped 3 previous similar messages [ 7556.324642] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 7557.492545] LustreError: 149728:0:(sec.c:403:import_sec_validate_get()) import 000000000e43b0e7 (NEW) with no sec [ 7626.606745] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 06:08:35 (1788430115) [ 7664.552796] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7673.028501] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7696.552293] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7719.334186] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7719.769385] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7719.952315] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 7734.064384] Lustre: Unmounted lustre-client [ 7734.074971] Lustre: Skipped 1 previous similar message [ 7771.229272] Key type lgssc unregistered [ 7771.688485] LNet: 153148:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7771.707087] LNetError: 153148:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7771.739112] LNet: Removed LNI 192.168.202.28@tcp [ 7772.892730] Key type .llcrypt unregistered [ 7772.896518] Key type ._llcrypt unregistered [ 7792.705685] Key type ._llcrypt registered [ 7792.707668] Key type .llcrypt registered [ 7793.785386] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 06:11:22 (1788430282) [ 7795.148586] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7795.159563] alg: No test for adler32 (adler32-zlib) [ 7796.151629] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 7796.513555] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 7798.191209] Key type lgssc registered [ 7799.458483] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7858.849383] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7865.837028] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7888.900516] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7915.866857] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7916.527673] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7917.748063] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 7925.302118] LustreError: lustre-MDT0001-mdc-ffff8beec7b96000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7925.317557] Lustre: lustre-MDT0001-mdc-ffff8beec7b96000: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [ 7932.875702] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7935.143422] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7960.094465] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7964.416353] Lustre: Unmounted lustre-client [ 7991.603946] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 06:14:40 (1788430480) [ 8099.752927] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8107.169345] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8133.907014] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8135.029702] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 8168.405687] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8170.610400] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8184.167708] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8194.561154] Lustre: Unmounted lustre-client [ 8241.016852] Key type lgssc unregistered [ 8241.388468] LNet: 162753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8241.407058] LNetError: 162753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8241.433576] LNet: Removed LNI 192.168.202.28@tcp [ 8242.569875] Key type .llcrypt unregistered [ 8242.578552] Key type ._llcrypt unregistered [ 8277.709295] Key type ._llcrypt registered [ 8277.711340] Key type .llcrypt registered [ 8279.056072] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 06:19:27 (1788430767) [ 8281.882325] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8281.912440] alg: No test for adler32 (adler32-zlib) [ 8283.038468] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 8283.256265] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 8284.927239] Key type lgssc registered [ 8286.738942] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8351.289258] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8357.860125] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8379.146309] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8382.340497] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 8433.403671] Lustre: Unmounted lustre-client [ 8478.047471] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8478.684279] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 8515.782510] Lustre: Unmounted lustre-client [ 8552.099654] Key type lgssc unregistered [ 8552.611104] LNet: 167200:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8552.631261] LNetError: 167200:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8552.665538] LNet: Removed LNI 192.168.202.28@tcp [ 8553.970823] Key type .llcrypt unregistered [ 8553.975780] Key type ._llcrypt unregistered [ 8574.559663] Key type ._llcrypt registered [ 8574.564202] Key type .llcrypt registered [ 8577.252820] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 06:24:24 (1788431064) [ 8580.370767] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8580.547850] alg: No test for adler32 (adler32-zlib) [ 8581.610148] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 8582.038078] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 8583.768493] Key type lgssc registered [ 8585.430208] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8649.953581] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8656.881974] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8679.526048] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8686.657393] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 8707.240260] Lustre: Unmounted lustre-client [ 8736.264898] Key type lgssc unregistered [ 8736.560965] LNet: 170954:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8736.579817] LNetError: 170954:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8736.616088] LNet: Removed LNI 192.168.202.28@tcp [ 8737.626911] Key type .llcrypt unregistered [ 8737.629525] Key type ._llcrypt unregistered [ 8753.283914] Key type ._llcrypt registered [ 8753.287579] Key type .llcrypt registered [ 8754.182525] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8754.195345] alg: No test for adler32 (adler32-zlib) [ 8755.391755] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 8755.874804] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 8757.671336] Key type lgssc registered [ 8760.202704] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8822.555746] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8829.001973] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8853.911846] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8860.265667] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 8870.084179] Lustre: Unmounted lustre-client [ 8899.485805] Key type lgssc unregistered [ 8899.972245] LNet: 174019:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8899.984227] LNetError: 174019:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8900.023494] LNet: Removed LNI 192.168.202.28@tcp [ 8901.014429] Key type .llcrypt unregistered [ 8901.021431] Key type ._llcrypt unregistered [ 8920.958706] Key type ._llcrypt registered [ 8920.963933] Key type .llcrypt registered [ 8922.828492] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 06:30:11 (1788431411) [ 8925.839621] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8925.864941] alg: No test for adler32 (adler32-zlib) [ 8927.160417] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 8927.579083] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 8929.287633] Key type lgssc registered [ 8930.674944] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8988.761596] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8995.972113] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9022.832618] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9030.271125] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 9051.409604] Lustre: Unmounted lustre-client [ 9082.600269] Key type lgssc unregistered [ 9082.929666] LNet: 177770:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9082.946581] LNetError: 177770:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9082.992675] LNet: Removed LNI 192.168.202.28@tcp [ 9083.910683] Key type .llcrypt unregistered [ 9083.919412] Key type ._llcrypt unregistered [ 9098.694973] Key type ._llcrypt registered [ 9098.735979] Key type .llcrypt registered [ 9099.218339] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9099.232477] alg: No test for adler32 (adler32-zlib) [ 9100.458908] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 9100.764081] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 9102.552897] Key type lgssc registered [ 9104.254694] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9161.068500] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9167.292612] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9189.547825] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9191.106328] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 9202.748280] Lustre: Unmounted lustre-client [ 9230.259524] Key type lgssc unregistered [ 9230.506759] LNet: 180832:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9230.514074] LNetError: 180832:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9230.537502] LNet: Removed LNI 192.168.202.28@tcp [ 9231.382515] Key type .llcrypt unregistered [ 9231.384642] Key type ._llcrypt unregistered [ 9248.972431] Key type ._llcrypt registered [ 9248.973756] Key type .llcrypt registered [ 9250.752985] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 06:35:39 (1788431739) [ 9275.755483] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9275.863253] alg: No test for adler32 (adler32-zlib) [ 9277.000461] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 9277.220948] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 9278.892319] Key type lgssc registered [ 9280.357286] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9367.364636] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9373.850417] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9396.174617] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9435.865639] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 06:38:44 (1788431924) [ 9471.591599] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9478.771302] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9500.757923] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9502.496595] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 9509.056848] Lustre: Unmounted lustre-client [ 9537.436440] Key type lgssc unregistered [ 9537.764141] LNet: 187947:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9537.769610] LNetError: 187947:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9537.784415] LNet: Removed LNI 192.168.202.28@tcp [ 9538.692091] Key type .llcrypt unregistered [ 9538.697087] Key type ._llcrypt unregistered [ 9554.941522] Key type ._llcrypt registered [ 9554.943526] Key type .llcrypt registered [ 9556.455260] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9558.158635] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 06:40:47 (1788432047) [ 9576.572496] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9576.624221] alg: No test for adler32 (adler32-zlib) [ 9577.845358] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [ 9578.144965] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [ 9579.887694] Key type lgssc registered [ 9581.380500] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9668.590848] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9674.761591] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9700.933489] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9723.323242] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9726.016664] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [ 9748.544432] Lustre: Unmounted lustre-client [ 9892.502639] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9899.308617] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9924.623848] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9967.671859] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 06:47:36 (1788432456) [ 9969.274931] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9971.313890] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 06:47:40 (1788432460) [10068.621976] Key type lgssc unregistered [10069.041302] LNet: 199392:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10069.057372] LNetError: 199392:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10069.092378] LNet: Removed LNI 192.168.202.28@tcp [10070.132025] Key type .llcrypt unregistered [10070.136431] Key type ._llcrypt unregistered [10089.784500] Key type ._llcrypt registered [10089.787265] Key type .llcrypt registered [10091.416477] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 06:49:39 (1788432579) [10133.138057] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10133.306326] alg: No test for adler32 (adler32-zlib) [10134.345530] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [10134.572735] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [10136.328141] Key type lgssc registered [10137.580540] Lustre: Echo OBD driver; http://www.lustre.org/ [10181.395459] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10187.423861] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10222.396974] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10251.621861] Key type lgssc unregistered [10251.951192] LNet: 203123:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10251.961295] LNetError: 203123:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10252.003054] LNet: Removed LNI 192.168.202.28@tcp [10253.008925] Key type .llcrypt unregistered [10253.010325] Key type ._llcrypt unregistered [10270.695474] Key type ._llcrypt registered [10270.696572] Key type .llcrypt registered [10272.298650] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 06:52:40 (1788432760) [10275.125975] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10275.281518] alg: No test for adler32 (adler32-zlib) [10276.583660] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [10276.835710] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [10278.519295] Key type lgssc registered [10279.845633] Lustre: Echo OBD driver; http://www.lustre.org/ [10330.840388] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10336.886436] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10359.598918] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10361.159261] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [10376.701590] Lustre: lustre-MDT0000-mdc-ffff8beee0064800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [10397.194692] Lustre: lustre-MDT0001-mdc-ffff8beee0064800: Connection to lustre-MDT0001 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [10408.416154] Lustre: 204108:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788432882/real 1788432882] req@00000000e40b1552 x1875307677173248/t0(0) o400->MGC192.168.202.128@tcp@192.168.202.128@tcp:26/25 lens 224/224 e 0 to 1 dl 1788432898 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10408.437729] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [10417.707617] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0x42b0105ed77cc6d6 to 0x42b0105ed77ce1cc [10417.720279] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [10442.215607] LustreError: lustre-MDT0000-mdc-ffff8beee0064800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10442.296939] Lustre: lustre-MDT0000-mdc-ffff8beee0064800: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [10444.378403] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10445.895687] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10451.873623] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10453.722302] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10456.982820] Lustre: Unmounted lustre-client [10488.250287] Key type lgssc unregistered [10488.904330] LNet: 208063:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10488.921714] LNetError: 208063:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10488.962540] LNet: Removed LNI 192.168.202.28@tcp [10489.767608] Key type .llcrypt unregistered [10489.769588] Key type ._llcrypt unregistered [10510.489746] Key type ._llcrypt registered [10510.494928] Key type .llcrypt registered [10512.729759] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 06:56:40 (1788433000) [10515.697993] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10516.076643] alg: No test for adler32 (adler32-zlib) [10517.282867] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [10517.673535] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [10519.536442] Key type lgssc registered [10521.470600] Lustre: Echo OBD driver; http://www.lustre.org/ [10574.220208] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10581.621270] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10652.656766] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10659.200402] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10693.480091] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10717.896828] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10759.377432] Key type lgssc unregistered [10759.809716] LNet: 213357:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10759.819716] LNetError: 213357:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10759.846149] LNet: Removed LNI 192.168.202.28@tcp [10760.811564] Key type .llcrypt unregistered [10760.816911] Key type ._llcrypt unregistered [10806.911132] Key type ._llcrypt registered [10806.913424] Key type .llcrypt registered [10808.612910] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 07:01:37 (1788433297) [10850.331059] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10850.361171] alg: No test for adler32 (adler32-zlib) [10851.627378] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [10851.930643] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [10853.738310] Key type lgssc registered [10855.145971] Lustre: Echo OBD driver; http://www.lustre.org/ [10948.112170] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10955.790782] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10984.479470] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11030.477284] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 07:05:18 (1788433518) [11039.260290] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 07:05:28 (1788433528) [11078.684791] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11084.783876] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11105.711623] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11108.491405] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [11117.508193] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [11120.157937] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [11122.264840] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [11124.252808] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [11128.820685] Lustre: lustre-MDT0000-mdc-ffff8beee01cd800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [11139.046488] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [11139.075481] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0xd8c963f77cc38d01 to 0xd8c963f77cc38e74 [11139.103476] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [11149.312791] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [11149.340679] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0xd8c963f77cc38e74 to 0xd8c963f77cc39057 [11149.367963] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [11152.239429] Lustre: lustre-MDT0000-mdc-ffff8beee01cd800: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [11163.509726] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11165.570493] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11169.185529] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [11174.910846] Lustre: lustre-MDT0000-mdc-ffff8beee01cd800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [11180.024855] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [11180.060975] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0xd8c963f77cc39057 to 0xd8c963f77cc39202 [11180.082829] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [11195.372182] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [11195.396270] Lustre: Evicted from MGS (at 192.168.202.128@tcp) after server handle changed from 0xd8c963f77cc39202 to 0xd8c963f77cc39248 [11195.407706] Lustre: MGC192.168.202.128@tcp: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [11195.583663] Lustre: 221255:0:(mgc_request.c:2378:mgc_process_log()) MGC192.168.202.128@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [11222.408808] Lustre: lustre-MDT0000-mdc-ffff8beee01cd800: Connection restored to 192.168.202.128@tcp (at 192.168.202.128@tcp) [11234.195290] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11236.517267] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11240.665518] Lustre: Unmounted lustre-client [11322.065180] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11329.276370] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11352.934670] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11363.884732] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [11366.995475] Lustre: Unmounted lustre-client [11397.813363] Key type lgssc unregistered [11398.338259] LNet: 225854:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11398.346591] LNetError: 225854:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11398.376660] LNet: Removed LNI 192.168.202.28@tcp [11399.759700] Key type .llcrypt unregistered [11399.771638] Key type ._llcrypt unregistered [11423.387360] Key type ._llcrypt registered [11423.393243] Key type .llcrypt registered [11425.038922] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 07:11:53 (1788433913) [11430.434228] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11430.452593] alg: No test for adler32 (adler32-zlib) [11431.701447] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [11432.208628] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [11434.103312] Key type lgssc registered [11435.752191] Lustre: Echo OBD driver; http://www.lustre.org/ [11489.879638] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11496.537854] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11522.215793] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11524.417944] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [11533.178272] Lustre: Unmounted lustre-client [11617.413811] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11626.406751] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11655.815620] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11656.645916] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [11666.029832] Lustre: Unmounted lustre-client [11743.780616] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11752.095767] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11780.655232] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11782.062960] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [11784.351604] Lustre: Unmounted lustre-client [11813.659491] Key type lgssc unregistered [11814.065096] LNet: 232911:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11814.083414] LNetError: 232911:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11814.105169] LNet: Removed LNI 192.168.202.28@tcp [11815.116611] Key type .llcrypt unregistered [11815.118420] Key type ._llcrypt unregistered [11837.991458] Key type ._llcrypt registered [11838.000750] Key type .llcrypt registered [11839.925979] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 07:18:48 (1788434328) [11844.127774] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11844.294220] alg: No test for adler32 (adler32-zlib) [11845.596909] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [11845.989784] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [11847.729733] Key type lgssc registered [11848.954667] Lustre: Echo OBD driver; http://www.lustre.org/ [11910.487325] Key type lgssc unregistered [11910.792182] LNet: 235232:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11910.799526] LNetError: 235232:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11910.821860] LNet: Removed LNI 192.168.202.28@tcp [11911.456598] Key type .llcrypt unregistered [11911.459579] Key type ._llcrypt unregistered [11944.142459] Key type ._llcrypt registered [11944.155608] Key type .llcrypt registered [11944.864325] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11944.890975] alg: No test for adler32 (adler32-zlib) [11946.196203] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [11946.484694] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [11948.143717] Key type lgssc registered [11949.620762] Lustre: Echo OBD driver; http://www.lustre.org/ [12036.036734] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12042.337461] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12066.782359] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12122.546090] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [12124.210807] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 07:23:33 (1788434613) [12163.105222] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12170.214947] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12196.911573] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12225.076298] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12226.972186] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [12232.181774] Lustre: lustre-OST0001-osc-ffff8beee01cc800: Connection to lustre-OST0001 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [12241.159257] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12251.489580] Lustre: Unmounted lustre-client [12289.284705] Key type lgssc unregistered [12289.610713] LNet: 242347:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12289.636779] LNetError: 242347:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12289.678861] LNet: Removed LNI 192.168.202.28@tcp [12290.663363] Key type .llcrypt unregistered [12290.665090] Key type ._llcrypt unregistered [12329.550272] Key type ._llcrypt registered [12329.553543] Key type .llcrypt registered [12331.342118] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 07:26:59 (1788434819) [12346.414756] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12346.429538] alg: No test for adler32 (adler32-zlib) [12347.592951] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [12347.861880] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [12349.575253] Key type lgssc registered [12350.880463] Lustre: Echo OBD driver; http://www.lustre.org/ [12405.200518] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12413.089144] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12442.531709] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 07:28:50 (1788434930) [12478.601321] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12485.970784] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12511.933329] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12514.923246] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [12530.216925] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12536.639741] Lustre: Unmounted lustre-client [12670.511961] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12676.987462] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12732.655721] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12733.770335] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [12737.268682] Lustre: Unmounted lustre-client [12768.799792] Key type lgssc unregistered [12769.319805] LNet: 250049:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12769.322738] LNetError: 250049:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12769.347733] LNet: Removed LNI 192.168.202.28@tcp [12770.695909] Key type .llcrypt unregistered [12770.699315] Key type ._llcrypt unregistered [12807.161335] Key type ._llcrypt registered [12807.166564] Key type .llcrypt registered [12808.110502] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12808.135438] alg: No test for adler32 (adler32-zlib) [12809.357265] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [12809.733478] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [12811.488124] Key type lgssc registered [12813.134843] Lustre: Echo OBD driver; http://www.lustre.org/ [12897.334654] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12906.529823] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12932.397442] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12979.521927] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12981.095982] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 07:37:50 (1788435470) [13017.295531] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13024.338800] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13045.392221] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13050.157542] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [13053.856784] Lustre: Unmounted lustre-client [13081.624711] Key type lgssc unregistered [13081.947826] LNet: 256684:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13081.970108] LNetError: 256684:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13081.998625] LNet: Removed LNI 192.168.202.28@tcp [13082.804690] Key type .llcrypt unregistered [13082.810799] Key type ._llcrypt unregistered [13100.076162] Key type ._llcrypt registered [13100.079563] Key type .llcrypt registered [13101.661628] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [13103.515803] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 07:39:52 (1788435592) [13112.339333] Key type .llcrypt unregistered [13112.341663] Key type ._llcrypt unregistered [13121.892731] Key type ._llcrypt registered [13121.895230] Key type .llcrypt registered [13122.321821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13122.342540] alg: No test for adler32 (adler32-zlib) [13123.504153] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [13123.993498] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [13125.840935] Key type lgssc registered [13127.121720] Lustre: Echo OBD driver; http://www.lustre.org/ [13179.106650] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13194.844503] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [13197.976983] Lustre: Unmounted lustre-client [13227.328719] Key type lgssc unregistered [13227.614829] LNet: 260131:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13227.619277] LNetError: 260131:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13227.641207] LNet: Removed LNI 192.168.202.28@tcp [13228.597766] Key type .llcrypt unregistered [13228.616987] Key type ._llcrypt unregistered [13247.088371] Key type ._llcrypt registered [13247.091500] Key type .llcrypt registered [13248.705543] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 07:42:17 (1788435737) [13251.490391] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13251.870980] alg: No test for adler32 (adler32-zlib) [13253.060796] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [13253.466634] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [13255.266889] Key type lgssc registered [13256.806807] Lustre: Echo OBD driver; http://www.lustre.org/ [13348.160787] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13386.020858] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13392.361124] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13394.204218] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [13397.041619] Lustre: Unmounted lustre-client [13425.497811] Key type lgssc unregistered [13425.771186] LNet: 263669:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13425.790866] LNetError: 263669:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13425.811487] LNet: Removed LNI 192.168.202.28@tcp [13426.515290] Key type .llcrypt unregistered [13426.517399] Key type ._llcrypt unregistered [13445.408844] Key type ._llcrypt registered [13445.410892] Key type .llcrypt registered [13447.215605] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 07:45:35 (1788435935) [13450.119931] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13450.256097] alg: No test for adler32 (adler32-zlib) [13451.557302] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [13451.977126] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [13453.879260] Key type lgssc registered [13455.425345] Lustre: Echo OBD driver; http://www.lustre.org/ [13509.415639] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13515.981290] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13539.790517] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13542.586875] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [13548.021167] Lustre: lustre-MDT0000-mdc-ffff8beef22fa800: Connection to lustre-MDT0000 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [13553.474834] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13553.532264] LustreError: 266821:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13554.035265] LustreError: 266832:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13554.056156] LustreError: 266832:0:(file.c:6167:ll_inode_revalidate_fini()) Skipped 3 previous similar messages [13554.350097] LustreError: MGC192.168.202.128@tcp: Connection to MGS (at 192.168.202.128@tcp) was lost; in progress operations using this service will fail [13554.466070] Lustre: Unmounted lustre-client [13581.882931] Key type lgssc unregistered [13582.232101] LNet: 267233:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13582.245298] LNetError: 267233:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13582.275181] LNet: Removed LNI 192.168.202.28@tcp [13583.619406] Key type .llcrypt unregistered [13583.621228] Key type ._llcrypt unregistered [13604.300768] Key type ._llcrypt registered [13604.303822] Key type .llcrypt registered [13606.026080] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 07:48:14 (1788436094) [13608.433432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13608.546523] alg: No test for adler32 (adler32-zlib) [13609.766277] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [13610.017111] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [13611.727646] Key type lgssc registered [13613.357831] Lustre: Echo OBD driver; http://www.lustre.org/ [13665.877382] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13672.083459] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13690.665614] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13693.418932] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [13703.994806] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13705.825930] Lustre: Unmounted lustre-client [13730.759870] Key type lgssc unregistered [13731.237444] LNet: 270808:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13731.257947] LNetError: 270808:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13731.294874] LNet: Removed LNI 192.168.202.28@tcp [13732.676140] Key type .llcrypt unregistered [13732.682676] Key type ._llcrypt unregistered [13761.418371] Key type ._llcrypt registered [13761.426222] Key type .llcrypt registered [13763.900862] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 07:50:51 (1788436251) [13788.972248] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13789.039405] alg: No test for adler32 (adler32-zlib) [13790.466886] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [13791.002827] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [13792.759918] Key type lgssc registered [13794.356810] Lustre: Echo OBD driver; http://www.lustre.org/ [13930.570654] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13932.637976] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [13979.623112] Lustre: lustre-MDT0001-mdc-ffff8beec506f000: Connection to lustre-MDT0001 (at 192.168.202.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [13988.032639] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13998.406879] Lustre: Unmounted lustre-client [14035.201356] Key type lgssc unregistered [14035.569599] LNet: 276600:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14035.575758] LNetError: 276600:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14035.596599] LNet: Removed LNI 192.168.202.28@tcp [14036.305684] Key type .llcrypt unregistered [14036.308589] Key type ._llcrypt unregistered [14055.083520] Key type ._llcrypt registered [14055.090562] Key type .llcrypt registered [14056.803497] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 07:55:45 (1788436545) [14058.490348] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [14060.667856] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 07:55:49 (1788436549) [14062.642859] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [14065.125646] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 07:55:53 (1788436553) [14067.460052] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [14069.418339] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 07:55:58 (1788436558) [14071.441650] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [14073.263550] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 07:56:02 (1788436562) [14075.012404] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [14077.180353] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 07:56:05 (1788436565) [14086.653572] Key type .llcrypt unregistered [14086.655610] Key type ._llcrypt unregistered [14094.944147] Key type ._llcrypt registered [14094.950928] Key type .llcrypt registered [14095.746492] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14095.766555] alg: No test for adler32 (adler32-zlib) [14096.954106] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [14097.357467] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [14099.087404] Key type lgssc registered [14100.554379] Lustre: Echo OBD driver; http://www.lustre.org/ [14186.393881] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14195.708496] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14221.984255] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14223.591732] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [14225.158357] Lustre: Unmounted lustre-client [14266.922629] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 07:59:15 (1788436755) [14300.646486] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14306.343293] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14340.409236] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14346.819088] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [14349.183093] Lustre: Unmounted lustre-client [14389.749723] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 08:01:18 (1788436878) [14399.455470] LNet: 1 local NIs in recovery (showing 1): 192.168.202.28@tcp [15047.888764] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15054.809723] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15091.957530] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15216.031065] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 08:15:04 (1788437704) [15229.475944] Key type lgssc unregistered [15229.920555] LNet: 290143:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15229.929902] LNetError: 290143:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15229.957372] LNet: Removed LNI 192.168.202.28@tcp [15230.903229] Key type .llcrypt unregistered [15230.904758] Key type ._llcrypt unregistered [15352.351513] Key type ._llcrypt registered [15352.357097] Key type .llcrypt registered [15353.117150] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15353.137265] alg: No test for adler32 (adler32-zlib) [15354.336088] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [15354.689519] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [15356.415604] Key type lgssc registered [15357.987472] Lustre: Echo OBD driver; http://www.lustre.org/ [15460.840026] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15468.052335] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15495.227262] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15533.467441] Key type lgssc unregistered [15533.788924] LNet: 293834:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15533.806519] LNetError: 293834:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15533.832778] LNet: Removed LNI 192.168.202.28@tcp [15534.891819] Key type .llcrypt unregistered [15534.895364] Key type ._llcrypt unregistered [15573.693750] Key type ._llcrypt registered [15573.695310] Key type .llcrypt registered [15574.834460] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 08:21:03 (1788438063) [15602.147156] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15602.248501] alg: No test for adler32 (adler32-zlib) [15603.489815] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [15603.792942] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [15605.570102] Key type lgssc registered [15606.956174] Lustre: Echo OBD driver; http://www.lustre.org/ [15665.300112] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 08:22:33 (1788438153) [15678.059136] Key type lgssc unregistered [15678.390104] LNet: 297394:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15678.403623] LNetError: 297394:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15678.435873] LNet: Removed LNI 192.168.202.28@tcp [15679.268106] Key type .llcrypt unregistered [15679.270085] Key type ._llcrypt unregistered [15691.741443] Key type ._llcrypt registered [15691.798940] Key type .llcrypt registered [15692.106502] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15692.127438] alg: No test for adler32 (adler32-zlib) [15693.239709] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [15693.479623] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [15695.207285] Key type lgssc registered [15696.721911] Lustre: Echo OBD driver; http://www.lustre.org/ [15757.729994] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15765.095488] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15793.753044] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16105.433429] LNet: Added LNI 192.168.202.28@tcp50 [8/256/0/180] [16108.180508] LNet: Removed LNI 192.168.202.28@tcp [16110.520635] Lustre: 301795:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8beee0188000: config has no valid NIDs, force dynamic NIDs [16111.786853] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [16111.988817] Lustre: Unmounted lustre-client [16115.195636] Key type lgssc unregistered [16115.655683] LNet: 302052:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16115.667847] LNetError: 302052:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16116.735120] LNet: Removed LNI 192.168.202.28@tcp50 [16117.595625] Key type .llcrypt unregistered [16117.602814] Key type ._llcrypt unregistered [16139.589159] Key type ._llcrypt registered [16139.608162] Key type .llcrypt registered [16140.257859] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16140.267197] alg: No test for adler32 (adler32-zlib) [16141.409666] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [16141.828081] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [16143.663246] Key type lgssc registered [16144.921472] Lustre: Echo OBD driver; http://www.lustre.org/ [16209.694941] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16215.739363] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16224.907883] LNet: Added LNI 192.168.202.28@tcp50 [8/256/0/180] [16225.707914] LNet: Removed LNI 192.168.202.28@tcp [16252.692232] Lustre: 304838:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8beef202d800: config has no valid NIDs, force dynamic NIDs [16253.933897] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [16254.702949] Lustre: Unmounted lustre-client [16300.071444] Key type lgssc unregistered [16300.678446] LNet: 305708:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16300.685530] LNetError: 305708:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16301.739199] LNet: Removed LNI 192.168.202.28@tcp50 [16302.727620] Key type .llcrypt unregistered [16302.730594] Key type ._llcrypt unregistered [16317.572418] Key type ._llcrypt registered [16317.573822] Key type .llcrypt registered [16319.436972] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 08:33:27 (1788438807) [16342.837335] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16343.148833] alg: No test for adler32 (adler32-zlib) [16344.443218] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [16345.002617] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [16346.847271] Key type lgssc registered [16348.642355] Lustre: Echo OBD driver; http://www.lustre.org/ [16450.644518] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16457.079861] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16483.935503] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16530.718408] Key type lgssc unregistered [16531.030959] LNet: 310457:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16531.038354] LNetError: 310457:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16531.059550] LNet: Removed LNI 192.168.202.28@tcp [16532.034831] Key type .llcrypt unregistered [16532.037639] Key type ._llcrypt unregistered [16545.929300] Key type ._llcrypt registered [16545.931810] Key type .llcrypt registered [16547.538373] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 08:37:16 (1788439036) [16550.392732] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16550.425655] alg: No test for adler32 (adler32-zlib) [16551.639724] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [16552.096236] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [16553.871844] Key type lgssc registered [16555.663649] Lustre: Echo OBD driver; http://www.lustre.org/ [16616.285464] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16624.329714] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16649.795791] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16657.016916] Lustre: Mounted lustre-client - version 2.17.58_7_g065ac5e [16724.456146] Lustre: Mounted fs15246-client - version 2.17.58_7_g065ac5e [16742.574533] Lustre: Unmounted fs15246-client [16774.101657] Lustre: Unmounted lustre-client [16804.291516] Key type lgssc unregistered [16804.563665] LNet: 315321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16804.577876] LNetError: 315321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16804.596422] LNet: Removed LNI 192.168.202.28@tcp [16805.361310] Key type .llcrypt unregistered [16805.364339] Key type ._llcrypt unregistered [16818.040970] Key type ._llcrypt registered [16818.044184] Key type .llcrypt registered [16819.883032] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 08:41:48 (1788439308) [16821.953328] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16821.994564] alg: No test for adler32 (adler32-zlib) [16823.032919] Lustre: Lustre: Build Version: 2.17.58_7_g065ac5e [16823.249705] LNet: Added LNI 192.168.202.28@tcp [8/256/0/180] [16824.991769] Key type lgssc registered [16826.709662] Lustre: Echo OBD driver; http://www.lustre.org/ [16988.918483] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16995.726332] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17025.023458] Lustre: DEBUG MARKER: oleg228-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17140.029890] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16832 sec ========= 08:47:07 (1788439627) [17142.033982] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 08:47:10 (1788439630) === [17146.392625] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 08:47:14 (1788439634) === [17190.353676] Key type lgssc unregistered [17190.892610] LNet: 324591:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17190.906337] LNetError: 324591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17190.929167] LNet: Removed LNI 192.168.202.28@tcp [17192.193644] Key type .llcrypt unregistered [17192.198547] Key type ._llcrypt unregistered