[ 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 427736561 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003324] x2apic enabled [ 0.004010] Switched APIC routing to physical x2apic. [ 0.005015] kvm-guest: setup PV IPIs [ 0.008295] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010011] pid_max: default: 32768 minimum: 301 [ 0.011132] LSM: Security Framework initializing [ 0.012044] Yama: becoming mindful. [ 0.013025] SELinux: Initializing. [ 0.014068] *** VALIDATE selinux *** [ 0.021738] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026122] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027143] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029025] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030114] *** VALIDATE tmpfs *** [ 0.032172] *** VALIDATE proc *** [ 0.033196] *** VALIDATE cgroup *** [ 0.034008] *** VALIDATE cgroup2 *** [ 0.035253] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037110] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039028] Spectre V2 : User space: Vulnerable [ 0.040009] Speculative Store Bypass: Vulnerable [ 0.043388] debug: unmapping init [mem 0xffffffffa6859000-0xffffffffa6860fff] [ 0.046000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046718] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047023] ... version: 2 [ 0.048014] ... bit width: 48 [ 0.049012] ... generic registers: 4 [ 0.050013] ... value mask: 0000ffffffffffff [ 0.051014] ... max period: 00007fffffffffff [ 0.052009] ... fixed-purpose events: 3 [ 0.052728] ... event mask: 000000070000000f [ 0.053240] rcu: Hierarchical SRCU implementation. [ 0.055219] smp: Bringing up secondary CPUs ... [ 0.056595] x86: Booting SMP configuration: [ 0.057038] .... node #0, CPUs: #1 #2 #3 [ 0.060716] smp: Brought up 1 node, 4 CPUs [ 0.062012] smpboot: Max logical packages: 1 [ 0.062875] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.156973] node 0 deferred pages initialised in 90ms [ 0.160107] devtmpfs: initialized [ 0.161272] x86/mm: Memory block size: 128MB [ 0.164847] gcov: version magic: 0x41383552 [ 0.168381] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.172077] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.174307] pinctrl core: initialized pinctrl subsystem [ 0.177202] [ 0.177903] ************************************************************* [ 0.180014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.182010] ** ** [ 0.185013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.187013] ** ** [ 0.190015] ** This means that this kernel is built to expose internal ** [ 0.192013] ** IOMMU data structures, which may compromise security on ** [ 0.195016] ** your system. ** [ 0.197020] ** ** [ 0.200010] ** If you see this message and you are not debugging the ** [ 0.201012] ** kernel, report this immediately to your vendor! ** [ 0.203012] ** ** [ 0.205017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.208015] ************************************************************* [ 0.211695] NET: Registered protocol family 16 [ 0.212545] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.215066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.218140] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.222193] cpuidle: using governor menu [ 0.223637] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.225474] PCI: Using configuration type 1 for base access [ 0.228131] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.236113] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.238029] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.242049] cryptd: max_cpu_qlen set to 1000 [ 0.244258] ACPI: Added _OSI(Module Device) [ 0.246013] ACPI: Added _OSI(Processor Device) [ 0.247014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.248011] ACPI: Added _OSI(Processor Aggregator Device) [ 0.253704] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.260588] ACPI: Interpreter enabled [ 0.262059] ACPI: PM: (supports S0 S3 S4 S5) [ 0.263014] ACPI: Using IOAPIC for interrupt routing [ 0.266091] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.269383] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.278153] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.281045] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.284021] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.287063] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.292338] acpiphp: Slot [2] registered [ 0.293094] acpiphp: Slot [5] registered [ 0.294096] acpiphp: Slot [6] registered [ 0.295040] acpiphp: Slot [3] registered [ 0.296026] acpiphp: Slot [4] registered [ 0.296964] acpiphp: Slot [7] registered [ 0.298084] acpiphp: Slot [8] registered [ 0.299096] acpiphp: Slot [9] registered [ 0.300129] acpiphp: Slot [10] registered [ 0.301082] acpiphp: Slot [11] registered [ 0.302082] acpiphp: Slot [12] registered [ 0.303079] acpiphp: Slot [13] registered [ 0.304077] acpiphp: Slot [14] registered [ 0.305102] acpiphp: Slot [15] registered [ 0.307090] acpiphp: Slot [16] registered [ 0.308078] acpiphp: Slot [17] registered [ 0.309068] acpiphp: Slot [18] registered [ 0.310108] acpiphp: Slot [19] registered [ 0.311097] acpiphp: Slot [20] registered [ 0.313122] acpiphp: Slot [21] registered [ 0.314093] acpiphp: Slot [22] registered [ 0.316102] acpiphp: Slot [23] registered [ 0.317101] acpiphp: Slot [24] registered [ 0.320048] acpiphp: Slot [25] registered [ 0.321081] acpiphp: Slot [26] registered [ 0.322084] acpiphp: Slot [27] registered [ 0.323073] acpiphp: Slot [28] registered [ 0.324097] acpiphp: Slot [29] registered [ 0.325082] acpiphp: Slot [30] registered [ 0.326081] acpiphp: Slot [31] registered [ 0.327055] PCI host bridge to bus 0000:00 [ 0.328025] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.329016] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.331020] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.333018] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.335019] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.337019] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.338170] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.339820] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.343122] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.348969] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.353010] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.355016] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.357022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.359024] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.360712] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.363745] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.367053] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.370813] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.374719] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.383016] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.388012] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.393157] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.399882] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.406013] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.422968] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.431553] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.436014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.442014] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.457013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.465301] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.468330] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.469300] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.471263] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.473208] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.479126] iommu: Default domain type: Passthrough [ 0.481562] SCSI subsystem initialized [ 0.483219] ACPI: bus type USB registered [ 0.485144] usbcore: registered new interface driver usbfs [ 0.487128] usbcore: registered new interface driver hub [ 0.490125] usbcore: registered new device driver usb [ 0.493247] pps_core: LinuxPPS API ver. 1 registered [ 0.495010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.498069] PTP clock support registered [ 0.501088] EDAC MC: Ver: 3.0.0 [ 0.503127] PCI: Using ACPI for IRQ routing [ 0.504666] NetLabel: Initializing [ 0.506013] NetLabel: domain hash size = 128 [ 0.508010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.510063] NetLabel: unlabeled traffic allowed by default [ 0.512096] vgaarb: loaded [ 0.513283] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.514010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.519318] clocksource: Switched to clocksource kvm-clock [ 0.626952] VFS: Disk quotas dquot_6.6.0 [ 0.628585] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.632324] *** VALIDATE ramfs *** [ 0.633207] *** VALIDATE hugetlbfs *** [ 0.634498] pnp: PnP ACPI init [ 0.636735] pnp: PnP ACPI: found 6 devices [ 0.655680] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.657868] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.659885] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.662203] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.664900] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.667011] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.669555] NET: Registered protocol family 2 [ 0.672275] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.676201] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.678720] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.682824] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.685423] TCP: Hash tables configured (established 65536 bind 65536) [ 0.687664] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.689817] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.691760] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.693858] NET: Registered protocol family 1 [ 0.695763] RPC: Registered named UNIX socket transport module. [ 0.697258] RPC: Registered udp transport module. [ 0.698377] RPC: Registered tcp transport module. [ 0.699471] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.701281] NET: Registered protocol family 44 [ 0.703114] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.705366] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.707669] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.709754] PCI: CLS 0 bytes, default 64 [ 0.711275] Unpacking initramfs... [ 2.095415] debug: unmapping init [mem 0xffff8c3ffcc64000-0xffff8c3ffffcffff] [ 2.098681] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.101226] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.104472] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.602093] Initialise system trusted keyrings [ 2.603681] Key type blacklist registered [ 2.605486] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.616341] zbud: loaded [ 2.619837] *** VALIDATE nfs *** [ 2.621246] *** VALIDATE nfs4 *** [ 2.622726] pstore: using deflate compression [ 2.628024] Platform Keyring initialized [ 2.726961] NET: Registered protocol family 38 [ 2.729254] Key type asymmetric registered [ 2.730808] Asymmetric key parser 'x509' registered [ 2.733307] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.736757] io scheduler mq-deadline registered [ 2.739051] io scheduler kyber registered [ 2.741339] io scheduler bfq registered [ 2.743730] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.747083] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.750361] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.753270] ACPI: Power Button [PWRF] [ 2.759467] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.765199] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.780257] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.809466] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.837686] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.842302] Non-volatile memory driver v1.3 [ 2.844289] Linux agpgart interface v0.103 [ 2.875136] virtio_blk virtio1: [vda] 149760 512-byte logical blocks (76.7 MB/73.1 MiB) [ 2.878130] vda: detected capacity change from 0 to 76677120 [ 2.893720] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.896828] vdb: detected capacity change from 0 to 1073741824 [ 2.905615] libphy: Fixed MDIO Bus: probed [ 2.910952] usbcore: registered new interface driver usbserial_generic [ 2.913479] usbserial: USB Serial support registered for generic [ 2.915886] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.920755] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.922717] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.924954] mousedev: PS/2 mouse device common for all mice [ 2.928033] rtc_cmos 00:05: RTC can wake from S4 [ 2.930867] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.931890] rtc_cmos 00:05: registered as rtc0 [ 2.936273] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.940276] intel_pstate: CPU model not supported [ 2.943785] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.946041] hid: raw HID events driver (C) Jiri Kosina [ 2.949372] usbcore: registered new interface driver usbhid [ 2.951837] usbhid: USB HID core driver [ 2.952068] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.954491] drop_monitor: Initializing network drop monitor service [ 2.959604] Initializing XFRM netlink socket [ 2.961629] NET: Registered protocol family 10 [ 2.966125] Segment Routing with IPv6 [ 2.968047] NET: Registered protocol family 17 [ 2.970069] mpls_gso: MPLS GSO support [ 2.976108] RAS: Correctable Errors collector initialized. [ 2.978436] AVX version of gcm_enc/dec engaged. [ 2.980736] AES CTR mode by8 optimization enabled [ 3.046338] sched_clock: Marking stable (3046318129, 0)->(3902161157, -855843028) [ 3.049437] registered taskstats version 1 [ 3.051479] Loading compiled-in X.509 certificates [ 3.053016] zswap: loaded using pool lzo/zbud [ 3.076696] Key type big_key registered [ 3.088760] Key type encrypted registered [ 3.090745] ima: No TPM chip found, activating TPM-bypass! [ 3.093162] ima: Allocated hash algorithm: sha1 [ 3.094857] ima: No architecture policies found [ 3.096876] evm: Initialising EVM extended attributes: [ 3.098894] evm: security.selinux [ 3.100161] evm: security.ima [ 3.101587] evm: security.capability [ 3.103160] evm: HMAC attrs: 0x1 [ 3.105618] rtc_cmos 00:05: setting system clock to 2026-09-03 12:44:17 UTC (1788439457) [ 3.112379] debug: unmapping init [mem 0xffffffffa7803000-0xffffffffa79fffff] [ 3.116021] debug: unmapping init [mem 0xffffffffa6582000-0xffffffffa6858fff] [ 3.126089] Write protecting the kernel read-only data: 28672k [ 3.129614] debug: unmapping init [mem 0xffffffffa4c03000-0xffffffffa4dfffff] [ 3.132968] debug: unmapping init [mem 0xffffffffa5514000-0xffffffffa55fffff] [ 3.165556] 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.175969] systemd[1]: Detected virtualization kvm. [ 3.178067] systemd[1]: Detected architecture x86-64. [ 3.180260] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.208884] systemd[1]: No hostname configured. [ 3.210857] systemd[1]: Set hostname to . [ 3.213344] random: systemd: uninitialized urandom read (16 bytes read) [ 3.216069] systemd[1]: Initializing machine ID from random generator. [ 3.259578] random: ln: uninitialized urandom read (6 bytes read) [ 3.336894] random: systemd: uninitialized urandom read (16 bytes read) [ 3.340479] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.349106] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st…ce nodes for the current kernel... [ 3.356291] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. Starting Setup Virtual Console... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Reached target Initrd Root Device. Starting Apply Kernel Variables... [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.908738] device-mapper: uevent: version 1.0.3 [ 3.910945] 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. Starting dracut initqueue hook... [ 4.694301] virtio_net virtio0 ens2: renamed from eth0 [ 4.813312] scsi host0: ata_piix [ 4.846698] scsi host1: ata_piix [ 4.848520] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.851143] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.538631] dracut-initqueue[579]: RTNETLINK answers: File exists [ 9.610201] random: crng init done [ 9.611812] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.074830] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Timers. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ 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 target Swap. [ 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 Slices. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.316125] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.583947] SELinux: Disabled at runtime. [ 11.642212] 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.650436] systemd[1]: Detected virtualization kvm. [ 11.652785] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.183780] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.188114] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.195342] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.200132] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.204738] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.214815] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.219386] systemd[1]: Stopped target Switch Root. [ OK ] Stopped target Switch Root. [ OK ] Listening on initctl Compatibility Named Pipe. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on Process Core Dump Socket. Mounting POSIX Message Queue File System... Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd File Systems. Mounting Huge Pages File System... [ OK ] Listening on udev Kernel Socket. Activating swap /dev/disk/by-label/SWAP... Starting Apply Kernel Variables... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. [ OK ] Listening on[ 12.355091] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS RPCbind Server Activation Socket. [ OK ] Listening on udev Control Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd Root File System. Starting udev Coldplug all Devices... Mounting Kernel Debug File System... [ OK ] Reached target Slices. [ OK ] Created slice system-getty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.734603] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.994668] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.079613] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.217270] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.230837] EDAC sbridge: Ver: 1.1.2 [ 14.432595] Key type dns_resolver registered [ 14.723911] NFS: Registering the id_resolver key type [ 14.725676] Key type id_resolver registered [ 14.727732] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Basic System. Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. [ OK ] Reached target sshd-keygen.target. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg339-client login: [ 44.229714] libcfs: loading out-of-tree module taints kernel. [ 44.350170] Key type ._llcrypt registered [ 44.352692] Key type .llcrypt registered [ 44.773730] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 44.781767] alg: No test for adler32 (adler32-zlib) [ 45.859033] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 46.236688] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 47.879173] Key type lgssc registered [ 48.684697] Lustre: Echo OBD driver; http://www.lustre.org/ [ 179.924008] hrtimer: interrupt took 25645485 ns [ 217.223626] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 222.489130] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 236.887757] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing check_logdir /tmp/testlogs/ [ 242.251994] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing yml_node [ 242.658201] Lustre: lustre-OST0000-osc-ffff8c4042e8f000: disconnect after 23s idle [ 247.801461] Lustre: DEBUG MARKER: Client: 2.17.58.2 [ 250.761787] Lustre: DEBUG MARKER: MDS: 2.17.58.2 [ 253.676654] Lustre: DEBUG MARKER: OSS: 2.17.58.2 [ 255.515799] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 3 08:48:28 EDT 2026 [ 273.137944] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 274.453911] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 276.935123] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 287.285399] Lustre: Unmounted lustre-client [ 404.707749] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 412.453834] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 437.972540] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 484.387233] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 08:52:17 (1788439937) [ 487.283908] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 489.580122] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 08:52:22 (1788439942) [ 527.468439] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 533.995515] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 559.545189] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 571.021475] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 576.858958] Lustre: Unmounted lustre-client [ 607.122066] Key type lgssc unregistered [ 607.432877] LNet: 15041:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 607.451057] LNetError: 15041:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 607.489788] LNet: Removed LNI 192.168.203.39@tcp [ 608.294162] Key type .llcrypt unregistered [ 608.297182] Key type ._llcrypt unregistered [ 624.865981] Key type ._llcrypt registered [ 624.868520] Key type .llcrypt registered [ 626.043305] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 08:54:39 (1788440079) [ 627.461789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 627.489949] alg: No test for adler32 (adler32-zlib) [ 628.522044] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 628.781108] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 630.503179] Key type lgssc registered [ 631.810336] Lustre: Echo OBD driver; http://www.lustre.org/ [ 711.349658] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 801.499512] Lustre: Unmounted lustre-client [ 827.626952] Key type lgssc unregistered [ 827.933161] LNet: 18832:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 827.939163] LNetError: 18832:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 827.957613] LNet: Removed LNI 192.168.203.39@tcp [ 828.638171] Key type .llcrypt unregistered [ 828.640970] Key type ._llcrypt unregistered [ 841.104048] Key type ._llcrypt registered [ 841.106679] Key type .llcrypt registered [ 842.729084] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 08:58:15 (1788440295) [ 845.841447] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 845.883832] alg: No test for adler32 (adler32-zlib) [ 847.086919] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 847.385135] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 849.143896] Key type lgssc registered [ 850.471325] Lustre: Echo OBD driver; http://www.lustre.org/ [ 905.129770] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 911.172730] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 933.906697] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 935.642085] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 950.450912] Lustre: Unmounted lustre-client [ 978.557420] Key type lgssc unregistered [ 978.903737] LNet: 22426:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 978.912939] LNetError: 22426:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 978.976352] LNet: Removed LNI 192.168.203.39@tcp [ 979.813814] Key type .llcrypt unregistered [ 979.818897] Key type ._llcrypt unregistered [ 990.096092] Key type ._llcrypt registered [ 990.103126] Key type .llcrypt registered [ 991.617295] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 09:00:44 (1788440444) [ 994.280728] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 994.312782] alg: No test for adler32 (adler32-zlib) [ 995.447392] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 995.666324] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 997.407274] Key type lgssc registered [ 998.504504] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1051.656810] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1058.778706] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1084.142500] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1085.777993] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 1092.017093] Lustre: Unmounted lustre-client [ 1128.273832] Key type lgssc unregistered [ 1128.529876] LNet: 25631:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1128.539933] LNetError: 25631:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1128.554190] LNet: Removed LNI 192.168.203.39@tcp [ 1129.356676] Key type .llcrypt unregistered [ 1129.360175] Key type ._llcrypt unregistered [ 1145.455964] Key type ._llcrypt registered [ 1145.461784] Key type .llcrypt registered [ 1146.984363] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 09:03:19 (1788440599) [ 1149.270474] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1149.497668] alg: No test for adler32 (adler32-zlib) [ 1150.647770] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 1150.940363] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1152.667367] Key type lgssc registered [ 1153.977609] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1210.205798] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1217.072434] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1240.815240] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1252.913898] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 1257.964167] Lustre: lustre-MDT0000-mdc-ffff8c4051c4b800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1268.215550] Lustre: lustre-MDT0001-mdc-ffff8c4051c4b800: Connection to lustre-MDT0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1272.054753] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1279.455148] Lustre: 26585:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788440717/real 1788440717] req@00000000de8dcd8e x1875315895834752/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788440733 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1279.476598] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [ 1282.436840] Lustre: Unmounted lustre-client [ 1305.697348] Key type lgssc unregistered [ 1306.082176] LNet: 29279:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1306.094925] LNetError: 29279:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1306.133617] LNet: Removed LNI 192.168.203.39@tcp [ 1307.000367] Key type .llcrypt unregistered [ 1307.002139] Key type ._llcrypt unregistered [ 1326.263185] Key type ._llcrypt registered [ 1326.267676] Key type .llcrypt registered [ 1327.940293] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 09:06:20 (1788440780) [ 1330.434213] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1330.487938] alg: No test for adler32 (adler32-zlib) [ 1331.629649] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 1331.939868] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1333.615221] Key type lgssc registered [ 1335.431115] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1387.743868] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1393.616762] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1414.959345] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1416.863606] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 1428.334508] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1438.716414] Lustre: Unmounted lustre-client [ 1466.480352] Key type lgssc unregistered [ 1466.760291] LNet: 32886:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1466.785104] LNetError: 32886:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1466.806431] LNet: Removed LNI 192.168.203.39@tcp [ 1467.420755] Key type .llcrypt unregistered [ 1467.432466] Key type ._llcrypt unregistered [ 1482.949490] Key type ._llcrypt registered [ 1482.951489] Key type .llcrypt registered [ 1484.447531] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 09:08:57 (1788440937) [ 1486.618400] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1486.637366] alg: No test for adler32 (adler32-zlib) [ 1487.841846] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 1488.102462] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1489.799364] Key type lgssc registered [ 1491.189787] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1545.508206] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1550.709150] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1572.182311] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1575.013614] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 1581.606401] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1585.791839] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1597.854582] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-03 9h10m50s [ 1599.815294] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1605.623632] Lustre: lustre-MDT0000-mdc-ffff8c405090e800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1609.633682] LustreError: 36670:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8c405090e800: can't stat MDS #0: rc = -19 [ 1611.175768] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1618.931779] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [ 1618.947108] LustreError: lustre-MDT0000-mdc-ffff8c405090e800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1619.003445] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0xe101cd06821bda77 to 0xe101cd06821bdd2c [ 1619.008410] Lustre: lustre-MDT0000-mdc-ffff8c405090e800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 1619.036845] Lustre: Skipped 1 previous similar message [ 1626.456302] Lustre: DEBUG MARKER: Wait for df (36670) ... [ 1627.975765] Lustre: DEBUG MARKER: done [ 1630.313559] Lustre: Unmounted lustre-client [ 1656.163788] Key type lgssc unregistered [ 1656.477979] LNet: 37685:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1656.493462] LNetError: 37685:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1656.514506] LNet: Removed LNI 192.168.203.39@tcp [ 1657.222471] Key type .llcrypt unregistered [ 1657.225767] Key type ._llcrypt unregistered [ 1692.808259] Key type ._llcrypt registered [ 1692.810767] Key type .llcrypt registered [ 1694.153495] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 09:12:27 (1788441147) [ 1697.125644] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1697.180363] alg: No test for adler32 (adler32-zlib) [ 1698.286391] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 1698.561957] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1700.223358] Key type lgssc registered [ 1701.702562] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1757.271756] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1764.947498] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1793.846748] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1795.631227] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 1800.285295] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-03 9h14m13s [ 1802.258495] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1809.565437] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1812.625591] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1832.927194] Lustre: 41824:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788441267/real 1788441267] req@0000000062fc3b40 x1875316469406336/t0(0) o101->lustre-MDT0000-mdc-ffff8c404545a000@192.168.203.139@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788441287 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1832.971658] Lustre: lustre-MDT0000-mdc-ffff8c404545a000: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1833.033300] Lustre: lustre-MDT0000-mdc-ffff8c404545a000: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 1854.236416] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1857.925727] Lustre: DEBUG MARKER: done [ 1862.201378] Lustre: Unmounted lustre-client [ 1898.834253] Key type lgssc unregistered [ 1899.178741] LNet: 42711:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1899.183196] LNetError: 42711:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1899.198902] LNet: Removed LNI 192.168.203.39@tcp [ 1900.122738] Key type .llcrypt unregistered [ 1900.128512] Key type ._llcrypt unregistered [ 1930.084758] Key type ._llcrypt registered [ 1930.087167] Key type .llcrypt registered [ 1931.522323] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 09:16:24 (1788441384) [ 1932.866689] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1934.860936] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 09:16:27 (1788441387) [ 1938.936956] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1938.972505] alg: No test for adler32 (adler32-zlib) [ 1940.134673] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 1940.430036] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1942.105267] Key type lgssc registered [ 1943.042920] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1971.373804] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 09:17:03 (1788441423) [ 2006.961685] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2012.699727] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2033.383254] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2034.941776] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 2038.684978] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2042.834327] Lustre: Unmounted lustre-client [ 2060.236821] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2108.417120] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2114.328501] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2114.885659] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 2118.963230] Lustre: Unmounted lustre-client [ 2179.014726] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2185.408943] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2186.296286] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 2191.992553] Lustre: Unmounted lustre-client [ 2216.875777] Lustre: DEBUG MARKER: files compared the same [ 2238.533779] Key type lgssc unregistered [ 2238.770046] LNet: 50330:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2238.781961] LNetError: 50330:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2238.805887] LNet: Removed LNI 192.168.203.39@tcp [ 2239.393383] Key type .llcrypt unregistered [ 2239.395717] Key type ._llcrypt unregistered [ 2253.066211] Key type ._llcrypt registered [ 2253.070234] Key type .llcrypt registered [ 2254.905500] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 09:21:47 (1788441707) [ 2257.470786] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2257.484394] alg: No test for adler32 (adler32-zlib) [ 2258.617231] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 2258.942367] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2260.760091] Key type lgssc registered [ 2262.326804] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2321.022114] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2327.155717] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2350.767774] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2353.764703] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 2358.124384] Lustre: Unmounted lustre-client [ 2386.807958] Key type lgssc unregistered [ 2387.173244] LNet: 53907:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2387.186973] LNetError: 53907:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2387.208475] LNet: Removed LNI 192.168.203.39@tcp [ 2388.349595] Key type .llcrypt unregistered [ 2388.352257] Key type ._llcrypt unregistered [ 2407.837479] Key type ._llcrypt registered [ 2407.840740] Key type .llcrypt registered [ 2409.944945] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 09:24:21 (1788441861) [ 2412.360330] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2412.532212] alg: No test for adler32 (adler32-zlib) [ 2413.744846] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 2414.015496] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2415.720204] Key type lgssc registered [ 2417.006788] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2502.611725] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2537.703337] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2543.801465] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2580.659902] Key type lgssc unregistered [ 2580.943977] LNet: 57396:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2580.952644] LNetError: 57396:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2580.975632] LNet: Removed LNI 192.168.203.39@tcp [ 2581.802127] Key type .llcrypt unregistered [ 2581.807232] Key type ._llcrypt unregistered [ 2600.932403] Key type ._llcrypt registered [ 2600.936537] Key type .llcrypt registered [ 2602.509509] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 09:27:35 (1788442055) [ 2606.176262] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2606.188407] alg: No test for adler32 (adler32-zlib) [ 2607.356978] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 2607.663863] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2609.432591] Key type lgssc registered [ 2611.064299] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2690.717783] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 2698.378103] Lustre: Unmounted lustre-client [ 2738.062825] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 09:29:51 (1788442191) [ 2870.522667] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2894.439176] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 2901.953491] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2901.966358] LustreError: 63867:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8c4051cc4800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2901.991444] Lustre: 58379:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.139@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2912.369407] Lustre: Unmounted lustre-client [ 2956.637877] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 09:33:29 (1788442409) [ 2969.813397] Key type lgssc unregistered [ 2970.161978] LNet: 65087:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2970.171102] LNetError: 65087:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2970.204309] LNet: Removed LNI 192.168.203.39@tcp [ 2970.962964] Key type .llcrypt unregistered [ 2970.965629] Key type ._llcrypt unregistered [ 2984.626827] Key type ._llcrypt registered [ 2984.632645] Key type .llcrypt registered [ 2985.091828] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2985.139493] alg: No test for adler32 (adler32-zlib) [ 2986.245992] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 2986.571361] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2988.343583] Key type lgssc registered [ 2989.609611] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3045.259221] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3050.987481] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3075.633438] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3077.480281] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3083.360769] Lustre: Unmounted lustre-client [ 3112.629766] Key type lgssc unregistered [ 3112.889916] LNet: 68102:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3112.896495] LNetError: 68102:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3112.910531] LNet: Removed LNI 192.168.203.39@tcp [ 3113.655685] Key type .llcrypt unregistered [ 3113.663705] Key type ._llcrypt unregistered [ 3126.048813] Key type ._llcrypt registered [ 3126.061845] Key type .llcrypt registered [ 3126.521834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3126.550401] alg: No test for adler32 (adler32-zlib) [ 3127.651622] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 3127.925774] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 3129.559204] Key type lgssc registered [ 3130.840267] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3257.940115] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3264.164587] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3285.909343] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3287.570554] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3294.728948] Lustre: Unmounted lustre-client [ 3326.887370] Key type lgssc unregistered [ 3327.164541] LNet: 71534:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3327.171803] LNetError: 71534:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3327.187140] LNet: Removed LNI 192.168.203.39@tcp [ 3327.894508] Key type .llcrypt unregistered [ 3327.900993] Key type ._llcrypt unregistered [ 3343.215273] Key type ._llcrypt registered [ 3343.217547] Key type .llcrypt registered [ 3344.649676] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 09:39:57 (1788442797) [ 3347.161994] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3347.321804] alg: No test for adler32 (adler32-zlib) [ 3348.590968] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 3348.927787] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 3350.631319] Key type lgssc registered [ 3352.024335] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3405.075811] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3411.123916] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3436.506363] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3439.451767] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3444.648971] Lustre: Unmounted lustre-client [ 3445.249908] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3448.633951] Lustre: Unmounted lustre-client [ 3482.059295] Key type lgssc unregistered [ 3482.467978] LNet: 75222:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3482.490425] LNetError: 75222:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3482.529620] LNet: Removed LNI 192.168.203.39@tcp [ 3483.392514] Key type .llcrypt unregistered [ 3483.397476] Key type ._llcrypt unregistered [ 3495.380945] Key type ._llcrypt registered [ 3495.401225] Key type .llcrypt registered [ 3496.012876] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3496.024139] alg: No test for adler32 (adler32-zlib) [ 3497.191214] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 3497.377713] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 3499.039270] Key type lgssc registered [ 3500.258163] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3553.653313] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3559.944939] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3583.990922] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3585.873576] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3594.949528] Lustre: Unmounted lustre-client [ 3623.737687] Key type lgssc unregistered [ 3623.973404] LNet: 78257:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3623.979175] LNetError: 78257:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3624.001067] LNet: Removed LNI 192.168.203.39@tcp [ 3624.854184] Key type .llcrypt unregistered [ 3624.860192] Key type ._llcrypt unregistered [ 3642.605941] Key type ._llcrypt registered [ 3642.608513] Key type .llcrypt registered [ 3644.263757] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 09:44:56 (1788443096) [ 3646.642341] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3646.690417] alg: No test for adler32 (adler32-zlib) [ 3647.877952] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 3648.218278] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 3650.015193] Key type lgssc registered [ 3651.224255] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3703.247404] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3710.553719] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3737.213592] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3740.094312] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3746.165757] Lustre: lustre: root_squash is set to 0:0 [ 3756.111154] Lustre: lustre: nosquash_nids is cleared [ 3756.160532] Lustre: lustre: root_squash is set to 500:500 [ 3765.827900] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.39@tcp 192.168.0.[2,10]@tcp [ 3772.081318] Lustre: lustre: nosquash_nids set to 192.168.203.39/24@tcp [ 3778.802169] Lustre: Unmounted lustre-client [ 3805.295425] Key type lgssc unregistered [ 3805.556932] LNet: 82196:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3805.568869] LNetError: 82196:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3805.593918] LNet: Removed LNI 192.168.203.39@tcp [ 3806.230218] Key type .llcrypt unregistered [ 3806.236693] Key type ._llcrypt unregistered [ 3820.902784] Key type ._llcrypt registered [ 3820.904900] Key type .llcrypt registered [ 3822.184346] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 09:47:55 (1788443275) [ 3824.826914] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3826.627781] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 09:47:59 (1788443279) [ 3829.234961] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3829.283613] alg: No test for adler32 (adler32-zlib) [ 3830.319293] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 3830.605703] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 3832.351300] Key type lgssc registered [ 3833.356519] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3884.648410] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3890.888196] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3912.627740] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3913.213259] Lustre: lustre: root_squash is set to 500:500 [ 3913.246488] Lustre: lustre: nosquash_nids set to 192.168.203.39/24@tcp [ 3914.442956] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 3923.776958] Lustre: Unmounted lustre-client [ 3951.586857] Key type lgssc unregistered [ 3951.871850] LNet: 86151:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3951.882357] LNetError: 86151:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3951.906853] LNet: Removed LNI 192.168.203.39@tcp [ 3952.763978] Key type .llcrypt unregistered [ 3952.766982] Key type ._llcrypt unregistered [ 3968.308400] Key type ._llcrypt registered [ 3968.310654] Key type .llcrypt registered [ 3969.340279] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3971.115578] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 09:50:24 (1788443424) [ 3988.367049] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3988.540949] alg: No test for adler32 (adler32-zlib) [ 3989.671514] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 3989.927700] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 3991.655232] Key type lgssc registered [ 3992.980751] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4070.393268] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4076.424530] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4104.345934] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4181.994176] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4188.476452] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4211.635537] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4226.506745] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 4266.073414] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8c40476be800.ost_server_uuid 50 [ 4267.556626] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8c40476be800.ost_server_uuid in IDLE state after 0 sec [ 4268.321167] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 4274.401315] Lustre: Unmounted lustre-client [ 4276.857906] Lustre: Unmounted lustre-client [ 4323.551552] Key type lgssc unregistered [ 4323.905910] LNet: 93836:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4323.920173] LNetError: 93836:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4323.946468] LNet: Removed LNI 192.168.203.39@tcp [ 4324.871071] Key type .llcrypt unregistered [ 4324.872840] Key type ._llcrypt unregistered [ 4355.775853] Key type ._llcrypt registered [ 4355.779965] Key type .llcrypt registered [ 4357.266641] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 09:56:50 (1788443810) [ 4377.918880] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4378.160416] alg: No test for adler32 (adler32-zlib) [ 4379.449992] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 4379.850985] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 4381.641364] Key type lgssc registered [ 4382.969770] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4471.416394] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4476.938605] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4503.439567] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4505.404282] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 4527.073642] Lustre: 95195:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788443965/real 1788443965] req@000000006999529e x1875319281685632/t0(0) o400->lustre-OST0000-osc-ffff8c40476b8000@192.168.203.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1788443981 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4527.107279] Lustre: lustre-OST0000-osc-ffff8c40476b8000: Connection to lustre-OST0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4532.233125] Lustre: 95195:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788443970/real 1788443970] req@000000008c7ba324 x1875319281686144/t0(0) o400->lustre-OST0000-osc-ffff8c40476b8000@192.168.203.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1788443986 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4537.312352] Lustre: 95196:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788443975/real 1788443975] req@00000000e6cf2353 x1875319281686656/t0(0) o400->lustre-OST0000-osc-ffff8c40476b8000@192.168.203.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1788443991 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4538.919545] Lustre: lustre-OST0000-osc-ffff8c40476b8000: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 4542.050276] Lustre: 95196:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788443980/real 1788443980] req@00000000bec922a1 x1875319281687168/t0(0) o400->lustre-OST0000-osc-ffff8c40476b8000@192.168.203.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1788443996 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4542.445757] Lustre: lustre-MDT0000-mdc-ffff8c40476b8000: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4557.791282] Lustre: 95195:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788443996/real 1788443996] req@00000000de71a171 x1875319281689472/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788444012 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4557.858489] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [ 4568.057122] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0x220f3a9c7837b9a to 0x220f3a9c7837d30 [ 4568.089360] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 4574.136583] Lustre: lustre-MDT0000-mdc-ffff8c40476b8000: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 4585.269824] Lustre: Unmounted lustre-client [ 4624.126671] Key type lgssc unregistered [ 4624.409392] LNet: 99514:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4624.425083] LNetError: 99514:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4624.448976] LNet: Removed LNI 192.168.203.39@tcp [ 4625.293321] Key type .llcrypt unregistered [ 4625.295310] Key type ._llcrypt unregistered [ 4644.995435] Key type ._llcrypt registered [ 4644.999714] Key type .llcrypt registered [ 4647.047776] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 10:01:39 (1788444099) [ 4662.917991] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4662.941753] alg: No test for adler32 (adler32-zlib) [ 4664.160783] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 4664.692429] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 4666.391282] Key type lgssc registered [ 4668.941627] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4715.264032] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4821.660982] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4827.593655] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4852.203934] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4855.264333] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 4858.215022] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4860.610119] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 10:05:13 (1788444313) [ 5134.872443] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5145.202271] Lustre: Unmounted lustre-client [ 5270.153307] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5277.470043] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5307.765278] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5352.048283] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:13:24 (1788444804) [ 5452.553985] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5458.925531] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5488.729422] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5489.495766] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 5496.169515] Lustre: Unmounted lustre-client [ 5532.104462] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:16:24 (1788444984) [ 5632.663957] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5638.163468] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5666.559632] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5667.372693] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 5671.876950] Lustre: Unmounted lustre-client [ 5717.205511] Key type lgssc unregistered [ 5717.597237] LNet: 122551:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5717.604593] LNetError: 122551:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5717.629421] LNet: Removed LNI 192.168.203.39@tcp [ 5718.604889] Key type .llcrypt unregistered [ 5718.620159] Key type ._llcrypt unregistered [ 5740.023965] Key type ._llcrypt registered [ 5740.033735] Key type .llcrypt registered [ 5741.503378] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 10:19:54 (1788445194) [ 5743.996047] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5744.061247] alg: No test for adler32 (adler32-zlib) [ 5745.199948] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 5745.557285] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 5747.305229] Key type lgssc registered [ 5748.416581] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5801.680572] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5807.590637] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5830.515920] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5832.541920] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 5849.975633] Lustre: Unmounted lustre-client [ 5878.753703] Key type lgssc unregistered [ 5879.049705] LNet: 126146:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5879.068935] LNetError: 126146:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5879.092854] LNet: Removed LNI 192.168.203.39@tcp [ 5880.029526] Key type .llcrypt unregistered [ 5880.040638] Key type ._llcrypt unregistered [ 5898.610165] Key type ._llcrypt registered [ 5898.611753] Key type .llcrypt registered [ 5900.446412] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 10:22:32 (1788445352) [ 5902.984816] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5903.034523] alg: No test for adler32 (adler32-zlib) [ 5904.110128] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 5904.388637] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 5906.103199] Key type lgssc registered [ 5907.790696] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5959.528219] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5967.307827] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5989.875768] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5992.897408] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 5998.059681] Lustre: lustre-OST0000-osc-ffff8c4043124800: Connection to lustre-OST0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6011.145561] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8c4043124800.ost_server_uuid 50 [ 6013.150896] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6025.408372] Lustre: Unmounted lustre-client [ 6049.297765] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 10:25:02 (1788445502) [ 6083.174648] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6089.281664] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6112.344766] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6144.133355] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6144.868480] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 6150.123163] Lustre: lustre-OST0000-osc-ffff8c4050e8d800: Connection to lustre-OST0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6185.746902] Lustre: Unmounted lustre-client [ 6235.350702] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 10:28:08 (1788445688) [ 6274.878287] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6281.179876] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6304.366272] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6326.376759] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6327.023816] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 6332.423545] Lustre: lustre-OST0000-osc-ffff8c404600b000: Connection to lustre-OST0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6349.828680] Lustre: Unmounted lustre-client [ 6399.178687] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 10:30:52 (1788445852) [ 6500.025101] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6506.128373] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6529.936367] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6601.887235] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6608.281047] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6635.737383] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6678.020744] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 6723.655250] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6725.461652] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6728.398952] Lustre: Unmounted lustre-client [ 6772.264718] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 10:37:05 (1788446225) [ 6810.148958] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6816.305449] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6838.098331] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6870.787652] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6900.896801] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 6947.573194] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6948.826403] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6961.130845] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6971.485805] Lustre: Unmounted lustre-client [ 7032.849542] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 10:41:26 (1788446486) [ 7064.530318] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7070.238206] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7091.235363] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7091.729551] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7115.228665] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7116.798933] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7132.763933] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8c40505d8000.ost_server_uuid 50 [ 7134.142326] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8c40505d8000.ost_server_uuid in IDLE state after 0 sec [ 7136.851137] Lustre: Unmounted lustre-client [ 7137.259539] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7137.272788] Lustre: Skipped 3 previous similar messages [ 7137.352085] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7138.523731] LustreError: 149574:0:(sec.c:403:import_sec_validate_get()) import 00000000e644c618 (NEW) with no sec [ 7203.315715] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 10:44:16 (1788446656) [ 7235.960447] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7242.945360] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7267.353626] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7287.483623] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7288.032689] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7288.197467] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7300.184056] Lustre: Unmounted lustre-client [ 7300.187817] Lustre: Skipped 1 previous similar message [ 7345.036400] Key type lgssc unregistered [ 7345.313172] LNet: 152981:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7345.325266] LNetError: 152981:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7345.356650] LNet: Removed LNI 192.168.203.39@tcp [ 7346.069952] Key type .llcrypt unregistered [ 7346.072046] Key type ._llcrypt unregistered [ 7360.470720] Key type ._llcrypt registered [ 7360.472752] Key type .llcrypt registered [ 7361.760657] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 10:46:54 (1788446814) [ 7362.687255] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7362.800700] alg: No test for adler32 (adler32-zlib) [ 7363.909866] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 7364.130162] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 7365.855253] Key type lgssc registered [ 7366.910307] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7421.356528] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7426.633183] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7448.941448] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7470.109600] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7471.566345] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7472.786506] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7476.706994] LustreError: lustre-MDT0001-mdc-ffff8c4042e8a800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7476.732332] Lustre: lustre-MDT0001-mdc-ffff8c4042e8a800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 7482.324691] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7483.662949] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7503.879402] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7508.785360] Lustre: Unmounted lustre-client [ 7543.798375] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 10:49:56 (1788446996) [ 7633.726250] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7639.261896] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7662.247669] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7662.913743] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7688.554695] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7690.174993] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7693.319283] Lustre: lustre-OST0001-osc-ffff8c4051cc5000: Connection to lustre-OST0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7702.604564] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7712.921688] Lustre: Unmounted lustre-client [ 7750.688251] Key type lgssc unregistered [ 7750.967823] LNet: 162584:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7750.977054] LNetError: 162584:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7751.017211] LNet: Removed LNI 192.168.203.39@tcp [ 7752.019723] Key type .llcrypt unregistered [ 7752.022548] Key type ._llcrypt unregistered [ 7784.176431] Key type ._llcrypt registered [ 7784.178535] Key type .llcrypt registered [ 7785.577874] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 10:53:58 (1788447238) [ 7787.949246] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7787.962183] alg: No test for adler32 (adler32-zlib) [ 7789.162173] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 7789.481219] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 7791.207255] Key type lgssc registered [ 7792.499279] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7842.353933] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7848.051961] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7868.192862] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7869.897768] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7916.432127] Lustre: Unmounted lustre-client [ 7957.056983] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7957.755860] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 7994.299567] Lustre: Unmounted lustre-client [ 8025.173235] Key type lgssc unregistered [ 8025.428805] LNet: 167031:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8025.440056] LNetError: 167031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8025.461494] LNet: Removed LNI 192.168.203.39@tcp [ 8026.403169] Key type .llcrypt unregistered [ 8026.405759] Key type ._llcrypt unregistered [ 8041.206750] Key type ._llcrypt registered [ 8041.211396] Key type .llcrypt registered [ 8042.630440] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 10:58:15 (1788447495) [ 8044.933078] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8044.982288] alg: No test for adler32 (adler32-zlib) [ 8045.984973] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 8046.227719] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8047.983148] Key type lgssc registered [ 8049.210080] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8095.787940] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8101.223388] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8125.684631] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8128.372486] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 8149.484909] Lustre: Unmounted lustre-client [ 8175.924212] Key type lgssc unregistered [ 8176.119946] LNet: 170792:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8176.126295] LNetError: 170792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8176.145943] LNet: Removed LNI 192.168.203.39@tcp [ 8176.651468] Key type .llcrypt unregistered [ 8176.654127] Key type ._llcrypt unregistered [ 8189.845615] Key type ._llcrypt registered [ 8189.865097] Key type .llcrypt registered [ 8190.315506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8190.338890] alg: No test for adler32 (adler32-zlib) [ 8191.497239] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 8191.907627] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8193.711303] Key type lgssc registered [ 8195.174456] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8245.147855] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8251.120959] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8273.232449] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8275.026777] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 8285.678576] Lustre: Unmounted lustre-client [ 8311.591824] Key type lgssc unregistered [ 8311.850572] LNet: 173872:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8311.863449] LNetError: 173872:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8311.880413] LNet: Removed LNI 192.168.203.39@tcp [ 8312.663837] Key type .llcrypt unregistered [ 8312.670352] Key type ._llcrypt unregistered [ 8331.089768] Key type ._llcrypt registered [ 8331.092337] Key type .llcrypt registered [ 8333.419911] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:03:05 (1788447785) [ 8337.007589] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8337.042233] alg: No test for adler32 (adler32-zlib) [ 8338.284699] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 8338.538741] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8340.231199] Key type lgssc registered [ 8341.314614] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8386.829314] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8394.448887] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8417.246641] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8420.040043] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 8442.754584] Lustre: Unmounted lustre-client [ 8470.539296] Key type lgssc unregistered [ 8470.843151] LNet: 177626:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8470.857737] LNetError: 177626:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8470.877883] LNet: Removed LNI 192.168.203.39@tcp [ 8471.527897] Key type .llcrypt unregistered [ 8471.535115] Key type ._llcrypt unregistered [ 8483.836740] Key type ._llcrypt registered [ 8483.843215] Key type .llcrypt registered [ 8484.236361] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8484.247982] alg: No test for adler32 (adler32-zlib) [ 8485.336752] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 8485.565480] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8487.248352] Key type lgssc registered [ 8488.440175] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8541.832308] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8549.660732] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8573.637797] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8575.433060] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 8581.655159] Lustre: Unmounted lustre-client [ 8606.721625] Key type lgssc unregistered [ 8606.935555] LNet: 180694:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8606.940203] LNetError: 180694:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8606.961086] LNet: Removed LNI 192.168.203.39@tcp [ 8607.459808] Key type .llcrypt unregistered [ 8607.462185] Key type ._llcrypt unregistered [ 8618.988267] Key type ._llcrypt registered [ 8618.990397] Key type .llcrypt registered [ 8619.980803] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:07:53 (1788448073) [ 8638.790603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8638.808343] alg: No test for adler32 (adler32-zlib) [ 8639.851697] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 8639.999944] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8641.647181] Key type lgssc registered [ 8642.740038] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8739.383510] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8746.350614] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8772.306556] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8814.940393] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:11:07 (1788448267) [ 8849.542531] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8856.802263] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8879.466695] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8882.282096] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 8887.198539] Lustre: Unmounted lustre-client [ 8925.452700] Key type lgssc unregistered [ 8925.710963] LNet: 187798:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8925.732840] LNetError: 187798:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8925.760207] LNet: Removed LNI 192.168.203.39@tcp [ 8926.783591] Key type .llcrypt unregistered [ 8926.785081] Key type ._llcrypt unregistered [ 8942.841986] Key type ._llcrypt registered [ 8942.845051] Key type .llcrypt registered [ 8944.522704] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8946.380130] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:13:19 (1788448399) [ 8966.870464] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8966.881552] alg: No test for adler32 (adler32-zlib) [ 8968.011262] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 8968.329627] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8970.023300] Key type lgssc registered [ 8971.394772] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9077.452491] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9084.133682] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9108.483378] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9130.583622] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9132.366222] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 9154.216198] Lustre: Unmounted lustre-client [ 9286.408495] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9293.079097] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9315.232186] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9371.418438] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 11:20:24 (1788448824) [ 9372.662671] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9374.137680] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 11:20:27 (1788448827) [ 9460.509531] Key type lgssc unregistered [ 9460.803050] LNet: 199238:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9460.813138] LNetError: 199238:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9460.839231] LNet: Removed LNI 192.168.203.39@tcp [ 9461.497487] Key type .llcrypt unregistered [ 9461.500293] Key type ._llcrypt unregistered [ 9475.947508] Key type ._llcrypt registered [ 9475.950723] Key type .llcrypt registered [ 9477.294959] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 11:22:10 (1788448930) [ 9518.233992] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9518.279141] alg: No test for adler32 (adler32-zlib) [ 9519.479278] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 9519.864973] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 9521.647206] Key type lgssc registered [ 9523.268321] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9573.391083] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9579.324054] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9618.047729] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9665.928676] Key type lgssc unregistered [ 9666.325717] LNet: 202975:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9666.332574] LNetError: 202975:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9666.361475] LNet: Removed LNI 192.168.203.39@tcp [ 9667.247885] Key type .llcrypt unregistered [ 9667.249717] Key type ._llcrypt unregistered [ 9683.093829] Key type ._llcrypt registered [ 9683.096472] Key type .llcrypt registered [ 9684.580214] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 11:25:37 (1788449137) [ 9687.140271] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9687.253034] alg: No test for adler32 (adler32-zlib) [ 9688.364269] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 9688.635457] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 9690.327309] Key type lgssc registered [ 9691.541870] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9744.608354] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9750.809962] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9775.787612] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9777.557485] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [ 9793.010718] Lustre: lustre-MDT0000-mdc-ffff8c4046667000: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9803.254048] Lustre: lustre-MDT0001-mdc-ffff8c4046667000: Connection to lustre-MDT0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9814.495188] Lustre: 203965:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788449252/real 1788449252] req@00000000437e5aed x1875324848652928/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788449268 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9814.555046] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [ 9839.144705] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0x68bea8e5e531ad26 to 0x68bea8e5e531c926 [ 9839.153097] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 9863.670502] LustreError: lustre-MDT0000-mdc-ffff8c4046667000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9863.734666] Lustre: lustre-MDT0000-mdc-ffff8c4046667000: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 9870.375983] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9871.998373] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9877.609770] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9879.138865] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9882.241793] Lustre: Unmounted lustre-client [ 9907.961440] Key type lgssc unregistered [ 9908.197901] LNet: 207923:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9908.208744] LNetError: 207923:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9908.230562] LNet: Removed LNI 192.168.203.39@tcp [ 9908.893433] Key type .llcrypt unregistered [ 9908.896033] Key type ._llcrypt unregistered [ 9924.428935] Key type ._llcrypt registered [ 9924.433543] Key type .llcrypt registered [ 9925.837341] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 11:29:38 (1788449378) [ 9927.982754] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9928.000564] alg: No test for adler32 (adler32-zlib) [ 9929.163799] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [ 9929.478497] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 9931.151435] Key type lgssc registered [ 9932.602780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9987.924883] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9994.729568] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10054.482851] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10060.332656] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10094.556135] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10117.787473] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10157.403438] Key type lgssc unregistered [10157.652527] LNet: 213218:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10157.664942] LNetError: 213218:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10157.687858] LNet: Removed LNI 192.168.203.39@tcp [10158.391741] Key type .llcrypt unregistered [10158.398224] Key type ._llcrypt unregistered [10201.638746] Key type ._llcrypt registered [10201.641420] Key type .llcrypt registered [10203.169301] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 11:34:15 (1788449655) [10243.597368] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10243.736193] alg: No test for adler32 (adler32-zlib) [10245.210060] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [10245.646958] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [10247.423640] Key type lgssc registered [10248.997526] Lustre: Echo OBD driver; http://www.lustre.org/ [10337.191716] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10343.219248] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10365.241650] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10408.314707] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 11:37:41 (1788449861) [10416.672902] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 11:37:49 (1788449869) [10454.390494] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10461.159445] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10484.283333] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10485.994588] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [10492.127778] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10494.566585] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10497.053946] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10499.202302] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10501.611683] Lustre: lustre-MDT0000-mdc-ffff8c4051d1d800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [10516.962375] Lustre: 215109:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788449955/real 1788449955] req@0000000038340bfc x1875325432637184/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788449971 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10516.991806] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [10527.276602] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0xc01fbb280922671 to 0xc01fbb2809228fc [10527.309131] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [10537.867446] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10539.700453] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10544.521912] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10547.697052] Lustre: lustre-MDT0000-mdc-ffff8c4051d1d800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [10564.063194] Lustre: 215110:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788450002/real 1788450002] req@00000000e363f0c0 x1875325432645632/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788450018 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10564.111635] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [10574.325800] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0xc01fbb2809228fc to 0xc01fbb280922b5d [10574.348910] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [10574.357613] Lustre: Skipped 1 previous similar message [10579.862914] Lustre: lustre-MDT0000-mdc-ffff8c4051d1d800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [10589.725184] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10591.456387] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10595.903811] Lustre: Unmounted lustre-client [10672.201073] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10679.137425] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10702.766147] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10703.373936] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [10711.233391] Lustre: Unmounted lustre-client [10740.150285] Key type lgssc unregistered [10740.488123] LNet: 225698:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10740.492122] LNetError: 225698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10740.521274] LNet: Removed LNI 192.168.203.39@tcp [10741.328588] Key type .llcrypt unregistered [10741.331668] Key type ._llcrypt unregistered [10758.675154] Key type ._llcrypt registered [10758.677528] Key type .llcrypt registered [10759.838596] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 11:43:32 (1788450212) [10764.885062] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10764.907741] alg: No test for adler32 (adler32-zlib) [10766.112648] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [10766.517882] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [10768.175198] Key type lgssc registered [10769.330366] Lustre: Echo OBD driver; http://www.lustre.org/ [10822.704227] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10828.647388] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10850.196376] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10852.857901] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [10862.420531] Lustre: Unmounted lustre-client [10921.566803] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10927.390667] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10947.837320] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10948.347229] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [10956.985179] Lustre: Unmounted lustre-client [11024.005166] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11029.398760] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11049.147865] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11049.816872] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [11051.874247] Lustre: Unmounted lustre-client [11078.320384] Key type lgssc unregistered [11078.561266] LNet: 232733:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11078.566466] LNetError: 232733:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11078.583816] LNet: Removed LNI 192.168.203.39@tcp [11079.175661] Key type .llcrypt unregistered [11079.183333] Key type ._llcrypt unregistered [11093.752735] Key type ._llcrypt registered [11093.754983] Key type .llcrypt registered [11094.773699] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 11:49:07 (1788450547) [11098.127059] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11098.328945] alg: No test for adler32 (adler32-zlib) [11099.450559] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [11099.746873] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11101.447588] Key type lgssc registered [11102.753923] Lustre: Echo OBD driver; http://www.lustre.org/ [11147.011902] Key type lgssc unregistered [11147.263344] LNet: 235051:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11147.272626] LNetError: 235051:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11147.286698] LNet: Removed LNI 192.168.203.39@tcp [11148.087817] Key type .llcrypt unregistered [11148.094216] Key type ._llcrypt unregistered [11179.072247] Key type ._llcrypt registered [11179.085366] Key type .llcrypt registered [11179.376407] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11179.407812] alg: No test for adler32 (adler32-zlib) [11180.566503] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [11180.816455] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11182.487490] Key type lgssc registered [11183.845731] Lustre: Echo OBD driver; http://www.lustre.org/ [11271.684681] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11278.575902] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11303.505921] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11343.952352] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11345.595919] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 11:53:18 (1788450798) [11374.863708] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11380.653571] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11398.669112] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11419.336609] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11420.894466] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [11426.292706] Lustre: lustre-OST0001-osc-ffff8c405046d800: Connection to lustre-OST0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [11432.943049] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11443.283990] Lustre: Unmounted lustre-client [11479.667264] Key type lgssc unregistered [11479.924402] LNet: 242157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11479.937036] LNetError: 242157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11479.966160] LNet: Removed LNI 192.168.203.39@tcp [11480.855631] Key type .llcrypt unregistered [11480.860924] Key type ._llcrypt unregistered [11509.609529] Key type ._llcrypt registered [11509.612412] Key type .llcrypt registered [11510.829247] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 11:56:03 (1788450963) [11522.947772] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11522.958320] alg: No test for adler32 (adler32-zlib) [11524.023062] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [11524.250694] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11525.911220] Key type lgssc registered [11527.122754] Lustre: Echo OBD driver; http://www.lustre.org/ [11578.286293] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11583.819083] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11606.788404] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 11:57:39 (1788451059) [11641.260942] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11646.450291] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11665.469520] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11668.224661] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [11680.281760] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11684.554891] Lustre: Unmounted lustre-client [11785.545977] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11791.655506] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11844.484799] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11845.145179] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [11847.778113] Lustre: Unmounted lustre-client [11875.189532] Key type lgssc unregistered [11875.459994] LNet: 249879:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11875.472486] LNetError: 249879:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11875.503733] LNet: Removed LNI 192.168.203.39@tcp [11876.137210] Key type .llcrypt unregistered [11876.140304] Key type ._llcrypt unregistered [11904.010928] Key type ._llcrypt registered [11904.014087] Key type .llcrypt registered [11904.296989] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11904.322620] alg: No test for adler32 (adler32-zlib) [11905.411931] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [11905.606610] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11907.255765] Key type lgssc registered [11908.437808] Lustre: Echo OBD driver; http://www.lustre.org/ [11995.954455] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12002.594538] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12028.379290] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12070.284442] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12072.259304] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 12:05:25 (1788451525) [12106.616801] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12112.663282] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12134.249559] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12138.756160] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [12142.448688] Lustre: Unmounted lustre-client [12179.557831] Key type lgssc unregistered [12179.823957] LNet: 256512:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12179.830586] LNetError: 256512:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12179.851565] LNet: Removed LNI 192.168.203.39@tcp [12180.515539] Key type .llcrypt unregistered [12180.517664] Key type ._llcrypt unregistered [12197.654399] Key type ._llcrypt registered [12197.656270] Key type .llcrypt registered [12198.716947] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12200.118757] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 12:07:33 (1788451653) [12208.319570] Key type .llcrypt unregistered [12208.323111] Key type ._llcrypt unregistered [12216.753993] Key type ._llcrypt registered [12216.755700] Key type .llcrypt registered [12217.001932] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12217.018955] alg: No test for adler32 (adler32-zlib) [12218.115120] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [12218.384916] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12220.119449] Key type lgssc registered [12221.251225] Lustre: Echo OBD driver; http://www.lustre.org/ [12275.575714] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12292.324715] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [12295.534341] Lustre: Unmounted lustre-client [12323.132380] Key type lgssc unregistered [12323.366527] LNet: 259958:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12323.374629] LNetError: 259958:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12323.389924] LNet: Removed LNI 192.168.203.39@tcp [12324.018465] Key type .llcrypt unregistered [12324.024216] Key type ._llcrypt unregistered [12340.579382] Key type ._llcrypt registered [12340.582724] Key type .llcrypt registered [12341.783897] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 12:09:54 (1788451794) [12344.102168] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12344.152655] alg: No test for adler32 (adler32-zlib) [12345.215753] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [12345.485781] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12347.175195] Key type lgssc registered [12348.394767] Lustre: Echo OBD driver; http://www.lustre.org/ [12433.585665] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12470.366682] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12477.242094] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12480.497457] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [12483.755257] Lustre: Unmounted lustre-client [12508.848507] Key type lgssc unregistered [12509.041277] LNet: 263496:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12509.051467] LNetError: 263496:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12509.069301] LNet: Removed LNI 192.168.203.39@tcp [12509.616594] Key type .llcrypt unregistered [12509.623610] Key type ._llcrypt unregistered [12525.813873] Key type ._llcrypt registered [12525.818902] Key type .llcrypt registered [12527.214633] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 12:13:00 (1788451980) [12529.470783] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12529.542827] alg: No test for adler32 (adler32-zlib) [12530.598048] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [12530.890076] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12532.639796] Key type lgssc registered [12533.690374] Lustre: Echo OBD driver; http://www.lustre.org/ [12588.849916] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12594.949938] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12617.110715] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12619.896091] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [12624.872740] Lustre: lustre-MDT0000-mdc-ffff8c4051cc7000: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [12627.677135] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12627.716946] LustreError: 266652:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12628.598401] LustreError: 266663:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12628.614045] LustreError: 266663:0:(file.c:6167:ll_inode_revalidate_fini()) Skipped 3 previous similar messages [12628.836254] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [12628.923357] Lustre: Unmounted lustre-client [12649.615238] Key type lgssc unregistered [12650.033636] LNet: 267067:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12650.042188] LNetError: 267067:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12650.065558] LNet: Removed LNI 192.168.203.39@tcp [12650.849759] Key type .llcrypt unregistered [12650.854199] Key type ._llcrypt unregistered [12666.802970] Key type ._llcrypt registered [12666.809461] Key type .llcrypt registered [12668.054826] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 12:15:21 (1788452121) [12670.345374] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12670.398427] alg: No test for adler32 (adler32-zlib) [12671.570112] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [12671.838486] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12673.551331] Key type lgssc registered [12674.554634] Lustre: Echo OBD driver; http://www.lustre.org/ [12729.283490] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12735.809974] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12757.478161] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12759.205119] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [12777.918530] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12780.094919] Lustre: Unmounted lustre-client [12800.095362] Key type lgssc unregistered [12800.368277] LNet: 270643:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12800.373894] LNetError: 270643:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12800.387103] LNet: Removed LNI 192.168.203.39@tcp [12801.047464] Key type .llcrypt unregistered [12801.050879] Key type ._llcrypt unregistered [12816.409668] Key type ._llcrypt registered [12816.413884] Key type .llcrypt registered [12817.543561] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 12:17:50 (1788452270) [12836.112748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12836.160945] alg: No test for adler32 (adler32-zlib) [12837.249653] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [12837.584862] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12839.314093] Key type lgssc registered [12840.948722] Lustre: Echo OBD driver; http://www.lustre.org/ [12956.787462] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12958.603155] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [13005.289102] Lustre: lustre-MDT0001-mdc-ffff8c40531c6000: Connection to lustre-MDT0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [13015.548702] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13025.966313] Lustre: Unmounted lustre-client [13056.326716] Key type lgssc unregistered [13056.541750] LNet: 276424:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13056.555086] LNetError: 276424:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13056.579529] LNet: Removed LNI 192.168.203.39@tcp [13057.276993] Key type .llcrypt unregistered [13057.286593] Key type ._llcrypt unregistered [13073.713381] Key type ._llcrypt registered [13073.715481] Key type .llcrypt registered [13075.485253] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 12:22:07 (1788452527) [13077.219414] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13078.906893] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 12:22:12 (1788452532) [13080.708444] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13082.523356] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 12:22:15 (1788452535) [13084.541651] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13086.264371] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 12:22:19 (1788452539) [13088.231300] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13089.934743] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 12:22:22 (1788452542) [13091.580442] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13094.415735] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 12:22:26 (1788452546) [13105.685481] Key type .llcrypt unregistered [13105.693196] Key type ._llcrypt unregistered [13113.828712] Key type ._llcrypt registered [13113.857634] Key type .llcrypt registered [13114.367486] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13114.384307] alg: No test for adler32 (adler32-zlib) [13115.422719] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [13115.696055] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [13117.415146] Key type lgssc registered [13118.716152] Lustre: Echo OBD driver; http://www.lustre.org/ [13197.587808] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13203.351298] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13227.030329] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13228.608847] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [13231.796314] Lustre: Unmounted lustre-client [13268.802547] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 12:25:21 (1788452721) [13302.778695] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13308.503989] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13345.228331] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13351.469716] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [13353.040722] Lustre: Unmounted lustre-client [13398.591418] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 12:27:31 (1788452851) [13404.447375] LNet: 1 local NIs in recovery (showing 1): 192.168.203.39@tcp [14056.771683] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14063.788891] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14100.868754] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14209.035865] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 12:41:01 (1788453661) [14221.765348] Key type lgssc unregistered [14222.084358] LNet: 289941:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14222.093079] LNetError: 289941:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14223.149251] LNet: Removed LNI 192.168.203.39@tcp [14223.988930] Key type .llcrypt unregistered [14223.994247] Key type ._llcrypt unregistered [14350.355610] Key type ._llcrypt registered [14350.358292] Key type .llcrypt registered [14350.851763] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14350.878539] alg: No test for adler32 (adler32-zlib) [14351.970862] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [14352.187305] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [14353.871253] Key type lgssc registered [14355.210630] Lustre: Echo OBD driver; http://www.lustre.org/ [14453.454996] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14461.630753] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14484.436276] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14519.290949] Key type lgssc unregistered [14519.540624] LNet: 293633:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14519.547756] LNetError: 293633:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14519.572333] LNet: Removed LNI 192.168.203.39@tcp [14520.137889] Key type .llcrypt unregistered [14520.142412] Key type ._llcrypt unregistered [14532.870044] Key type ._llcrypt registered [14532.884235] Key type .llcrypt registered [14534.384544] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 12:46:27 (1788453987) [14555.838412] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14555.876747] alg: No test for adler32 (adler32-zlib) [14556.935652] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [14557.179936] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [14558.881458] Key type lgssc registered [14559.945309] Lustre: Echo OBD driver; http://www.lustre.org/ [14612.619247] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 12:47:45 (1788454065) [14624.814268] Key type lgssc unregistered [14625.342784] LNet: 297185:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14625.364788] LNetError: 297185:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14625.387746] LNet: Removed LNI 192.168.203.39@tcp [14626.083115] Key type .llcrypt unregistered [14626.086808] Key type ._llcrypt unregistered [14637.483848] Key type ._llcrypt registered [14637.487713] Key type .llcrypt registered [14638.216114] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14638.233774] alg: No test for adler32 (adler32-zlib) [14639.301314] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [14639.526100] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [14641.239214] Key type lgssc registered [14643.440774] Lustre: Echo OBD driver; http://www.lustre.org/ [14704.374053] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14711.302143] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14736.862915] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15035.617560] LNet: Added LNI 192.168.203.39@tcp50 [8/256/0/180] [15038.238339] LNet: Removed LNI 192.168.203.39@tcp [15040.462445] Lustre: 301578:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8c4052af9800: config has no valid NIDs, force dynamic NIDs [15041.770807] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [15041.962167] Lustre: Unmounted lustre-client [15044.457623] Key type lgssc unregistered [15044.771291] LNet: 301835:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15044.781429] LNetError: 301835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15044.798772] LNet: Removed LNI 192.168.203.39@tcp50 [15045.514937] Key type .llcrypt unregistered [15045.521919] Key type ._llcrypt unregistered [15064.397073] Key type ._llcrypt registered [15064.401679] Key type .llcrypt registered [15064.726918] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15064.742976] alg: No test for adler32 (adler32-zlib) [15066.018752] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [15066.410712] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [15068.207198] Key type lgssc registered [15069.985462] Lustre: Echo OBD driver; http://www.lustre.org/ [15131.755092] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15138.000585] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15146.380680] LNet: Added LNI 192.168.203.39@tcp50 [8/256/0/180] [15147.736136] LNet: Removed LNI 192.168.203.39@tcp [15149.064947] Lustre: 304520:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8c4043687800: config has no valid NIDs, force dynamic NIDs [15150.377515] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [15151.441955] Lustre: Unmounted lustre-client [15189.395779] Key type lgssc unregistered [15189.846603] LNet: 305389:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15189.854812] LNetError: 305389:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15189.871794] LNet: Removed LNI 192.168.203.39@tcp50 [15190.721651] Key type .llcrypt unregistered [15190.737300] Key type ._llcrypt unregistered [15202.305486] Key type ._llcrypt registered [15202.307751] Key type .llcrypt registered [15203.629958] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 12:57:36 (1788454656) [15224.246834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15224.346944] alg: No test for adler32 (adler32-zlib) [15225.482513] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [15225.959416] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [15227.743182] Key type lgssc registered [15229.524100] Lustre: Echo OBD driver; http://www.lustre.org/ [15332.530106] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15338.133904] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15365.703186] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15403.865897] Key type lgssc unregistered [15404.325370] LNet: 310137:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15404.336257] LNetError: 310137:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15404.363374] LNet: Removed LNI 192.168.203.39@tcp [15405.580527] Key type .llcrypt unregistered [15405.585562] Key type ._llcrypt unregistered [15420.997759] Key type ._llcrypt registered [15421.000669] Key type .llcrypt registered [15422.642375] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 13:01:15 (1788454875) [15427.005109] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15427.033174] alg: No test for adler32 (adler32-zlib) [15428.165601] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [15428.614293] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [15430.375216] Key type lgssc registered [15431.744543] Lustre: Echo OBD driver; http://www.lustre.org/ [15495.937491] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15503.009195] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15530.561919] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15533.441294] Lustre: Mounted lustre-client - version 2.17.58_2_gee80f9b [15605.313756] Lustre: Mounted fs15246-client - version 2.17.58_2_gee80f9b [15622.977580] Lustre: Unmounted fs15246-client [15655.142206] Lustre: Unmounted lustre-client [15686.539930] Key type lgssc unregistered [15686.978192] LNet: 315007:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15686.986171] LNetError: 315007:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15687.031123] LNet: Removed LNI 192.168.203.39@tcp [15688.286842] Key type .llcrypt unregistered [15688.291099] Key type ._llcrypt unregistered [15702.014900] Key type ._llcrypt registered [15702.017570] Key type .llcrypt registered [15704.161970] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 13:05:56 (1788455156) [15707.747203] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15707.788428] alg: No test for adler32 (adler32-zlib) [15709.070383] Lustre: Lustre: Build Version: 2.17.58_2_gee80f9b [15709.340512] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [15711.095200] Key type lgssc registered [15712.715671] Lustre: Echo OBD driver; http://www.lustre.org/ [15885.096967] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15892.856315] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15920.439488] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16043.396675] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15785 sec ========= 13:11:36 (1788455496) [16045.300621] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:11:38 (1788455498) === [16049.383365] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:11:41 (1788455501) === [16087.514963] Key type lgssc unregistered [16087.973615] LNet: 324277:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16087.989160] LNetError: 324277:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16088.018224] LNet: Removed LNI 192.168.203.39@tcp [16089.344304] Key type .llcrypt unregistered [16089.347053] Key type ._llcrypt unregistered