[ 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 470040071 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.001011] APIC: Switch to symmetric I/O mode setup [ 0.003173] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005015] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008020] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009011] pid_max: default: 32768 minimum: 301 [ 0.010131] LSM: Security Framework initializing [ 0.011056] Yama: becoming mindful. [ 0.012042] SELinux: Initializing. [ 0.013083] *** VALIDATE selinux *** [ 0.020877] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024619] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025156] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026114] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027108] *** VALIDATE tmpfs *** [ 0.028471] *** VALIDATE proc *** [ 0.029244] *** VALIDATE cgroup *** [ 0.030010] *** VALIDATE cgroup2 *** [ 0.032168] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.033162] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.034009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.035032] Spectre V2 : User space: Vulnerable [ 0.036012] Speculative Store Bypass: Vulnerable [ 0.039475] debug: unmapping init [mem 0xffffffff9ba59000-0xffffffff9ba60fff] [ 0.042000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.042714] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.043028] ... version: 2 [ 0.044014] ... bit width: 48 [ 0.045011] ... generic registers: 4 [ 0.046013] ... value mask: 0000ffffffffffff [ 0.047014] ... max period: 00007fffffffffff [ 0.048017] ... fixed-purpose events: 3 [ 0.049012] ... event mask: 000000070000000f [ 0.050291] rcu: Hierarchical SRCU implementation. [ 0.052453] smp: Bringing up secondary CPUs ... [ 0.053608] x86: Booting SMP configuration: [ 0.054027] .... node #0, CPUs: #1 #2 #3 [ 0.057516] smp: Brought up 1 node, 4 CPUs [ 0.059012] smpboot: Max logical packages: 1 [ 0.060018] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.137481] node 0 deferred pages initialised in 74ms [ 0.139115] devtmpfs: initialized [ 0.140244] x86/mm: Memory block size: 128MB [ 0.143026] gcov: version magic: 0x41383552 [ 0.144619] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.145098] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.148214] pinctrl core: initialized pinctrl subsystem [ 0.149178] [ 0.149584] ************************************************************* [ 0.150021] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.151012] ** ** [ 0.152015] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.153010] ** ** [ 0.154008] ** This means that this kernel is built to expose internal ** [ 0.155010] ** IOMMU data structures, which may compromise security on ** [ 0.156010] ** your system. ** [ 0.157009] ** ** [ 0.158010] ** If you see this message and you are not debugging the ** [ 0.159011] ** kernel, report this immediately to your vendor! ** [ 0.160012] ** ** [ 0.161007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.162010] ************************************************************* [ 0.163683] NET: Registered protocol family 16 [ 0.164392] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.165060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.166060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.167351] cpuidle: using governor menu [ 0.168614] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.170417] PCI: Using configuration type 1 for base access [ 0.172090] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.176152] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.177000] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.178109] cryptd: max_cpu_qlen set to 1000 [ 0.181471] ACPI: Added _OSI(Module Device) [ 0.183012] ACPI: Added _OSI(Processor Device) [ 0.184012] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.185018] ACPI: Added _OSI(Processor Aggregator Device) [ 0.189592] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.193478] ACPI: Interpreter enabled [ 0.194047] ACPI: PM: (supports S0 S3 S4 S5) [ 0.195011] ACPI: Using IOAPIC for interrupt routing [ 0.197104] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.199291] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.210144] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.212037] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.214015] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.216087] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.220287] acpiphp: Slot [2] registered [ 0.222096] acpiphp: Slot [5] registered [ 0.223121] acpiphp: Slot [6] registered [ 0.225115] acpiphp: Slot [3] registered [ 0.226123] acpiphp: Slot [4] registered [ 0.228102] acpiphp: Slot [7] registered [ 0.229097] acpiphp: Slot [8] registered [ 0.231129] acpiphp: Slot [9] registered [ 0.232100] acpiphp: Slot [10] registered [ 0.234116] acpiphp: Slot [11] registered [ 0.235155] acpiphp: Slot [12] registered [ 0.237135] acpiphp: Slot [13] registered [ 0.238111] acpiphp: Slot [14] registered [ 0.240096] acpiphp: Slot [15] registered [ 0.241092] acpiphp: Slot [16] registered [ 0.243099] acpiphp: Slot [17] registered [ 0.244102] acpiphp: Slot [18] registered [ 0.246137] acpiphp: Slot [19] registered [ 0.247086] acpiphp: Slot [20] registered [ 0.248070] acpiphp: Slot [21] registered [ 0.249075] acpiphp: Slot [22] registered [ 0.250072] acpiphp: Slot [23] registered [ 0.251069] acpiphp: Slot [24] registered [ 0.252090] acpiphp: Slot [25] registered [ 0.253067] acpiphp: Slot [26] registered [ 0.254071] acpiphp: Slot [27] registered [ 0.255070] acpiphp: Slot [28] registered [ 0.256081] acpiphp: Slot [29] registered [ 0.257082] acpiphp: Slot [30] registered [ 0.258090] acpiphp: Slot [31] registered [ 0.259073] PCI host bridge to bus 0000:00 [ 0.260014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.261015] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.263015] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.264016] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.266019] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.268019] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.269159] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.271877] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.274144] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.279881] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.282911] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.285015] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.287014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.288013] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.290501] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.292694] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.294033] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.296730] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.300012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.308014] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.312013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.315539] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.324014] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.329017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.342018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.350685] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.377025] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.381013] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.390016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.400994] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.403369] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.405382] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.408326] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.410184] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.414099] iommu: Default domain type: Passthrough [ 0.416449] SCSI subsystem initialized [ 0.417092] ACPI: bus type USB registered [ 0.418102] usbcore: registered new interface driver usbfs [ 0.420118] usbcore: registered new interface driver hub [ 0.421059] usbcore: registered new device driver usb [ 0.423139] pps_core: LinuxPPS API ver. 1 registered [ 0.424007] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.426052] PTP clock support registered [ 0.427109] EDAC MC: Ver: 3.0.0 [ 0.428334] PCI: Using ACPI for IRQ routing [ 0.429458] NetLabel: Initializing [ 0.430000] NetLabel: domain hash size = 128 [ 0.431009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.433072] NetLabel: unlabeled traffic allowed by default [ 0.435137] vgaarb: loaded [ 0.436260] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.437020] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.441190] clocksource: Switched to clocksource kvm-clock [ 0.543518] VFS: Disk quotas dquot_6.6.0 [ 0.544854] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.547152] *** VALIDATE ramfs *** [ 0.548249] *** VALIDATE hugetlbfs *** [ 0.549755] pnp: PnP ACPI init [ 0.551807] pnp: PnP ACPI: found 6 devices [ 0.567395] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.570337] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.572389] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.574230] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.576344] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.578566] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.581071] NET: Registered protocol family 2 [ 0.583084] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.588216] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.591803] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.595731] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.598683] TCP: Hash tables configured (established 65536 bind 65536) [ 0.601322] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.604348] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.607249] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.610346] NET: Registered protocol family 1 [ 0.612794] RPC: Registered named UNIX socket transport module. [ 0.614753] RPC: Registered udp transport module. [ 0.616480] RPC: Registered tcp transport module. [ 0.617879] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.620149] NET: Registered protocol family 44 [ 0.621557] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.623599] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.625509] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.627676] PCI: CLS 0 bytes, default 64 [ 0.629222] Unpacking initramfs... [ 2.122281] debug: unmapping init [mem 0xffff89d1fcc64000-0xffff89d1fffcffff] [ 2.126536] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.129143] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.132508] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.629210] Initialise system trusted keyrings [ 2.630831] Key type blacklist registered [ 2.632823] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.638808] zbud: loaded [ 2.641734] *** VALIDATE nfs *** [ 2.642748] *** VALIDATE nfs4 *** [ 2.643941] pstore: using deflate compression [ 2.647537] Platform Keyring initialized [ 2.761323] NET: Registered protocol family 38 [ 2.763725] Key type asymmetric registered [ 2.766184] Asymmetric key parser 'x509' registered [ 2.768516] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.772487] io scheduler mq-deadline registered [ 2.774484] io scheduler kyber registered [ 2.776769] io scheduler bfq registered [ 2.778749] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.782656] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.786630] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.791605] ACPI: Power Button [PWRF] [ 2.797600] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.804994] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.819622] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.852376] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.895371] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.899915] Non-volatile memory driver v1.3 [ 2.901914] Linux agpgart interface v0.103 [ 2.935971] virtio_blk virtio1: [vda] 150688 512-byte logical blocks (77.2 MB/73.6 MiB) [ 2.939429] vda: detected capacity change from 0 to 77152256 [ 2.958490] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.962398] vdb: detected capacity change from 0 to 1073741824 [ 2.971775] libphy: Fixed MDIO Bus: probed [ 2.978431] usbcore: registered new interface driver usbserial_generic [ 2.980590] usbserial: USB Serial support registered for generic [ 2.982123] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.985433] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.987218] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.989469] mousedev: PS/2 mouse device common for all mice [ 2.993355] rtc_cmos 00:05: RTC can wake from S4 [ 2.998496] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.000610] rtc_cmos 00:05: registered as rtc0 [ 3.003258] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.005679] intel_pstate: CPU model not supported [ 3.008711] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.010525] hid: raw HID events driver (C) Jiri Kosina [ 3.013726] usbcore: registered new interface driver usbhid [ 3.015853] usbhid: USB HID core driver [ 3.016190] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.016969] drop_monitor: Initializing network drop monitor service [ 3.021669] Initializing XFRM netlink socket [ 3.023720] NET: Registered protocol family 10 [ 3.026899] Segment Routing with IPv6 [ 3.028653] NET: Registered protocol family 17 [ 3.030882] mpls_gso: MPLS GSO support [ 3.035755] RAS: Correctable Errors collector initialized. [ 3.038082] AVX version of gcm_enc/dec engaged. [ 3.039881] AES CTR mode by8 optimization enabled [ 3.100256] sched_clock: Marking stable (3100225550, 0)->(4015774133, -915548583) [ 3.103298] registered taskstats version 1 [ 3.105239] Loading compiled-in X.509 certificates [ 3.107527] zswap: loaded using pool lzo/zbud [ 3.128714] Key type big_key registered [ 3.139328] Key type encrypted registered [ 3.140931] ima: No TPM chip found, activating TPM-bypass! [ 3.143023] ima: Allocated hash algorithm: sha1 [ 3.144558] ima: No architecture policies found [ 3.145924] evm: Initialising EVM extended attributes: [ 3.147900] evm: security.selinux [ 3.149219] evm: security.ima [ 3.149949] evm: security.capability [ 3.151084] evm: HMAC attrs: 0x1 [ 3.153065] rtc_cmos 00:05: setting system clock to 2026-09-30 12:54:30 UTC (1790772870) [ 3.158161] debug: unmapping init [mem 0xffffffff9ca03000-0xffffffff9cbfffff] [ 3.160967] debug: unmapping init [mem 0xffffffff9b782000-0xffffffff9ba58fff] [ 3.169131] Write protecting the kernel read-only data: 28672k [ 3.172254] debug: unmapping init [mem 0xffffffff99e03000-0xffffffff99ffffff] [ 3.174716] debug: unmapping init [mem 0xffffffff9a714000-0xffffffff9a7fffff] [ 3.204660] 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.213300] systemd[1]: Detected virtualization kvm. [ 3.215067] systemd[1]: Detected architecture x86-64. [ 3.216852] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.243140] systemd[1]: No hostname configured. [ 3.244604] systemd[1]: Set hostname to . [ 3.246306] random: systemd: uninitialized urandom read (16 bytes read) [ 3.248459] systemd[1]: Initializing machine ID from random generator. [ 3.368701] random: systemd: uninitialized urandom read (16 bytes read) [ 3.370330] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.373687] random: systemd: uninitialized urandom read (16 bytes read) [ 3.375082] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.377800] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... Starting Setup Virtual Console... Starting Journal Service... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Timers. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Sockets. [ OK ] Started Memstrack Anylazing Service. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Slices. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [[ 3.574776] random: fast init done  OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.962523] device-mapper: uevent: version 1.0.3 [ 3.965239] 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. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.898390] virtio_net virtio0 ens2: renamed from eth0 Starting dracut initqueue hook... [ 5.055285] scsi host0: ata_piix [ 5.089859] scsi host1: ata_piix [ 5.091753] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.094411] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.395959] dracut-initqueue[588]: RTNETLINK answers: File exists [ 9.655646] random: crng init done [ 9.657117] 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.112651] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ 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 Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev 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.356639] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.565168] SELinux: Disabled at runtime. [ 11.621680] 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.627274] systemd[1]: Detected virtualization kvm. [ 11.628401] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.058992] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.061090] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.064564] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.066748] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.068533] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.083705] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.092984] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... Mounting POSIX Message Queue File System... [ OK ] Created slice User and Session Slice. [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Started Forward Password Requests to Wall Directory Watch. [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... Starting Remount Root and Kernel File Systems... Mounting Kernel Debug File System... [ OK ] Reached target rpc_pipefs.target. [ OK ] Reached target Slices. Mounting Huge Pages File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-serial\x2dgetty.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Initrd Root File System. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK [0[ 12.284381] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS m] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ 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 udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 12.652109] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.949271] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.997518] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.080121] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.093083] EDAC sbridge: Ver: 1.1.2 [ 14.287472] Key type dns_resolver registered [ 14.602930] NFS: Registering the id_resolver key type [ 14.605390] Key type id_resolver registered [ 14.607148] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... [ 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 Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg245-client login: [ 54.899731] libcfs: loading out-of-tree module taints kernel. [ 55.251066] Key type ._llcrypt registered [ 55.253388] Key type .llcrypt registered [ 55.522738] hrtimer: interrupt took 3132351 ns [ 55.863276] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 55.875111] alg: No test for adler32 (adler32-zlib) [ 57.324818] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 58.571902] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 60.335263] Key type lgssc registered [ 62.585977] Lustre: Echo OBD driver; http://www.lustre.org/ [ 237.694198] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 242.914814] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 263.136190] Lustre: lustre-OST0000-osc-ffff89d247f17800: disconnect after 23s idle [ 263.284729] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing check_logdir /tmp/testlogs/ [ 268.754469] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing yml_node [ 273.300125] Lustre: DEBUG MARKER: Client: 2.17.59.4 [ 276.054576] Lustre: DEBUG MARKER: MDS: 2.17.59.4 [ 278.963948] Lustre: DEBUG MARKER: OSS: 2.17.59.4 [ 280.601809] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Sep 30 08:59:06 EDT 2026 [ 296.541854] Lustre: DEBUG MARKER: only running tests: 33-75 [ 297.699560] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 298.996807] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 301.120291] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 311.521452] Lustre: Unmounted lustre-client [ 444.043983] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 450.173942] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 474.355740] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 519.085095] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 09:03:05 (1790773385) [ 521.540375] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 523.120314] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 09:03:09 (1790773389) [ 559.184306] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 566.216668] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 590.141788] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 590.691417] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 595.945760] Lustre: Unmounted lustre-client [ 625.627914] Key type lgssc unregistered [ 625.982283] LNet: 15214:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 625.987467] LNetError: 15214:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 626.000976] LNet: Removed LNI 192.168.202.45@tcp [ 626.825192] Key type .llcrypt unregistered [ 626.827726] Key type ._llcrypt unregistered [ 643.824173] Key type ._llcrypt registered [ 643.825874] Key type .llcrypt registered [ 645.202406] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 09:05:10 (1790773510) [ 646.846117] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 646.856188] alg: No test for adler32 (adler32-zlib) [ 647.922392] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 648.126505] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 649.839499] Key type lgssc registered [ 651.374935] Lustre: Echo OBD driver; http://www.lustre.org/ [ 723.100737] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 808.739864] Lustre: Unmounted lustre-client [ 840.781239] Key type lgssc unregistered [ 841.237877] LNet: 19017:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 841.246156] LNetError: 19017:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 841.266722] LNet: Removed LNI 192.168.202.45@tcp [ 842.016490] Key type .llcrypt unregistered [ 842.020487] Key type ._llcrypt unregistered [ 853.470258] Key type ._llcrypt registered [ 853.472186] Key type .llcrypt registered [ 854.895519] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 09:08:40 (1790773720) [ 857.198164] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 857.278235] alg: No test for adler32 (adler32-zlib) [ 858.549490] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 858.745068] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 860.407384] Key type lgssc registered [ 861.893900] Lustre: Echo OBD driver; http://www.lustre.org/ [ 918.596873] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 925.392682] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 950.389325] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 952.273781] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 964.823837] Lustre: Unmounted lustre-client [ 995.472985] Key type lgssc unregistered [ 995.756799] LNet: 22646:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 995.767096] LNetError: 22646:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 995.782183] LNet: Removed LNI 192.168.202.45@tcp [ 996.520609] Key type .llcrypt unregistered [ 996.522374] Key type ._llcrypt unregistered [ 1009.260486] Key type ._llcrypt registered [ 1009.264040] Key type .llcrypt registered [ 1010.763718] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 09:11:16 (1790773876) [ 1013.809814] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1013.952197] alg: No test for adler32 (adler32-zlib) [ 1015.249894] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 1015.539502] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 1017.271407] Key type lgssc registered [ 1018.549686] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1069.704107] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1074.775503] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1096.105279] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1098.811855] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 1103.932570] Lustre: Unmounted lustre-client [ 1133.718953] Key type lgssc unregistered [ 1134.019649] LNet: 25852:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1134.028995] LNetError: 25852:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1135.082629] LNet: Removed LNI 192.168.202.45@tcp [ 1135.917985] Key type .llcrypt unregistered [ 1135.923039] Key type ._llcrypt unregistered [ 1150.660870] Key type ._llcrypt registered [ 1150.662684] Key type .llcrypt registered [ 1152.051301] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 09:13:37 (1790774017) [ 1154.715729] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1154.821365] alg: No test for adler32 (adler32-zlib) [ 1156.040395] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 1156.430971] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 1158.143273] Key type lgssc registered [ 1159.267788] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1209.649401] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1216.425187] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1237.504029] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1240.515994] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 1250.802632] Lustre: lustre-MDT0000-mdc-ffff89d25264a000: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1261.030453] Lustre: lustre-MDT0001-mdc-ffff89d25264a000: Connection to lustre-MDT0001 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1267.701047] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1272.295734] Lustre: 26834:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790774123/real 1790774123] req@0000000057ea36c5 x1877762661947520/t0(0) o400->MGC192.168.202.145@tcp@192.168.202.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1790774139 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1272.323572] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [ 1278.033179] Lustre: Unmounted lustre-client [ 1296.643452] Key type lgssc unregistered [ 1296.988989] LNet: 29536:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1297.001488] LNetError: 29536:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1297.043111] LNet: Removed LNI 192.168.202.45@tcp [ 1298.250870] Key type .llcrypt unregistered [ 1298.254699] Key type ._llcrypt unregistered [ 1318.885771] Key type ._llcrypt registered [ 1318.889022] Key type .llcrypt registered [ 1320.686095] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 09:16:26 (1790774186) [ 1323.684539] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1323.715108] alg: No test for adler32 (adler32-zlib) [ 1324.817555] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 1325.014256] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 1326.696142] Key type lgssc registered [ 1327.970636] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1384.425210] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1392.185491] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1413.584373] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1424.622822] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 1434.608074] Lustre: lustre-OST0000-osc-ffff89d248b42800: Connection to lustre-OST0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1438.741513] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1449.071065] Lustre: Unmounted lustre-client [ 1477.707841] Key type lgssc unregistered [ 1478.038437] LNet: 33162:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1478.044596] LNetError: 33162:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1478.080610] LNet: Removed LNI 192.168.202.45@tcp [ 1478.888249] Key type .llcrypt unregistered [ 1478.890149] Key type ._llcrypt unregistered [ 1496.860742] Key type ._llcrypt registered [ 1496.866783] Key type .llcrypt registered [ 1498.773219] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 09:19:24 (1790774364) [ 1501.122364] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1501.204823] alg: No test for adler32 (adler32-zlib) [ 1502.419526] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 1502.718850] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 1504.418233] Key type lgssc registered [ 1506.063381] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1566.525419] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1572.593024] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1593.869909] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1596.659471] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 1603.805835] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1606.986515] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1618.570995] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-30 9h21m24s [ 1621.649937] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1627.633358] Lustre: lustre-MDT0000-mdc-ffff89d25c813000: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1632.519723] LustreError: 36969:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff89d25c813000: can't stat MDS #0: rc = -19 [ 1634.193488] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1646.056237] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [ 1646.082601] Lustre: Evicted from MGS (at 192.168.202.145@tcp) after server handle changed from 0xe8b902869a61b755 to 0xe8b902869a61ba1f [ 1646.096284] Lustre: MGC192.168.202.145@tcp: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 1647.175524] LustreError: lustre-MDT0000-mdc-ffff89d25c813000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1647.223487] Lustre: lustre-MDT0000-mdc-ffff89d25c813000: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 1651.879919] Lustre: DEBUG MARKER: Wait for df (36969) ... [ 1653.521498] Lustre: DEBUG MARKER: done [ 1655.490873] Lustre: Unmounted lustre-client [ 1684.933563] Key type lgssc unregistered [ 1685.246730] LNet: 37983:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1685.280308] LNetError: 37983:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1685.310554] LNet: Removed LNI 192.168.202.45@tcp [ 1686.113804] Key type .llcrypt unregistered [ 1686.119199] Key type ._llcrypt unregistered [ 1724.186637] Key type ._llcrypt registered [ 1724.190489] Key type .llcrypt registered [ 1725.683476] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 09:23:11 (1790774591) [ 1729.607924] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1729.669873] alg: No test for adler32 (adler32-zlib) [ 1730.945871] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 1731.292807] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 1733.031629] Key type lgssc registered [ 1734.674772] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1792.368701] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1797.959621] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1822.213511] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1825.015765] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 1829.927319] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-30 9h24m55s [ 1831.557983] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1839.502095] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1842.411792] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1863.136178] Lustre: 42147:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790774710/real 1790774710] req@000000009ade14a6 x1877763264879360/t0(0) o101->lustre-MDT0000-mdc-ffff89d255983000@192.168.202.145@tcp:12/10 lens 576/1152 e 0 to 1 dl 1790774730 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1863.160664] Lustre: lustre-MDT0000-mdc-ffff89d255983000: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1863.208798] Lustre: lustre-MDT0000-mdc-ffff89d255983000: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 1884.987727] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1889.099921] Lustre: DEBUG MARKER: done [ 1893.764486] Lustre: Unmounted lustre-client [ 1923.825399] Key type lgssc unregistered [ 1924.166951] LNet: 43024:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1924.179721] LNetError: 43024:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1924.191397] LNet: Removed LNI 192.168.202.45@tcp [ 1925.078566] Key type .llcrypt unregistered [ 1925.080898] Key type ._llcrypt unregistered [ 1960.432518] Key type ._llcrypt registered [ 1960.434197] Key type .llcrypt registered [ 1961.851993] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 09:27:07 (1790774827) [ 1964.122203] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1966.295220] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 09:27:11 (1790774831) [ 1970.759156] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1970.776704] alg: No test for adler32 (adler32-zlib) [ 1971.907479] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 1972.120420] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 1973.847317] Key type lgssc registered [ 1975.289694] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2003.025590] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 09:27:49 (1790774869) [ 2042.892677] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2049.863733] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2075.649182] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2078.800058] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 2082.388254] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2086.959485] Lustre: Unmounted lustre-client [ 2111.042851] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2162.642381] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2168.979843] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2169.745121] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 2174.280682] Lustre: Unmounted lustre-client [ 2240.537625] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2246.238343] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2246.608373] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 2250.654916] Lustre: Unmounted lustre-client [ 2276.235807] Lustre: DEBUG MARKER: files compared the same [ 2300.145310] Key type lgssc unregistered [ 2300.406428] LNet: 50670:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2300.411324] LNetError: 50670:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2300.426307] LNet: Removed LNI 192.168.202.45@tcp [ 2301.319825] Key type .llcrypt unregistered [ 2301.322113] Key type ._llcrypt unregistered [ 2320.932184] Key type ._llcrypt registered [ 2320.934778] Key type .llcrypt registered [ 2322.685022] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 09:33:08 (1790775188) [ 2326.525659] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2326.547773] alg: No test for adler32 (adler32-zlib) [ 2327.813456] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 2328.206415] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 2329.944446] Key type lgssc registered [ 2332.254846] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2391.817784] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2398.278897] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2420.291690] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2423.049219] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 2427.608163] Lustre: Unmounted lustre-client [ 2465.467879] Key type lgssc unregistered [ 2465.876755] LNet: 54281:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2465.888243] LNetError: 54281:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2465.903498] LNet: Removed LNI 192.168.202.45@tcp [ 2466.911211] Key type .llcrypt unregistered [ 2466.913356] Key type ._llcrypt unregistered [ 2483.234433] Key type ._llcrypt registered [ 2483.235972] Key type .llcrypt registered [ 2484.766804] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 09:35:50 (1790775350) [ 2487.035160] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2487.049727] alg: No test for adler32 (adler32-zlib) [ 2488.187766] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 2488.476846] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 2490.111766] Key type lgssc registered [ 2491.018988] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2581.306909] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2628.132693] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2637.580552] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2683.045994] Key type lgssc unregistered [ 2683.386146] LNet: 57792:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2683.393643] LNetError: 57792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2683.414219] LNet: Removed LNI 192.168.202.45@tcp [ 2684.250822] Key type .llcrypt unregistered [ 2684.252886] Key type ._llcrypt unregistered [ 2703.285746] Key type ._llcrypt registered [ 2703.289896] Key type .llcrypt registered [ 2704.982485] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 09:39:30 (1790775570) [ 2708.676950] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2708.693588] alg: No test for adler32 (adler32-zlib) [ 2710.190452] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 2710.498571] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 2712.186904] Key type lgssc registered [ 2713.918287] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2800.094673] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 2808.682730] Lustre: Unmounted lustre-client [ 2857.973037] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 09:42:03 (1790775723) [ 2981.639866] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3005.023715] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3012.433734] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3012.441565] LustreError: 64292:0:(file.c:252:ll_close_inode_openhandle()) lustre-clilmv-ffff89d2501ea800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3012.466415] Lustre: 58785:0:(llite_lib.c:4343:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.145@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3022.867199] Lustre: Unmounted lustre-client [ 3070.231263] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 09:45:35 (1790775935) [ 3082.993307] Key type lgssc unregistered [ 3083.346084] LNet: 65505:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3083.359252] LNetError: 65505:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3083.381856] LNet: Removed LNI 192.168.202.45@tcp [ 3084.227283] Key type .llcrypt unregistered [ 3084.230118] Key type ._llcrypt unregistered [ 3098.928132] Key type ._llcrypt registered [ 3098.929675] Key type .llcrypt registered [ 3099.525290] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3099.549693] alg: No test for adler32 (adler32-zlib) [ 3100.718863] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 3101.038881] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 3102.727639] Key type lgssc registered [ 3104.164368] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3156.060543] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3162.042753] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3183.080037] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3184.783337] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3188.510279] Lustre: Unmounted lustre-client [ 3225.250099] Key type lgssc unregistered [ 3225.460570] LNet: 68537:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3225.464895] LNetError: 68537:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3226.535060] LNet: Removed LNI 192.168.202.45@tcp [ 3227.105737] Key type .llcrypt unregistered [ 3227.108428] Key type ._llcrypt unregistered [ 3237.553515] Key type ._llcrypt registered [ 3237.557821] Key type .llcrypt registered [ 3237.876883] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3237.886802] alg: No test for adler32 (adler32-zlib) [ 3238.843869] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 3239.013957] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 3240.623399] Key type lgssc registered [ 3242.141299] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3350.919510] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3357.182854] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3381.049705] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3382.674643] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3385.758592] Lustre: Unmounted lustre-client [ 3412.244486] Key type lgssc unregistered [ 3412.427830] LNet: 71982:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3412.431493] LNetError: 71982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3412.446389] LNet: Removed LNI 192.168.202.45@tcp [ 3413.047470] Key type .llcrypt unregistered [ 3413.050155] Key type ._llcrypt unregistered [ 3429.528393] Key type ._llcrypt registered [ 3429.536595] Key type .llcrypt registered [ 3430.803797] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 09:51:36 (1790776296) [ 3433.705908] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3433.794457] alg: No test for adler32 (adler32-zlib) [ 3434.966943] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 3435.307931] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 3437.033312] Key type lgssc registered [ 3438.513695] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3491.395766] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3497.229771] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3519.887501] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3522.549887] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3527.807432] Lustre: Unmounted lustre-client [ 3528.193634] LustreError: 72946:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 3528.226939] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3530.634709] Lustre: Unmounted lustre-client [ 3569.582272] Key type lgssc unregistered [ 3569.907590] LNet: 75686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3569.914381] LNetError: 75686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3569.931625] LNet: Removed LNI 192.168.202.45@tcp [ 3570.538697] Key type .llcrypt unregistered [ 3570.541774] Key type ._llcrypt unregistered [ 3583.532860] Key type ._llcrypt registered [ 3583.534145] Key type .llcrypt registered [ 3583.926922] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3583.942147] alg: No test for adler32 (adler32-zlib) [ 3585.221580] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 3585.465287] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 3587.207249] Key type lgssc registered [ 3588.761085] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3644.694195] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3651.394053] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3674.992616] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3686.947879] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3691.169858] Lustre: Unmounted lustre-client [ 3719.801223] Key type lgssc unregistered [ 3720.072287] LNet: 78736:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3720.079424] LNetError: 78736:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3720.102458] LNet: Removed LNI 192.168.202.45@tcp [ 3720.843882] Key type .llcrypt unregistered [ 3720.845509] Key type ._llcrypt unregistered [ 3736.965093] Key type ._llcrypt registered [ 3736.966816] Key type .llcrypt registered [ 3738.420666] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 09:56:44 (1790776604) [ 3740.739085] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3740.782584] alg: No test for adler32 (adler32-zlib) [ 3741.966339] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 3742.165636] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 3743.903601] Key type lgssc registered [ 3745.357074] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3796.983498] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3804.774272] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3832.151876] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3833.962795] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 3842.019449] Lustre: lustre: root_squash is set to 0:0 [ 3851.306506] Lustre: lustre: nosquash_nids is cleared [ 3851.338242] Lustre: lustre: root_squash is set to 500:500 [ 3869.754478] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.45@tcp 192.168.0.[2,10]@tcp [ 3882.539623] Lustre: lustre: nosquash_nids set to 192.168.202.45/24@tcp [ 3886.773420] Lustre: Unmounted lustre-client [ 3920.802981] Key type lgssc unregistered [ 3921.083755] LNet: 82754:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3921.091288] LNetError: 82754:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3921.129299] LNet: Removed LNI 192.168.202.45@tcp [ 3922.012303] Key type .llcrypt unregistered [ 3922.014141] Key type ._llcrypt unregistered [ 3940.066205] Key type ._llcrypt registered [ 3940.069757] Key type .llcrypt registered [ 3941.612518] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 10:00:07 (1790776807) [ 3944.709934] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3946.765615] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 10:00:12 (1790776812) [ 3949.849071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3950.044108] alg: No test for adler32 (adler32-zlib) [ 3951.353688] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 3951.734742] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 3953.584501] Key type lgssc registered [ 3955.587510] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4014.113847] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4020.328919] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4045.120154] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4045.763071] Lustre: lustre: root_squash is set to 500:500 [ 4045.782601] Lustre: lustre: nosquash_nids set to 192.168.202.45/24@tcp [ 4046.920346] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 4053.964387] Lustre: Unmounted lustre-client [ 4083.739494] Key type lgssc unregistered [ 4084.138917] LNet: 86741:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4084.151813] LNetError: 86741:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4085.225995] LNet: Removed LNI 192.168.202.45@tcp [ 4086.691416] Key type .llcrypt unregistered [ 4086.705295] Key type ._llcrypt unregistered [ 4105.775785] Key type ._llcrypt registered [ 4105.778432] Key type .llcrypt registered [ 4106.918547] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4109.029569] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 10:02:54 (1790776974) [ 4130.296869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4130.338647] alg: No test for adler32 (adler32-zlib) [ 4131.723425] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 4132.162928] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 4134.007283] Key type lgssc registered [ 4136.038345] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4227.702904] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4233.381225] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4260.796401] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4337.648726] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4344.421850] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4369.239440] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4383.266222] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 4417.648956] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff89d243569000.ost_server_uuid 50 [ 4420.050117] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff89d243569000.ost_server_uuid in IDLE state after 0 sec [ 4420.999683] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 4424.592336] Lustre: Unmounted lustre-client [ 4427.401170] Lustre: Unmounted lustre-client [ 4476.412169] Key type lgssc unregistered [ 4476.644986] LNet: 94423:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4476.651373] LNetError: 94423:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4476.668511] LNet: Removed LNI 192.168.202.45@tcp [ 4477.521922] Key type .llcrypt unregistered [ 4477.524773] Key type ._llcrypt unregistered [ 4511.772909] Key type ._llcrypt registered [ 4511.775863] Key type .llcrypt registered [ 4513.470837] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 10:09:38 (1790777378) [ 4532.921282] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4532.966150] alg: No test for adler32 (adler32-zlib) [ 4534.049322] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 4534.453922] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 4536.199293] Key type lgssc registered [ 4537.567497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4625.790792] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4632.589985] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4661.003225] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4663.032577] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 4668.393425] Lustre: lustre-OST0000-osc-ffff89d243924800: Connection to lustre-OST0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4703.212156] Lustre: lustre-MDT0000-mdc-ffff89d243924800: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4719.585129] Lustre: 95802:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790777570/real 1790777570] req@00000000d5bae554 x1877766204039424/t0(0) o400->MGC192.168.202.145@tcp@192.168.202.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1790777586 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4719.623274] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [ 4727.012445] Lustre: lustre-MDT0000-mdc-ffff89d243924800: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 4729.078950] Lustre: Evicted from MGS (at 192.168.202.145@tcp) after server handle changed from 0x9c710e99419aee8e to 0x9c710e99419af207 [ 4729.117855] Lustre: MGC192.168.202.145@tcp: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 4729.132850] Lustre: Skipped 1 previous similar message [ 4734.173602] Lustre: Unmounted lustre-client [ 4764.759972] Key type lgssc unregistered [ 4765.223688] LNet: 100108:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4765.231388] LNetError: 100108:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4765.259399] LNet: Removed LNI 192.168.202.45@tcp [ 4766.190667] Key type .llcrypt unregistered [ 4766.194587] Key type ._llcrypt unregistered [ 4785.530372] Key type ._llcrypt registered [ 4785.532516] Key type .llcrypt registered [ 4786.985436] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 10:14:12 (1790777652) [ 4802.512317] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4802.701139] alg: No test for adler32 (adler32-zlib) [ 4803.833671] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 4804.117308] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 4805.848054] Key type lgssc registered [ 4807.431604] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4850.746258] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4954.413773] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4959.938819] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4985.113911] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4987.950487] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 4989.903318] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4991.533522] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 10:17:37 (1790777857) [ 5200.731521] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5211.067290] Lustre: Unmounted lustre-client [ 5329.494238] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5335.784325] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5361.696950] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5404.548885] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:24:30 (1790778270) [ 5500.345510] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5506.553296] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5529.585290] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5530.228870] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 5534.994836] Lustre: Unmounted lustre-client [ 5566.801313] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:27:12 (1790778432) [ 5661.686230] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5668.582507] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5694.223750] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5694.679079] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 5700.387171] Lustre: Unmounted lustre-client [ 5727.184423] Key type lgssc unregistered [ 5727.491704] LNet: 123132:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5727.498118] LNetError: 123132:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5727.532358] LNet: Removed LNI 192.168.202.45@tcp [ 5728.177317] Key type .llcrypt unregistered [ 5728.180932] Key type ._llcrypt unregistered [ 5742.636347] Key type ._llcrypt registered [ 5742.639818] Key type .llcrypt registered [ 5744.199811] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 10:30:09 (1790778609) [ 5747.669392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5747.692790] alg: No test for adler32 (adler32-zlib) [ 5748.982063] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 5749.464392] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 5751.305745] Key type lgssc registered [ 5753.132530] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5807.617215] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5813.480236] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5838.024688] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5839.622650] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 5853.623824] Lustre: Unmounted lustre-client [ 5882.501408] Key type lgssc unregistered [ 5882.864377] LNet: 126740:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5882.884302] LNetError: 126740:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5883.955773] LNet: Removed LNI 192.168.202.45@tcp [ 5884.763993] Key type .llcrypt unregistered [ 5884.766493] Key type ._llcrypt unregistered [ 5901.745622] Key type ._llcrypt registered [ 5901.747446] Key type .llcrypt registered [ 5903.034935] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 10:32:48 (1790778768) [ 5905.780780] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5906.055853] alg: No test for adler32 (adler32-zlib) [ 5907.242739] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 5907.468278] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 5909.159266] Key type lgssc registered [ 5910.612283] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5960.519938] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5966.504805] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5987.847033] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5990.794701] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 6001.128868] Lustre: lustre-OST0000-osc-ffff89d252648800: Connection to lustre-OST0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6011.677184] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff89d252648800.ost_server_uuid 50 [ 6013.373144] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6024.949052] Lustre: Unmounted lustre-client [ 6044.851614] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 10:35:10 (1790778910) [ 6085.306914] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6090.738819] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6111.336252] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6133.503025] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6133.998748] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 6139.397287] Lustre: lustre-OST0000-osc-ffff89d2501ea000: Connection to lustre-OST0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6167.536906] Lustre: Unmounted lustre-client [ 6223.134871] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 10:38:09 (1790779089) [ 6262.248601] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6268.298940] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6290.807272] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6311.167100] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6311.784174] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 6317.035427] Lustre: lustre-OST0000-osc-ffff89d242d29000: Connection to lustre-OST0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6332.056520] Lustre: Unmounted lustre-client [ 6377.153640] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 10:40:43 (1790779243) [ 6463.931485] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6470.955770] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6496.013842] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6581.358046] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6586.991574] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6607.691250] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6638.935780] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 6680.250720] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6687.235189] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 5 sec [ 6689.570042] Lustre: Unmounted lustre-client [ 6726.480268] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 10:46:32 (1790779592) [ 6757.156728] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6763.875684] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6790.827948] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6824.457630] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6852.177656] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 6894.071592] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6895.889914] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6898.169878] Lustre: lustre-OST0001-osc-ffff89d2435d7800: Connection to lustre-OST0001 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6907.974085] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6918.347643] Lustre: Unmounted lustre-client [ 6972.113553] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 10:50:38 (1790779838) [ 7006.378454] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7011.941327] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7034.866702] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7035.590938] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 7059.342591] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7060.949147] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7075.855778] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff89d248b40000.ost_server_uuid 50 [ 7077.412623] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff89d248b40000.ost_server_uuid in IDLE state after 0 sec [ 7080.674584] Lustre: Unmounted lustre-client [ 7080.960360] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7080.969686] Lustre: Skipped 3 previous similar messages [ 7081.063418] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 7081.991637] LustreError: 150218:0:(sec.c:409:import_sec_validate_get()) import 0000000058c421f3 (NEW) with no sec [ 7151.566391] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 10:53:37 (1790780017) [ 7188.152951] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7193.600506] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7218.628860] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7241.192077] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7241.625405] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7241.789207] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 7254.246526] Lustre: Unmounted lustre-client [ 7254.249403] Lustre: Skipped 1 previous similar message [ 7313.665552] Key type lgssc unregistered [ 7313.952787] LNet: 153640:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7313.962973] LNetError: 153640:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7315.013197] LNet: Removed LNI 192.168.202.45@tcp [ 7315.815116] Key type .llcrypt unregistered [ 7315.819210] Key type ._llcrypt unregistered [ 7332.778817] Key type ._llcrypt registered [ 7332.781087] Key type .llcrypt registered [ 7334.019794] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 10:56:40 (1790780200) [ 7335.379199] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7335.415395] alg: No test for adler32 (adler32-zlib) [ 7336.687995] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 7336.887333] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 7338.551749] Key type lgssc registered [ 7339.957768] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7396.516212] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7402.353318] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7422.470724] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7447.104955] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7448.536713] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7449.702951] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 7456.827793] LustreError: lustre-MDT0001-mdc-ffff89d242d29800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7456.908381] Lustre: lustre-MDT0001-mdc-ffff89d242d29800: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 7464.889859] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7467.030196] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7489.550284] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7493.631393] Lustre: Unmounted lustre-client [ 7516.967389] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 10:59:42 (1790780382) [ 7619.693798] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7625.536742] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7648.714775] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7649.548701] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 7676.938237] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7679.066159] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7691.946788] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7702.410986] Lustre: Unmounted lustre-client [ 7746.081696] Key type lgssc unregistered [ 7746.318435] LNet: 163291:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7746.325582] LNetError: 163291:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7746.338768] LNet: Removed LNI 192.168.202.45@tcp [ 7747.050862] Key type .llcrypt unregistered [ 7747.053037] Key type ._llcrypt unregistered [ 7779.501547] Key type ._llcrypt registered [ 7779.503023] Key type .llcrypt registered [ 7781.156386] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 11:04:06 (1790780646) [ 7783.950158] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7783.987115] alg: No test for adler32 (adler32-zlib) [ 7785.233541] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 7785.405641] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 7787.047462] Key type lgssc registered [ 7788.870422] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7847.739608] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7853.875472] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7880.288264] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7883.095735] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 7930.395884] Lustre: Unmounted lustre-client [ 7973.638570] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7974.475207] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 8011.077689] Lustre: Unmounted lustre-client [ 8040.689629] Key type lgssc unregistered [ 8041.003040] LNet: 167757:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8041.016837] LNetError: 167757:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8041.033878] LNet: Removed LNI 192.168.202.45@tcp [ 8042.011163] Key type .llcrypt unregistered [ 8042.016701] Key type ._llcrypt unregistered [ 8060.854067] Key type ._llcrypt registered [ 8060.856066] Key type .llcrypt registered [ 8062.410293] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 11:08:48 (1790780928) [ 8065.579852] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8065.594885] alg: No test for adler32 (adler32-zlib) [ 8066.676516] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 8066.955805] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 8068.631274] Key type lgssc registered [ 8069.974820] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8124.194817] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8130.818694] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8152.234862] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8155.016750] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 8179.066759] Lustre: Unmounted lustre-client [ 8205.882254] Key type lgssc unregistered [ 8206.183344] LNet: 171526:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8206.187232] LNetError: 171526:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8207.220210] LNet: Removed LNI 192.168.202.45@tcp [ 8208.274644] Key type .llcrypt unregistered [ 8208.290530] Key type ._llcrypt unregistered [ 8222.979146] Key type ._llcrypt registered [ 8222.980814] Key type .llcrypt registered [ 8223.187913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8223.214580] alg: No test for adler32 (adler32-zlib) [ 8224.482737] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 8224.782117] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 8226.632323] Key type lgssc registered [ 8228.178785] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8281.985904] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8287.758631] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8308.789543] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8310.784119] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 8319.617615] Lustre: Unmounted lustre-client [ 8348.592404] Key type lgssc unregistered [ 8349.005835] LNet: 174603:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8349.019811] LNetError: 174603:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8349.054877] LNet: Removed LNI 192.168.202.45@tcp [ 8350.151447] Key type .llcrypt unregistered [ 8350.153942] Key type ._llcrypt unregistered [ 8368.823574] Key type ._llcrypt registered [ 8368.825324] Key type .llcrypt registered [ 8370.411414] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:13:55 (1790781235) [ 8372.291822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8372.340209] alg: No test for adler32 (adler32-zlib) [ 8373.380738] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 8373.649597] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 8375.354717] Key type lgssc registered [ 8377.559518] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8439.116801] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8445.535492] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8469.359680] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8481.363442] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 8502.180298] Lustre: Unmounted lustre-client [ 8530.884363] Key type lgssc unregistered [ 8531.119537] LNet: 178374:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8531.127832] LNetError: 178374:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8531.157067] LNet: Removed LNI 192.168.202.45@tcp [ 8531.859881] Key type .llcrypt unregistered [ 8531.864919] Key type ._llcrypt unregistered [ 8547.029920] Key type ._llcrypt registered [ 8547.037926] Key type .llcrypt registered [ 8547.599402] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8547.618623] alg: No test for adler32 (adler32-zlib) [ 8548.856111] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 8549.221525] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 8550.967277] Key type lgssc registered [ 8552.562930] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8611.772731] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8617.698263] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8640.176932] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8642.136527] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 8654.179025] Lustre: Unmounted lustre-client [ 8685.368565] Key type lgssc unregistered [ 8685.730838] LNet: 181453:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8685.735199] LNetError: 181453:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8685.751646] LNet: Removed LNI 192.168.202.45@tcp [ 8686.341565] Key type .llcrypt unregistered [ 8686.344208] Key type ._llcrypt unregistered [ 8706.485641] Key type ._llcrypt registered [ 8706.488208] Key type .llcrypt registered [ 8708.082623] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:19:33 (1790781573) [ 8734.816219] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8734.908668] alg: No test for adler32 (adler32-zlib) [ 8736.144327] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 8736.478975] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 8738.311281] Key type lgssc registered [ 8740.053479] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8835.991786] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8843.794374] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8870.822505] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8926.630374] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:23:12 (1790781792) [ 8965.892950] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8972.226661] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8998.374858] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9004.163393] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 9009.511495] Lustre: Unmounted lustre-client [ 9037.523757] Key type lgssc unregistered [ 9037.882072] LNet: 188575:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9037.894456] LNetError: 188575:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9038.956547] LNet: Removed LNI 192.168.202.45@tcp [ 9040.024119] Key type .llcrypt unregistered [ 9040.026530] Key type ._llcrypt unregistered [ 9059.345634] Key type ._llcrypt registered [ 9059.348774] Key type .llcrypt registered [ 9060.963462] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9062.960861] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:25:28 (1790781928) [ 9082.571620] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9082.600445] alg: No test for adler32 (adler32-zlib) [ 9083.823467] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 9084.230665] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 9085.968963] Key type lgssc registered [ 9087.415316] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9190.593394] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9197.681918] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9224.619800] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9249.878789] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9252.568971] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 9277.883823] Lustre: Unmounted lustre-client [ 9433.209788] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9439.394169] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9463.576880] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9512.659971] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 11:32:58 (1790782378) [ 9514.167904] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9515.995909] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 11:33:02 (1790782382) [ 9626.436526] Key type lgssc unregistered [ 9626.715193] LNet: 200039:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9626.720849] LNetError: 200039:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9626.738640] LNet: Removed LNI 192.168.202.45@tcp [ 9627.450313] Key type .llcrypt unregistered [ 9627.455163] Key type ._llcrypt unregistered [ 9644.759536] Key type ._llcrypt registered [ 9644.761232] Key type .llcrypt registered [ 9646.441672] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 11:35:11 (1790782511) [ 9690.970112] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9691.004929] alg: No test for adler32 (adler32-zlib) [ 9692.088075] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 9692.375320] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 9694.031339] Key type lgssc registered [ 9695.396601] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9742.862640] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9748.583773] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9785.054663] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9814.489878] Key type lgssc unregistered [ 9814.707627] LNet: 203786:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9814.720682] LNetError: 203786:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9814.743927] LNet: Removed LNI 192.168.202.45@tcp [ 9815.263790] Key type .llcrypt unregistered [ 9815.267815] Key type ._llcrypt unregistered [ 9832.684250] Key type ._llcrypt registered [ 9832.686553] Key type .llcrypt registered [ 9834.203420] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 11:38:19 (1790782699) [ 9837.323130] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9837.338484] alg: No test for adler32 (adler32-zlib) [ 9838.420104] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [ 9838.716197] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [ 9840.425235] Key type lgssc registered [ 9842.066596] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9893.186347] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9899.155402] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9922.380599] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9924.133190] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [ 9939.448196] Lustre: lustre-MDT0000-mdc-ffff89d251a29000: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9949.684339] Lustre: lustre-MDT0001-mdc-ffff89d251a29000: Connection to lustre-MDT0001 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9959.903154] Lustre: 204786:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790782811/real 1790782811] req@000000007f74d994 x1877771766809216/t0(0) o400->MGC192.168.202.145@tcp@192.168.202.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1790782827 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9959.953668] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [ 9985.518438] Lustre: Evicted from MGS (at 192.168.202.145@tcp) after server handle changed from 0x21acb1ba08b83012 to 0x21acb1ba08b84c12 [ 9985.560410] Lustre: MGC192.168.202.145@tcp: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [ 9992.180737] Lustre: 206914:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.202.145@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [10015.221687] LustreError: lustre-MDT0000-mdc-ffff89d251a29000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10015.278576] Lustre: lustre-MDT0000-mdc-ffff89d251a29000: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [10018.361032] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10019.821440] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10025.783346] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10027.539260] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10031.263247] Lustre: Unmounted lustre-client [10059.340351] Key type lgssc unregistered [10059.614982] LNet: 208748:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10059.618605] LNetError: 208748:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10059.640405] LNet: Removed LNI 192.168.202.45@tcp [10060.478437] Key type .llcrypt unregistered [10060.482075] Key type ._llcrypt unregistered [10077.373487] Key type ._llcrypt registered [10077.376293] Key type .llcrypt registered [10079.197874] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 11:42:24 (1790782944) [10081.670507] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10081.824155] alg: No test for adler32 (adler32-zlib) [10082.960906] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [10083.319989] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [10084.999638] Key type lgssc registered [10086.193199] Lustre: Echo OBD driver; http://www.lustre.org/ [10138.345646] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10143.888429] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10201.629858] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10207.799839] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10246.988924] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10266.915322] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10305.631417] Key type lgssc unregistered [10305.928047] LNet: 214057:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10305.954670] LNetError: 214057:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10306.009373] LNet: Removed LNI 192.168.202.45@tcp [10306.572739] Key type .llcrypt unregistered [10306.575168] Key type ._llcrypt unregistered [10352.440046] Key type ._llcrypt registered [10352.441860] Key type .llcrypt registered [10353.826792] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 11:46:59 (1790783219) [10396.150317] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10396.405189] alg: No test for adler32 (adler32-zlib) [10397.784047] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [10398.082267] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [10399.785886] Key type lgssc registered [10401.787732] Lustre: Echo OBD driver; http://www.lustre.org/ [10493.847213] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10500.431429] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10526.433166] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10575.378988] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 11:50:41 (1790783441) [10582.406762] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 11:50:48 (1790783448) [10625.540537] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10630.569279] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10652.553852] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10654.251725] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [10662.985674] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10664.492940] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10666.247792] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10667.681965] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10674.664925] Lustre: lustre-MDT0000-mdc-ffff89d2441a2800: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [10690.024025] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [10690.038587] Lustre: Evicted from MGS (at 192.168.202.145@tcp) after server handle changed from 0xbb408a6f51a7c007 to 0xbb408a6f51a7c181 [10690.057361] Lustre: MGC192.168.202.145@tcp: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [10696.702103] Lustre: 221969:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.202.145@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [10705.691931] Lustre: lustre-MDT0000-mdc-ffff89d2441a2800: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [10719.662682] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10722.088257] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10725.985400] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10728.953881] Lustre: lustre-MDT0000-mdc-ffff89d2441a2800: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [10745.311764] Lustre: 215957:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790783596/real 1790783596] req@000000006287ae54 x1877772352900992/t0(0) o400->MGC192.168.202.145@tcp@192.168.202.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1790783612 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10745.339138] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [10755.575970] Lustre: Evicted from MGS (at 192.168.202.145@tcp) after server handle changed from 0xbb408a6f51a7c181 to 0xbb408a6f51a7c498 [10755.594743] Lustre: MGC192.168.202.145@tcp: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [10763.509654] Lustre: lustre-MDT0000-mdc-ffff89d2441a2800: Connection restored to 192.168.202.145@tcp (at 192.168.202.145@tcp) [10772.086728] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10773.382667] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10777.478053] Lustre: Unmounted lustre-client [10852.975993] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10859.847307] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10881.956714] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10882.723674] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [10890.113467] Lustre: Unmounted lustre-client [10917.156881] Key type lgssc unregistered [10917.372791] LNet: 226559:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10917.379647] LNetError: 226559:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10917.394031] LNet: Removed LNI 192.168.202.45@tcp [10917.969223] Key type .llcrypt unregistered [10917.971340] Key type ._llcrypt unregistered [10933.657703] Key type ._llcrypt registered [10933.659781] Key type .llcrypt registered [10934.885496] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 11:56:40 (1790783800) [10939.049699] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10939.296990] alg: No test for adler32 (adler32-zlib) [10940.436989] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [10940.642119] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [10942.311369] Key type lgssc registered [10943.685463] Lustre: Echo OBD driver; http://www.lustre.org/ [10997.387428] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11004.106669] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11026.817023] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11029.556809] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [11036.558688] Lustre: Unmounted lustre-client [11110.286131] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11116.640249] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11138.443477] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11139.060508] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [11148.681603] Lustre: Unmounted lustre-client [11223.070599] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11229.761033] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11253.221610] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11264.577271] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [11266.614231] Lustre: Unmounted lustre-client [11295.627930] Key type lgssc unregistered [11295.861559] LNet: 233642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11295.865646] LNetError: 233642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11295.880467] LNet: Removed LNI 192.168.202.45@tcp [11296.516418] Key type .llcrypt unregistered [11296.519412] Key type ._llcrypt unregistered [11312.647962] Key type ._llcrypt registered [11312.650442] Key type .llcrypt registered [11313.696318] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 12:02:59 (1790784179) [11317.150802] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11317.170158] alg: No test for adler32 (adler32-zlib) [11318.299906] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [11318.649175] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [11320.399207] Key type lgssc registered [11321.978801] Lustre: Echo OBD driver; http://www.lustre.org/ [11377.324669] Key type lgssc unregistered [11377.659987] LNet: 235980:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11377.676156] LNetError: 235980:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11377.721922] LNet: Removed LNI 192.168.202.45@tcp [11378.916614] Key type .llcrypt unregistered [11378.918909] Key type ._llcrypt unregistered [11418.068775] Key type ._llcrypt registered [11418.075460] Key type .llcrypt registered [11418.774463] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11418.814859] alg: No test for adler32 (adler32-zlib) [11420.087477] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [11420.529129] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [11422.353290] Key type lgssc registered [11424.273416] Lustre: Echo OBD driver; http://www.lustre.org/ [11529.139365] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11536.359142] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11563.060422] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11619.359208] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11621.311391] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 12:08:07 (1790784487) [11656.564814] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11663.120161] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11689.730284] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11717.652305] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11719.379676] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [11724.780977] Lustre: lustre-OST0001-osc-ffff89d244866000: Connection to lustre-OST0001 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [11731.780691] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11742.217916] Lustre: Unmounted lustre-client [11780.233212] Key type lgssc unregistered [11780.538136] LNet: 243122:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11780.543247] LNetError: 243122:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11780.560452] LNet: Removed LNI 192.168.202.45@tcp [11781.274673] Key type .llcrypt unregistered [11781.277187] Key type ._llcrypt unregistered [11817.178536] Key type ._llcrypt registered [11817.180127] Key type .llcrypt registered [11818.903098] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 12:11:24 (1790784684) [11833.753067] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11833.769385] alg: No test for adler32 (adler32-zlib) [11834.922958] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [11835.150353] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [11836.833525] Key type lgssc registered [11838.256446] Lustre: Echo OBD driver; http://www.lustre.org/ [11896.238475] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11902.635446] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11926.543036] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 12:13:12 (1790784792) [11962.174293] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11969.301287] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11992.345824] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11995.025210] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [12008.454873] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12011.184527] Lustre: Unmounted lustre-client [12115.050626] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12121.655529] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12175.625847] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12176.378863] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [12178.349989] Lustre: Unmounted lustre-client [12206.775642] Key type lgssc unregistered [12207.074278] LNet: 250831:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12207.087923] LNetError: 250831:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12207.114437] LNet: Removed LNI 192.168.202.45@tcp [12207.917749] Key type .llcrypt unregistered [12207.919486] Key type ._llcrypt unregistered [12242.343226] Key type ._llcrypt registered [12242.348981] Key type .llcrypt registered [12243.005573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12243.017242] alg: No test for adler32 (adler32-zlib) [12244.404064] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [12244.869453] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [12246.776737] Key type lgssc registered [12248.414683] Lustre: Echo OBD driver; http://www.lustre.org/ [12335.595704] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12341.718980] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12366.699568] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12411.905615] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12414.282336] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 12:21:19 (1790785279) [12451.125354] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12456.718282] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12481.737563] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12486.579966] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [12490.679963] Lustre: Unmounted lustre-client [12518.650600] Key type lgssc unregistered [12518.978107] LNet: 257488:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12518.995122] LNetError: 257488:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12519.027165] LNet: Removed LNI 192.168.202.45@tcp [12520.077844] Key type .llcrypt unregistered [12520.079860] Key type ._llcrypt unregistered [12540.394166] Key type ._llcrypt registered [12540.396581] Key type .llcrypt registered [12541.798735] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12544.479169] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 12:23:29 (1790785409) [12554.957471] Key type .llcrypt unregistered [12554.959472] Key type ._llcrypt unregistered [12566.298047] Key type ._llcrypt registered [12566.304421] Key type .llcrypt registered [12567.019941] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12567.066739] alg: No test for adler32 (adler32-zlib) [12568.218739] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [12568.590681] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [12570.303565] Key type lgssc registered [12571.918272] Lustre: Echo OBD driver; http://www.lustre.org/ [12631.267555] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12649.170790] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [12651.862957] Lustre: Unmounted lustre-client [12679.935949] Key type lgssc unregistered [12680.361802] LNet: 260961:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12680.370042] LNetError: 260961:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12680.391077] LNet: Removed LNI 192.168.202.45@tcp [12681.321437] Key type .llcrypt unregistered [12681.328576] Key type ._llcrypt unregistered [12701.757455] Key type ._llcrypt registered [12701.768763] Key type .llcrypt registered [12703.362627] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 12:26:08 (1790785568) [12706.447271] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12706.468968] alg: No test for adler32 (adler32-zlib) [12707.634368] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [12707.966501] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [12709.705407] Key type lgssc registered [12710.880280] Lustre: Echo OBD driver; http://www.lustre.org/ [12800.698272] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12838.956148] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12845.304224] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12846.984376] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [12848.978543] Lustre: Unmounted lustre-client [12880.630043] Key type lgssc unregistered [12880.965755] LNet: 264526:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12880.975377] LNetError: 264526:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12880.994723] LNet: Removed LNI 192.168.202.45@tcp [12882.058918] Key type .llcrypt unregistered [12882.061769] Key type ._llcrypt unregistered [12905.449205] Key type ._llcrypt registered [12905.451523] Key type .llcrypt registered [12907.098659] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 12:29:32 (1790785772) [12910.408490] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12910.499021] alg: No test for adler32 (adler32-zlib) [12911.757799] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [12912.028723] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [12913.719287] Key type lgssc registered [12915.168221] Lustre: Echo OBD driver; http://www.lustre.org/ [12972.593914] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12980.044858] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13003.969658] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13016.109321] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [13021.172945] Lustre: lustre-MDT0000-mdc-ffff89d248b45800: Connection to lustre-MDT0000 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [13027.284833] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13027.341740] LustreError: 267705:0:(file.c:6243:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13027.807190] LustreError: MGC192.168.202.145@tcp: Connection to MGS (at 192.168.202.145@tcp) was lost; in progress operations using this service will fail [13027.884674] Lustre: Unmounted lustre-client [13049.665642] Key type lgssc unregistered [13050.035524] LNet: 268117:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13050.046945] LNetError: 268117:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13050.095661] LNet: Removed LNI 192.168.202.45@tcp [13050.788551] Key type .llcrypt unregistered [13050.791635] Key type ._llcrypt unregistered [13067.660374] Key type ._llcrypt registered [13067.661602] Key type .llcrypt registered [13069.233257] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 12:32:14 (1790785934) [13071.864084] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13072.075647] alg: No test for adler32 (adler32-zlib) [13073.398498] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [13073.662275] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [13075.415761] Key type lgssc registered [13076.496282] Lustre: Echo OBD driver; http://www.lustre.org/ [13131.211487] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13136.136034] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13159.327764] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13162.189972] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [13167.599987] Lustre: lustre-MDT0001-mdc-ffff89d247168000: Connection to lustre-MDT0001 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [13173.371573] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13176.609240] Lustre: Unmounted lustre-client [13197.188866] Key type lgssc unregistered [13197.407039] LNet: 271716:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13197.419879] LNetError: 271716:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13198.441086] LNet: Removed LNI 192.168.202.45@tcp [13199.275124] Key type .llcrypt unregistered [13199.280570] Key type ._llcrypt unregistered [13218.678132] Key type ._llcrypt registered [13218.681414] Key type .llcrypt registered [13220.527832] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 12:34:45 (1790786085) [13238.454855] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13238.612759] alg: No test for adler32 (adler32-zlib) [13239.903877] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [13240.350576] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [13242.079242] Key type lgssc registered [13243.539364] Lustre: Echo OBD driver; http://www.lustre.org/ [13350.780697] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13352.602893] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [13394.408892] Lustre: lustre-MDT0001-mdc-ffff89d242d2d000: Connection to lustre-MDT0001 (at 192.168.202.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [13410.716622] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13421.055113] Lustre: Unmounted lustre-client [13450.125387] Key type lgssc unregistered [13450.561053] LNet: 277537:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13450.583621] LNetError: 277537:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13450.610602] LNet: Removed LNI 192.168.202.45@tcp [13451.985588] Key type .llcrypt unregistered [13451.996138] Key type ._llcrypt unregistered [13471.270258] Key type ._llcrypt registered [13471.272610] Key type .llcrypt registered [13473.019684] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 12:38:58 (1790786338) [13474.622926] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13476.302946] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 12:39:02 (1790786342) [13478.088660] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13479.687451] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 12:39:05 (1790786345) [13481.565657] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13483.600691] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 12:39:09 (1790786349) [13485.473749] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13487.846804] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 12:39:13 (1790786353) [13489.437797] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13491.293216] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 12:39:17 (1790786357) [13499.503572] Key type .llcrypt unregistered [13499.505465] Key type ._llcrypt unregistered [13505.354370] Key type ._llcrypt registered [13505.356113] Key type .llcrypt registered [13505.748582] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13505.762354] alg: No test for adler32 (adler32-zlib) [13506.864502] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [13507.094297] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [13508.769532] Key type lgssc registered [13510.064622] Lustre: Echo OBD driver; http://www.lustre.org/ [13584.984912] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13591.815966] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13616.283646] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13618.835479] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [13621.491309] Lustre: Unmounted lustre-client [13661.084715] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 12:42:07 (1790786527) [13695.932774] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13702.808974] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13737.995130] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13744.202514] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [13746.752180] Lustre: Unmounted lustre-client [13795.334869] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 12:44:21 (1790786661) [13795.871794] LNet: 1 local NIs in recovery (showing 1): 192.168.202.45@tcp [14445.814769] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14451.722410] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14486.368176] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14591.470785] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 12:57:37 (1790787457) [14603.608880] Key type lgssc unregistered [14603.861566] LNet: 291088:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14603.864983] LNetError: 291088:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14603.876082] LNet: Removed LNI 192.168.202.45@tcp [14604.260678] Key type .llcrypt unregistered [14604.263619] Key type ._llcrypt unregistered [14737.430155] Key type ._llcrypt registered [14737.431863] Key type .llcrypt registered [14738.077398] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14738.096719] alg: No test for adler32 (adler32-zlib) [14739.192278] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [14739.447685] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [14741.151221] Key type lgssc registered [14742.758245] Lustre: Echo OBD driver; http://www.lustre.org/ [14841.236227] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14848.108564] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14873.708647] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14911.460744] Key type lgssc unregistered [14911.830350] LNet: 294818:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14911.846888] LNetError: 294818:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14911.882253] LNet: Removed LNI 192.168.202.45@tcp [14912.762785] Key type .llcrypt unregistered [14912.765704] Key type ._llcrypt unregistered [14953.902899] Key type ._llcrypt registered [14953.904917] Key type .llcrypt registered [14955.076417] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 13:03:41 (1790787821) [14981.354727] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14981.380348] alg: No test for adler32 (adler32-zlib) [14982.676232] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [14983.024670] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [14984.736805] Key type lgssc registered [14986.327913] Lustre: Echo OBD driver; http://www.lustre.org/ [15049.578426] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 13:05:15 (1790787915) [15062.759714] Key type lgssc unregistered [15063.005052] LNet: 298394:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15063.012527] LNetError: 298394:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15063.025406] LNet: Removed LNI 192.168.202.45@tcp [15063.802863] Key type .llcrypt unregistered [15063.805654] Key type ._llcrypt unregistered [15077.542309] Key type ._llcrypt registered [15077.544308] Key type .llcrypt registered [15078.348316] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15078.363629] alg: No test for adler32 (adler32-zlib) [15079.569816] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [15079.835563] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [15081.575250] Key type lgssc registered [15083.403778] Lustre: Echo OBD driver; http://www.lustre.org/ [15153.358095] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15159.277668] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15193.322485] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15544.334465] LNet: Added LNI 192.168.202.45@tcp50 [8/256/0/180] [15546.494501] LNet: Removed LNI 192.168.202.45@tcp [15548.896957] Lustre: 302824:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff89d242d28000: config has no valid NIDs, force dynamic NIDs [15550.027707] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [15550.154943] Lustre: Unmounted lustre-client [15552.860723] Key type lgssc unregistered [15553.236650] LNet: 303083:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15553.246913] LNetError: 303083:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15553.283028] LNet: Removed LNI 192.168.202.45@tcp50 [15553.838894] Key type .llcrypt unregistered [15553.840742] Key type ._llcrypt unregistered [15575.443599] Key type ._llcrypt registered [15575.448556] Key type .llcrypt registered [15575.943798] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15575.974610] alg: No test for adler32 (adler32-zlib) [15577.228787] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [15577.472561] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [15579.239250] Key type lgssc registered [15580.824526] Lustre: Echo OBD driver; http://www.lustre.org/ [15645.979345] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15653.737814] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15663.521683] LNet: Added LNI 192.168.202.45@tcp50 [8/256/0/180] [15664.437586] LNet: Removed LNI 192.168.202.45@tcp [15665.667982] Lustre: 305787:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff89d248b43000: config has no valid NIDs, force dynamic NIDs [15666.956237] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [15667.423901] Lustre: Unmounted lustre-client [15705.687416] Key type lgssc unregistered [15706.222453] LNet: 306655:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15706.238810] LNetError: 306655:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15707.313489] LNet: Removed LNI 192.168.202.45@tcp50 [15708.218908] Key type .llcrypt unregistered [15708.220751] Key type ._llcrypt unregistered [15723.389522] Key type ._llcrypt registered [15723.391746] Key type .llcrypt registered [15725.457292] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 13:16:30 (1790788590) [15747.168221] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15747.233138] alg: No test for adler32 (adler32-zlib) [15748.442723] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [15748.844768] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [15750.647349] Key type lgssc registered [15753.153593] Lustre: Echo OBD driver; http://www.lustre.org/ [15863.102461] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15869.386958] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15899.574503] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15935.930720] Key type lgssc unregistered [15936.259328] LNet: 311423:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15936.272545] LNetError: 311423:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15936.316342] LNet: Removed LNI 192.168.202.45@tcp [15937.115709] Key type .llcrypt unregistered [15937.120664] Key type ._llcrypt unregistered [15951.631831] Key type ._llcrypt registered [15951.633691] Key type .llcrypt registered [15953.345808] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 13:20:18 (1790788818) [15956.109748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15956.162880] alg: No test for adler32 (adler32-zlib) [15957.295132] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [15957.577212] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [15959.361363] Key type lgssc registered [15961.076480] Lustre: Echo OBD driver; http://www.lustre.org/ [16021.090481] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16029.143768] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16056.066245] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16059.048478] Lustre: Mounted lustre-client - version 2.17.59_4_ge4c1f18 [16131.094562] Lustre: Mounted fs15246-client - version 2.17.59_4_ge4c1f18 [16148.560213] Lustre: Unmounted fs15246-client [16178.826464] Lustre: Unmounted lustre-client [16217.081580] Key type lgssc unregistered [16217.344079] LNet: 316300:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16217.347305] LNetError: 316300:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16217.362102] LNet: Removed LNI 192.168.202.45@tcp [16217.920438] Key type .llcrypt unregistered [16217.924494] Key type ._llcrypt unregistered [16233.559688] Key type ._llcrypt registered [16233.569933] Key type .llcrypt registered [16235.033224] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 13:25:00 (1790789100) [16236.525399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16236.690688] alg: No test for adler32 (adler32-zlib) [16237.765947] Lustre: Lustre: Build Version: 2.17.59_4_ge4c1f18 [16238.006256] LNet: Added LNI 192.168.202.45@tcp [8/256/0/180] [16239.703773] Key type lgssc registered [16241.481161] Lustre: Echo OBD driver; http://www.lustre.org/ [16403.993663] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16411.576905] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16438.962299] Lustre: DEBUG MARKER: oleg245-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16566.554714] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16283 sec ========= 13:30:31 (1790789431) [16568.499976] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:30:34 (1790789434) === [16572.643805] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:30:38 (1790789438) === [16614.535853] Key type lgssc unregistered [16614.930838] LNet: 325591:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16614.937515] LNetError: 325591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16614.950069] LNet: Removed LNI 192.168.202.45@tcp [16615.945851] Key type .llcrypt unregistered [16615.947497] Key type ._llcrypt unregistered