[ 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 841063230 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002484] x2apic enabled [ 0.003008] Switched APIC routing to physical x2apic. [ 0.004012] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008011] pid_max: default: 32768 minimum: 301 [ 0.009129] LSM: Security Framework initializing [ 0.010047] Yama: becoming mindful. [ 0.011027] SELinux: Initializing. [ 0.012059] *** VALIDATE selinux *** [ 0.020721] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025060] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026153] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027096] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028105] *** VALIDATE tmpfs *** [ 0.029439] *** VALIDATE proc *** [ 0.031206] *** VALIDATE cgroup *** [ 0.032008] *** VALIDATE cgroup2 *** [ 0.034040] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036103] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038027] Spectre V2 : User space: Vulnerable [ 0.039008] Speculative Store Bypass: Vulnerable [ 0.042492] debug: unmapping init [mem 0xffffffff90859000-0xffffffff90860fff] [ 0.045233] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046754] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047022] ... version: 2 [ 0.048009] ... bit width: 48 [ 0.049009] ... generic registers: 4 [ 0.050010] ... value mask: 0000ffffffffffff [ 0.051012] ... max period: 00007fffffffffff [ 0.052011] ... fixed-purpose events: 3 [ 0.053010] ... event mask: 000000070000000f [ 0.054381] rcu: Hierarchical SRCU implementation. [ 0.056541] smp: Bringing up secondary CPUs ... [ 0.057690] x86: Booting SMP configuration: [ 0.058023] .... node #0, CPUs: #1 #2 #3 [ 0.067169] smp: Brought up 1 node, 4 CPUs [ 0.069014] smpboot: Max logical packages: 1 [ 0.070010] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.098092] node 0 deferred pages initialised in 26ms [ 0.101565] devtmpfs: initialized [ 0.102212] x86/mm: Memory block size: 128MB [ 0.105229] gcov: version magic: 0x41383552 [ 0.107222] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.108075] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.109312] pinctrl core: initialized pinctrl subsystem [ 0.110177] [ 0.110722] ************************************************************* [ 0.111012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.112009] ** ** [ 0.113011] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.114012] ** ** [ 0.115013] ** This means that this kernel is built to expose internal ** [ 0.116015] ** IOMMU data structures, which may compromise security on ** [ 0.117014] ** your system. ** [ 0.118367] ** ** [ 0.119017] ** If you see this message and you are not debugging the ** [ 0.120025] ** kernel, report this immediately to your vendor! ** [ 0.121045] ** ** [ 0.122039] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.123017] ************************************************************* [ 0.124777] NET: Registered protocol family 16 [ 0.125532] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.126062] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.127065] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.139065] cpuidle: using governor menu [ 0.141447] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.161769] PCI: Using configuration type 1 for base access [ 0.164131] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.187139] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.188018] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.189678] cryptd: max_cpu_qlen set to 1000 [ 0.190377] ACPI: Added _OSI(Module Device) [ 0.191009] ACPI: Added _OSI(Processor Device) [ 0.192041] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.193010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.199106] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.206647] ACPI: Interpreter enabled [ 0.207100] ACPI: PM: (supports S0 S3 S4 S5) [ 0.208014] ACPI: Using IOAPIC for interrupt routing [ 0.210146] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.214555] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.228261] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.230150] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.233018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.237084] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.244893] acpiphp: Slot [2] registered [ 0.246465] acpiphp: Slot [5] registered [ 0.250365] acpiphp: Slot [6] registered [ 0.252110] acpiphp: Slot [3] registered [ 0.254090] acpiphp: Slot [4] registered [ 0.256111] acpiphp: Slot [7] registered [ 0.258129] acpiphp: Slot [8] registered [ 0.259188] acpiphp: Slot [9] registered [ 0.261096] acpiphp: Slot [10] registered [ 0.263093] acpiphp: Slot [11] registered [ 0.264216] acpiphp: Slot [12] registered [ 0.266153] acpiphp: Slot [13] registered [ 0.268141] acpiphp: Slot [14] registered [ 0.270102] acpiphp: Slot [15] registered [ 0.272134] acpiphp: Slot [16] registered [ 0.273231] acpiphp: Slot [17] registered [ 0.275118] acpiphp: Slot [18] registered [ 0.276297] acpiphp: Slot [19] registered [ 0.278093] acpiphp: Slot [20] registered [ 0.280123] acpiphp: Slot [21] registered [ 0.282098] acpiphp: Slot [22] registered [ 0.284087] acpiphp: Slot [23] registered [ 0.286092] acpiphp: Slot [24] registered [ 0.288099] acpiphp: Slot [25] registered [ 0.289107] acpiphp: Slot [26] registered [ 0.291223] acpiphp: Slot [27] registered [ 0.292099] acpiphp: Slot [28] registered [ 0.294099] acpiphp: Slot [29] registered [ 0.296100] acpiphp: Slot [30] registered [ 0.298150] acpiphp: Slot [31] registered [ 0.299056] PCI host bridge to bus 0000:00 [ 0.301022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.304019] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.307019] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.310082] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.313037] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.316041] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.318229] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.322271] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.325761] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.335015] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.340393] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.343018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.346019] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.349019] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.351784] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.355969] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.358228] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.361978] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.367013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.376712] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.381928] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.389802] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.406015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.462014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.500016] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.516712] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.535014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.565015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.590013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.605715] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.608425] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.610341] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.612357] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.614242] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.618173] iommu: Default domain type: Passthrough [ 0.619464] SCSI subsystem initialized [ 0.621137] ACPI: bus type USB registered [ 0.622116] usbcore: registered new interface driver usbfs [ 0.624114] usbcore: registered new interface driver hub [ 0.626077] usbcore: registered new device driver usb [ 0.628145] pps_core: LinuxPPS API ver. 1 registered [ 0.630010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.633051] PTP clock support registered [ 0.635079] EDAC MC: Ver: 3.0.0 [ 0.637147] PCI: Using ACPI for IRQ routing [ 0.640414] NetLabel: Initializing [ 0.642014] NetLabel: domain hash size = 128 [ 0.644012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.646078] NetLabel: unlabeled traffic allowed by default [ 0.649355] vgaarb: loaded [ 0.651113] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.654015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.663432] clocksource: Switched to clocksource kvm-clock [ 0.850541] VFS: Disk quotas dquot_6.6.0 [ 0.851994] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.854705] *** VALIDATE ramfs *** [ 0.856093] *** VALIDATE hugetlbfs *** [ 0.857768] pnp: PnP ACPI init [ 0.860143] pnp: PnP ACPI: found 6 devices [ 0.877312] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.881146] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.883705] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.886971] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.889669] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.892014] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.894902] NET: Registered protocol family 2 [ 0.899709] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.904610] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.923212] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.928157] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.931240] TCP: Hash tables configured (established 65536 bind 65536) [ 0.933667] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.936215] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.938673] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.941072] NET: Registered protocol family 1 [ 0.944960] RPC: Registered named UNIX socket transport module. [ 0.946865] RPC: Registered udp transport module. [ 0.948289] RPC: Registered tcp transport module. [ 0.949735] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.951863] NET: Registered protocol family 44 [ 0.954734] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.956614] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.958926] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.961012] PCI: CLS 0 bytes, default 64 [ 0.962677] Unpacking initramfs... [ 3.066392] debug: unmapping init [mem 0xffff8beffcc64000-0xffff8beffffcffff] [ 3.074168] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 3.077204] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 3.082415] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.887281] Initialise system trusted keyrings [ 3.889199] Key type blacklist registered [ 3.891117] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.900461] zbud: loaded [ 3.903649] *** VALIDATE nfs *** [ 3.905049] *** VALIDATE nfs4 *** [ 3.906778] pstore: using deflate compression [ 3.910729] Platform Keyring initialized [ 4.054509] NET: Registered protocol family 38 [ 4.057574] Key type asymmetric registered [ 4.060488] Asymmetric key parser 'x509' registered [ 4.063434] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 4.070226] io scheduler mq-deadline registered [ 4.075691] io scheduler kyber registered [ 4.081586] io scheduler bfq registered [ 4.085629] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 4.091496] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 4.097421] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 4.101626] ACPI: Power Button [PWRF] [ 4.109702] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 4.138211] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 4.195048] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 4.223669] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 4.252494] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 4.258486] Non-volatile memory driver v1.3 [ 4.260127] Linux agpgart interface v0.103 [ 4.291863] virtio_blk virtio1: [vda] 146744 512-byte logical blocks (75.1 MB/71.7 MiB) [ 4.295390] vda: detected capacity change from 0 to 75132928 [ 4.309527] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 4.313063] vdb: detected capacity change from 0 to 1073741824 [ 4.319264] libphy: Fixed MDIO Bus: probed [ 4.336524] usbcore: registered new interface driver usbserial_generic [ 4.339638] usbserial: USB Serial support registered for generic [ 4.342453] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 4.347685] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 4.353936] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 4.372812] mousedev: PS/2 mouse device common for all mice [ 4.376682] rtc_cmos 00:05: RTC can wake from S4 [ 4.377418] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 4.383225] rtc_cmos 00:05: registered as rtc0 [ 4.390068] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 4.395156] intel_pstate: CPU model not supported [ 4.399664] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 4.402610] hid: raw HID events driver (C) Jiri Kosina [ 4.408016] usbcore: registered new interface driver usbhid [ 4.410615] usbhid: USB HID core driver [ 4.412521] drop_monitor: Initializing network drop monitor service [ 4.415295] Initializing XFRM netlink socket [ 4.418532] NET: Registered protocol family 10 [ 4.422274] Segment Routing with IPv6 [ 4.424070] NET: Registered protocol family 17 [ 4.425459] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 4.428668] mpls_gso: MPLS GSO support [ 4.437516] RAS: Correctable Errors collector initialized. [ 4.439824] AVX version of gcm_enc/dec engaged. [ 4.441677] AES CTR mode by8 optimization enabled [ 4.657477] sched_clock: Marking stable (4657400556, 0)->(6353705896, -1696305340) [ 4.660853] registered taskstats version 1 [ 4.662919] Loading compiled-in X.509 certificates [ 4.665496] zswap: loaded using pool lzo/zbud [ 4.743639] Key type big_key registered [ 4.772709] Key type encrypted registered [ 4.775266] ima: No TPM chip found, activating TPM-bypass! [ 4.779522] ima: Allocated hash algorithm: sha1 [ 4.782905] ima: No architecture policies found [ 4.786265] evm: Initialising EVM extended attributes: [ 4.791788] evm: security.selinux [ 4.794488] evm: security.ima [ 4.796126] evm: security.capability [ 4.797702] evm: HMAC attrs: 0x1 [ 4.802292] rtc_cmos 00:05: setting system clock to 2026-09-08 23:03:04 UTC (1788908584) [ 4.810673] debug: unmapping init [mem 0xffffffff91803000-0xffffffff919fffff] [ 4.814683] debug: unmapping init [mem 0xffffffff90582000-0xffffffff90858fff] [ 4.873162] Write protecting the kernel read-only data: 28672k [ 4.876487] debug: unmapping init [mem 0xffffffff8ec03000-0xffffffff8edfffff] [ 4.878991] debug: unmapping init [mem 0xffffffff8f514000-0xffffffff8f5fffff] [ 4.915438] 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) [ 4.922899] systemd[1]: Detected virtualization kvm. [ 4.924529] systemd[1]: Detected architecture x86-64. [ 4.926041] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 4.978548] systemd[1]: No hostname configured. [ 4.980192] systemd[1]: Set hostname to . [ 4.982325] random: systemd: uninitialized urandom read (16 bytes read) [ 4.984955] systemd[1]: Initializing machine ID from random generator. [ 5.108733] random: ln: uninitialized urandom read (6 bytes read) [ 5.265747] random: systemd: uninitialized urandom read (16 bytes read) [ 5.269481] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 5.275737] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 5.280760] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... Starting Create Volatile Files and Directories... [ OK ] Reached target Sockets. [ OK ] Reached target Swap. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Reached target Initrd Root Device. Starting Apply Kernel Variables... [ 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... [ 8.321641] device-mapper: uevent: version 1.0.3 [ 8.326277] 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. [ 10.251465] virtio_net virtio0 ens2: renamed from eth0 [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 10.440045] random: fast init done Starting dracut initqueue hook... [ 11.006222] scsi host0: ata_piix [ 11.093636] scsi host1: ata_piix [ 11.098109] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 11.107421] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 16.416884] random: crng init done [ 16.437714] random: 7 urandom warning(s) missed due to ratelimiting [ 18.904490] dracut-initqueue[586]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 20.761336] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 22.986468] printk: systemd: 26 output lines suppressed due to ratelimiting [ 23.797832] SELinux: Disabled at runtime. [ 23.900599] 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) [ 23.925132] systemd[1]: Detected virtualization kvm. [ 23.929374] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 25.419978] systemd[1]: initrd-switch-root.service: Succeeded. [ 25.428924] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 25.444949] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 25.453822] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 25.458557] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 25.467834] systemd[1]: Starting Journal Service... Starting Journal Service... [ 25.477861] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Kernel Debug File System... Mounting Huge Pages File System... [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Process Core Dump Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-getty.slice. Mounting POSIX Message Queue File System... [ 25.685213] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. 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 ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ 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. [ 27.050607] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 27.737064] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 27.816355] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 28.618719] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 28.774090] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (7s / no limit)[ 32.916869] Key type dns_resolver registered [** ] A start job is running for Configur…-only root support (7s / no limit) [*** ] A start job is running for Configur…-only root support (8s / no limit)[ 33.927904] NFS: Registering the id_resolver key type [ 33.938766] Key type id_resolver registered [ 33.945342] Key type id_legacy registered [ *** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... 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 Login Service. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg334-client login: [ 74.595184] libcfs: loading out-of-tree module taints kernel. [ 74.627140] Key type ._llcrypt registered [ 74.628809] Key type .llcrypt registered [ 74.973883] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 74.981921] alg: No test for adler32 (adler32-zlib) [ 76.125379] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 76.569943] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 78.223169] Key type lgssc registered [ 79.126186] Lustre: Echo OBD driver; http://www.lustre.org/ [ 168.928918] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 172.222614] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 181.976745] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing check_logdir /tmp/testlogs/ [ 185.049803] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing yml_node [ 187.569651] Lustre: DEBUG MARKER: Client: 2.17.57.86 [ 189.215506] Lustre: DEBUG MARKER: MDS: 2.17.57.86 [ 190.868187] Lustre: DEBUG MARKER: OSS: 2.17.57.86 [ 191.787696] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Tue Sep 8 19:06:10 EDT 2026 [ 194.532359] Lustre: lustre-OST0000-osc-ffff8bf04a95a800: disconnect after 24s idle [ 201.699664] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 202.771599] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 204.420087] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 214.716126] Lustre: Unmounted lustre-client [ 291.730863] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 294.959948] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 308.327768] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 341.286449] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 19:08:40 (1788908920) [ 342.631375] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 343.782425] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 19:08:42 (1788908922) [ 361.558824] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 364.703723] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 376.655370] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 377.037428] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 383.655987] Lustre: Unmounted lustre-client [ 400.172838] Key type lgssc unregistered [ 400.345195] LNet: 15003:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 400.351581] LNetError: 15003:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 400.366369] LNet: Removed LNI 192.168.203.34@tcp [ 400.825152] Key type .llcrypt unregistered [ 400.826947] Key type ._llcrypt unregistered [ 409.123820] Key type ._llcrypt registered [ 409.126147] Key type .llcrypt registered [ 409.970336] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 19:09:48 (1788908988) [ 410.764924] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 410.774772] alg: No test for adler32 (adler32-zlib) [ 411.702801] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 411.853405] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 413.455165] Key type lgssc registered [ 414.144031] Lustre: Echo OBD driver; http://www.lustre.org/ [ 458.141300] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 537.228484] Lustre: Unmounted lustre-client [ 553.656382] Key type lgssc unregistered [ 553.795453] LNet: 18805:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 553.798496] LNetError: 18805:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 553.810236] LNet: Removed LNI 192.168.203.34@tcp [ 554.140224] Key type .llcrypt unregistered [ 554.142384] Key type ._llcrypt unregistered [ 558.676775] Key type ._llcrypt registered [ 558.678905] Key type .llcrypt registered [ 559.298863] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 19:12:18 (1788909138) [ 560.471433] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 560.481108] alg: No test for adler32 (adler32-zlib) [ 561.397957] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 561.525914] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 563.143171] Key type lgssc registered [ 563.684325] Lustre: Echo OBD driver; http://www.lustre.org/ [ 587.010506] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 589.599869] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 598.627759] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 606.190568] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 610.756293] Lustre: Unmounted lustre-client [ 630.097784] Key type lgssc unregistered [ 630.249281] LNet: 22389:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 630.254053] LNetError: 22389:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 630.267329] LNet: Removed LNI 192.168.203.34@tcp [ 630.623259] Key type .llcrypt unregistered [ 630.624534] Key type ._llcrypt unregistered [ 634.855819] Key type ._llcrypt registered [ 634.859354] Key type .llcrypt registered [ 635.535160] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 19:13:34 (1788909214) [ 636.444580] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 636.484068] alg: No test for adler32 (adler32-zlib) [ 637.384894] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 637.493463] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 639.095276] Key type lgssc registered [ 639.628086] Lustre: Echo OBD driver; http://www.lustre.org/ [ 660.447310] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 662.805162] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 670.793402] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 676.350107] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 679.428189] Lustre: Unmounted lustre-client [ 690.064155] Key type lgssc unregistered [ 690.214306] LNet: 25563:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 690.221494] LNetError: 25563:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 690.240911] LNet: Removed LNI 192.168.203.34@tcp [ 690.597890] Key type .llcrypt unregistered [ 690.599762] Key type ._llcrypt unregistered [ 697.583783] Key type ._llcrypt registered [ 697.585394] Key type .llcrypt registered [ 698.188669] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 19:14:37 (1788909277) [ 699.052919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 699.090421] alg: No test for adler32 (adler32-zlib) [ 699.993171] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 700.108355] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 701.711808] Key type lgssc registered [ 702.400666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 727.216177] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 730.317982] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 740.934744] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 743.308712] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 753.635275] Lustre: lustre-MDT0000-mdc-ffff8bf04abd5800: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 758.760066] Lustre: lustre-MDT0001-mdc-ffff8bf04abd5800: Connection to lustre-MDT0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 764.538334] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 774.833109] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 774.862261] Lustre: Unmounted lustre-client [ 787.358148] Key type lgssc unregistered [ 787.492268] LNet: 29203:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 787.495373] LNetError: 29203:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 788.517536] LNet: Removed LNI 192.168.203.34@tcp [ 788.889222] Key type .llcrypt unregistered [ 788.890733] Key type ._llcrypt unregistered [ 795.416441] Key type ._llcrypt registered [ 795.417883] Key type .llcrypt registered [ 796.108679] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 19:16:15 (1788909375) [ 797.198214] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 797.215104] alg: No test for adler32 (adler32-zlib) [ 798.150867] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 798.265710] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 799.871300] Key type lgssc registered [ 800.465306] Lustre: Echo OBD driver; http://www.lustre.org/ [ 823.963502] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 826.613818] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 836.298823] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 838.575627] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 848.871826] Lustre: lustre-OST0000-osc-ffff8bf0477f3000: Connection to lustre-OST0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 851.650777] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 861.950185] Lustre: Unmounted lustre-client [ 880.736638] Key type lgssc unregistered [ 880.878389] LNet: 32801:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 880.884413] LNetError: 32801:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 880.892815] LNet: Removed LNI 192.168.203.34@tcp [ 881.225513] Key type .llcrypt unregistered [ 881.227755] Key type ._llcrypt unregistered [ 888.147312] Key type ._llcrypt registered [ 888.148594] Key type .llcrypt registered [ 888.760346] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 19:17:47 (1788909467) [ 889.571723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 889.582430] alg: No test for adler32 (adler32-zlib) [ 890.449706] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 890.554857] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 892.151214] Key type lgssc registered [ 892.648746] Lustre: Echo OBD driver; http://www.lustre.org/ [ 915.553748] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 918.205212] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 926.876347] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 933.357829] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 939.098189] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 940.617197] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 951.226555] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-0819h18m50s [ 952.130905] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 953.830119] Lustre: lustre-MDT0000-mdc-ffff8bf04395f000: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 968.151652] LustreError: 36578:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8bf04395f000: can't stat MDS #0: rc = -19 [ 968.826418] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 972.259138] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 972.267603] LustreError: lustre-MDT0000-mdc-ffff8bf04395f000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 972.280656] Lustre: lustre-MDT0000-mdc-ffff8bf04395f000: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 972.286689] Lustre: Evicted from MGS (at 192.168.203.134@tcp) after server handle changed from 0x409b2380b6df0950 to 0x409b2380b6df0d01 [ 975.275738] Lustre: DEBUG MARKER: Wait for df (36578) ... [ 975.938689] Lustre: DEBUG MARKER: done [ 976.348707] Lustre: Unmounted lustre-client [ 1002.991581] Key type lgssc unregistered [ 1003.127675] LNet: 37589:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1003.130854] LNetError: 37589:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1003.140980] LNet: Removed LNI 192.168.203.34@tcp [ 1003.436141] Key type .llcrypt unregistered [ 1003.437540] Key type ._llcrypt unregistered [ 1016.395701] Key type ._llcrypt registered [ 1016.397341] Key type .llcrypt registered [ 1016.993509] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 19:19:56 (1788909596) [ 1018.023606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1018.032595] alg: No test for adler32 (adler32-zlib) [ 1018.925755] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1019.051108] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1020.655185] Key type lgssc registered [ 1021.289232] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1044.110348] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1046.570759] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1055.092221] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1061.876289] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1064.455153] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-0819h20m43s [ 1065.203329] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1068.433449] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1069.625602] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1090.015139] Lustre: 41723:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788909649/real 1788909649] req@00000000d8ad4a71 x1875807670638464/t0(0) o101->lustre-MDT0000-mdc-ffff8bf0483e2000@192.168.203.134@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788909669 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1090.029595] Lustre: lustre-MDT0000-mdc-ffff8bf0483e2000: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1090.046853] Lustre: lustre-MDT0000-mdc-ffff8bf0483e2000: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 1110.480825] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1111.883725] Lustre: DEBUG MARKER: done [ 1113.318829] Lustre: Unmounted lustre-client [ 1132.729472] Key type lgssc unregistered [ 1132.890376] LNet: 42607:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1132.897624] LNetError: 42607:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1132.908954] LNet: Removed LNI 192.168.203.34@tcp [ 1133.255416] Key type .llcrypt unregistered [ 1133.257302] Key type ._llcrypt unregistered [ 1146.655769] Key type ._llcrypt registered [ 1146.657089] Key type .llcrypt registered [ 1147.269795] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 19:22:06 (1788909726) [ 1147.983527] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1148.735958] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 19:22:07 (1788909727) [ 1150.422429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1150.443722] alg: No test for adler32 (adler32-zlib) [ 1151.328404] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1151.428493] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1153.031221] Key type lgssc registered [ 1153.568823] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1166.508638] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 19:22:25 (1788909745) [ 1180.143547] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1182.328388] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1190.861594] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1197.541449] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1199.485956] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1200.355146] Lustre: Unmounted lustre-client [ 1210.613588] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1229.353875] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1231.770460] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1231.965663] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1233.280703] Lustre: Unmounted lustre-client [ 1264.071284] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1266.602357] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1266.882076] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1268.126131] Lustre: Unmounted lustre-client [ 1280.816317] Lustre: DEBUG MARKER: files compared the same [ 1296.188128] Key type lgssc unregistered [ 1296.319050] LNet: 50198:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1296.323834] LNetError: 50198:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1296.338112] LNet: Removed LNI 192.168.203.34@tcp [ 1296.650453] Key type .llcrypt unregistered [ 1296.654606] Key type ._llcrypt unregistered [ 1302.343055] Key type ._llcrypt registered [ 1302.344748] Key type .llcrypt registered [ 1302.935852] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 19:24:41 (1788909881) [ 1303.882939] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1303.895674] alg: No test for adler32 (adler32-zlib) [ 1304.780620] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1304.886253] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1306.479434] Key type lgssc registered [ 1306.918595] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1327.273115] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1329.664917] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1338.128956] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1345.510066] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1350.979791] Lustre: Unmounted lustre-client [ 1377.876327] Key type lgssc unregistered [ 1378.028824] LNet: 53769:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1378.032944] LNetError: 53769:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1378.041076] LNet: Removed LNI 192.168.203.34@tcp [ 1378.356249] Key type .llcrypt unregistered [ 1378.358358] Key type ._llcrypt unregistered [ 1384.528790] Key type ._llcrypt registered [ 1384.530824] Key type .llcrypt registered [ 1385.109684] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 19:26:04 (1788909964) [ 1385.982326] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1385.989729] alg: No test for adler32 (adler32-zlib) [ 1386.891570] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1386.995341] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1388.591158] Key type lgssc registered [ 1389.091221] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1450.743791] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1462.212461] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1464.171632] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1490.044306] Key type lgssc unregistered [ 1490.171445] LNet: 57239:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1490.174375] LNetError: 57239:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1490.181535] LNet: Removed LNI 192.168.203.34@tcp [ 1490.456777] Key type .llcrypt unregistered [ 1490.458046] Key type ._llcrypt unregistered [ 1495.928415] Key type ._llcrypt registered [ 1495.933038] Key type .llcrypt registered [ 1496.544574] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 19:27:55 (1788910075) [ 1498.044403] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1498.063954] alg: No test for adler32 (adler32-zlib) [ 1498.960334] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1499.056083] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1500.664533] Key type lgssc registered [ 1501.202439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1529.880735] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1535.404585] Lustre: Unmounted lustre-client [ 1557.079482] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 19:28:56 (1788910136) [ 1598.942851] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1610.739187] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1616.113333] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1616.116919] LustreError: 63681:0:(file.c:256:ll_close_inode_openhandle()) lustre-clilmv-ffff8bf049373800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1616.127396] Lustre: 58217:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.134@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1626.421632] Lustre: Unmounted lustre-client [ 1661.692358] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 19:30:40 (1788910240) [ 1665.719544] Key type lgssc unregistered [ 1665.844431] LNet: 64889:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1665.847663] LNetError: 64889:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1665.857803] LNet: Removed LNI 192.168.203.34@tcp [ 1666.114352] Key type .llcrypt unregistered [ 1666.115783] Key type ._llcrypt unregistered [ 1670.365625] Key type ._llcrypt registered [ 1670.367391] Key type .llcrypt registered [ 1670.560173] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1670.575573] alg: No test for adler32 (adler32-zlib) [ 1671.446952] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1671.543190] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1673.127164] Key type lgssc registered [ 1673.563830] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1692.386081] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1694.210434] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1701.670544] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1712.117891] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1713.819886] Lustre: Unmounted lustre-client [ 1731.842917] Key type lgssc unregistered [ 1731.966774] LNet: 67886:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1731.970452] LNetError: 67886:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1731.980346] LNet: Removed LNI 192.168.203.34@tcp [ 1732.257350] Key type .llcrypt unregistered [ 1732.259368] Key type ._llcrypt unregistered [ 1736.183152] Key type ._llcrypt registered [ 1736.187409] Key type .llcrypt registered [ 1736.390141] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1736.397384] alg: No test for adler32 (adler32-zlib) [ 1737.256114] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1737.348489] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1738.935173] Key type lgssc registered [ 1739.392129] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1789.577318] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1791.501308] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1799.024792] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1809.433253] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1810.017068] Lustre: Unmounted lustre-client [ 1827.916365] Key type lgssc unregistered [ 1828.040328] LNet: 71301:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1828.042628] LNetError: 71301:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1828.050818] LNet: Removed LNI 192.168.203.34@tcp [ 1828.293684] Key type .llcrypt unregistered [ 1828.294726] Key type ._llcrypt unregistered [ 1833.748940] Key type ._llcrypt registered [ 1833.749953] Key type .llcrypt registered [ 1834.192887] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 19:33:33 (1788910413) [ 1834.992942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1835.001753] alg: No test for adler32 (adler32-zlib) [ 1835.856546] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1835.943757] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1837.527394] Key type lgssc registered [ 1837.959114] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1857.434205] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1859.471848] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1867.036533] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1877.504563] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1880.161047] Lustre: Unmounted lustre-client [ 1880.314663] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1881.208440] Lustre: Unmounted lustre-client [ 1898.933704] Key type lgssc unregistered [ 1899.065520] LNet: 74971:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1899.068324] LNetError: 74971:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1899.077491] LNet: Removed LNI 192.168.203.34@tcp [ 1899.351934] Key type .llcrypt unregistered [ 1899.353459] Key type ._llcrypt unregistered [ 1903.897724] Key type ._llcrypt registered [ 1903.899122] Key type .llcrypt registered [ 1904.097769] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1904.105547] alg: No test for adler32 (adler32-zlib) [ 1904.983260] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1905.092685] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1906.679356] Key type lgssc registered [ 1907.118032] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1925.663943] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1927.473802] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1934.134167] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1944.561716] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 1946.300638] Lustre: Unmounted lustre-client [ 1955.533270] Key type lgssc unregistered [ 1955.654824] LNet: 77987:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1955.657132] LNetError: 77987:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1955.663682] LNet: Removed LNI 192.168.203.34@tcp [ 1955.912283] Key type .llcrypt unregistered [ 1955.913459] Key type ._llcrypt unregistered [ 1961.339288] Key type ._llcrypt registered [ 1961.340383] Key type .llcrypt registered [ 1961.835147] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 19:35:40 (1788910540) [ 1962.723336] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1962.735136] alg: No test for adler32 (adler32-zlib) [ 1963.615978] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 1963.710794] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 1965.295103] Key type lgssc registered [ 1965.677344] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1983.825063] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1985.658730] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1992.285707] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2002.928762] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2005.701123] Lustre: lustre: root_squash is set to 0:0 [ 2014.704243] Lustre: lustre: nosquash_nids is cleared [ 2014.712859] Lustre: lustre: root_squash is set to 500:500 [ 2020.464317] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.34@tcp 192.168.0.[2,10]@tcp [ 2028.792028] Lustre: lustre: nosquash_nids set to 192.168.203.34/24@tcp [ 2035.905738] Lustre: Unmounted lustre-client [ 2053.388869] Key type lgssc unregistered [ 2053.509525] LNet: 81998:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2053.512787] LNetError: 81998:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2053.524653] LNet: Removed LNI 192.168.203.34@tcp [ 2053.781486] Key type .llcrypt unregistered [ 2053.782891] Key type ._llcrypt unregistered [ 2059.499891] Key type ._llcrypt registered [ 2059.501074] Key type .llcrypt registered [ 2060.018670] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 19:37:19 (1788910639) [ 2060.931563] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2061.572970] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 19:37:20 (1788910640) [ 2062.442435] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2062.453254] alg: No test for adler32 (adler32-zlib) [ 2063.316767] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 2063.410542] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 2064.999203] Key type lgssc registered [ 2065.407766] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2084.053762] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2086.084738] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2093.265057] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2093.419404] Lustre: lustre: root_squash is set to 500:500 [ 2093.428231] Lustre: lustre: nosquash_nids set to 192.168.203.34/24@tcp [ 2103.807518] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2106.421112] Lustre: Unmounted lustre-client [ 2124.616295] Key type lgssc unregistered [ 2124.740990] LNet: 85939:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2124.750195] LNetError: 85939:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2124.759679] LNet: Removed LNI 192.168.203.34@tcp [ 2125.061381] Key type .llcrypt unregistered [ 2125.063253] Key type ._llcrypt unregistered [ 2130.910412] Key type ._llcrypt registered [ 2130.911655] Key type .llcrypt registered [ 2131.379245] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2131.980716] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 19:38:31 (1788910711) [ 2138.464811] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2138.477474] alg: No test for adler32 (adler32-zlib) [ 2139.391305] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 2139.513478] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 2141.111224] Key type lgssc registered [ 2141.754119] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2212.576706] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2217.257631] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2233.126210] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2290.440374] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2293.824621] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2306.546719] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2314.385304] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2332.134712] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8bf049b28800.ost_server_uuid 50 [ 2332.941625] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8bf049b28800.ost_server_uuid in FULL state after 0 sec [ 2333.147038] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2335.230289] Lustre: Unmounted lustre-client [ 2336.140238] Lustre: Unmounted lustre-client [ 2371.530079] Key type lgssc unregistered [ 2371.691777] LNet: 93590:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2371.696909] LNetError: 93590:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2371.714463] LNet: Removed LNI 192.168.203.34@tcp [ 2372.218093] Key type .llcrypt unregistered [ 2372.221025] Key type ._llcrypt unregistered [ 2390.802563] Key type ._llcrypt registered [ 2390.804343] Key type .llcrypt registered [ 2391.588383] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 19:42:50 (1788910970) [ 2401.591435] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2401.627929] alg: No test for adler32 (adler32-zlib) [ 2402.575969] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 2402.744156] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 2404.360587] Key type lgssc registered [ 2404.993456] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2446.031402] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2448.350814] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2459.343954] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2460.599800] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2476.006813] Lustre: lustre-OST0000-osc-ffff8bf045eb9800: Connection to lustre-OST0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2481.124106] Lustre: lustre-MDT0000-mdc-ffff8bf045eb9800: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2481.887834] Lustre: 94946:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788911045/real 1788911045] req@00000000c87edd2c x1875809121866880/t0(0) o400->lustre-OST0000-osc-ffff8bf045eb9800@192.168.203.134@tcp:28/4 lens 224/224 e 0 to 1 dl 1788911061 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2487.263434] Lustre: 94945:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788911050/real 1788911050] req@00000000c1c1f182 x1875809121867392/t0(0) o400->lustre-OST0000-osc-ffff8bf045eb9800@192.168.203.134@tcp:28/4 lens 224/224 e 0 to 1 dl 1788911066 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2496.479172] Lustre: 94948:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788911060/real 1788911060] req@00000000771a979c x1875809121868672/t0(0) o400->MGC192.168.203.134@tcp@192.168.203.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1788911076 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2496.482176] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 2496.505418] Lustre: Evicted from MGS (at 192.168.203.134@tcp) after server handle changed from 0x621511c09a53c39c to 0x621511c09a53c64a [ 2496.511878] Lustre: MGC192.168.203.134@tcp: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 2499.751217] Lustre: lustre-MDT0000-mdc-ffff8bf045eb9800: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 2500.204629] Lustre: Unmounted lustre-client [ 2518.567304] Key type lgssc unregistered [ 2518.706487] LNet: 99229:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2518.713926] LNetError: 99229:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2518.731031] LNet: Removed LNI 192.168.203.34@tcp [ 2519.036663] Key type .llcrypt unregistered [ 2519.037957] Key type ._llcrypt unregistered [ 2525.514747] Key type ._llcrypt registered [ 2525.515995] Key type .llcrypt registered [ 2526.131677] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 19:45:05 (1788911105) [ 2538.122204] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2538.128860] alg: No test for adler32 (adler32-zlib) [ 2539.017177] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 2539.137859] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 2540.727681] Key type lgssc registered [ 2541.207327] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2560.268976] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2600.961421] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2603.252096] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2613.051315] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2619.351885] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2619.997751] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2620.623601] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 19:46:39 (1788911199) [ 2678.097465] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2688.371103] Lustre: Unmounted lustre-client [ 2753.128406] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2754.754220] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2762.183287] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2782.910609] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:49:22 (1788911362) [ 2813.117232] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2815.018542] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2823.005449] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2828.272731] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2829.324082] Lustre: Unmounted lustre-client [ 2855.859622] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:50:35 (1788911435) [ 2884.497312] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2886.221714] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2894.183212] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2894.334039] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2895.365130] Lustre: Unmounted lustre-client [ 2912.749287] Key type lgssc unregistered [ 2912.874886] LNet: 122153:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2912.878925] LNetError: 122153:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2912.888997] LNet: Removed LNI 192.168.203.34@tcp [ 2913.153204] Key type .llcrypt unregistered [ 2913.154521] Key type ._llcrypt unregistered [ 2918.340298] Key type ._llcrypt registered [ 2918.341961] Key type .llcrypt registered [ 2918.780728] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 19:51:37 (1788911497) [ 2919.464790] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2919.502922] alg: No test for adler32 (adler32-zlib) [ 2920.386760] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 2920.489729] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 2922.079238] Key type lgssc registered [ 2922.531378] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2939.992782] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2941.645413] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2947.869104] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2958.319215] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 2968.991151] Lustre: Unmounted lustre-client [ 2986.198199] Key type lgssc unregistered [ 2986.311652] LNet: 125730:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2986.314260] LNetError: 125730:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2986.321635] LNet: Removed LNI 192.168.203.34@tcp [ 2986.549140] Key type .llcrypt unregistered [ 2986.550427] Key type ._llcrypt unregistered [ 2991.312752] Key type ._llcrypt registered [ 2991.314094] Key type .llcrypt registered [ 2991.748719] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 19:52:50 (1788911570) [ 2992.428437] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2992.461921] alg: No test for adler32 (adler32-zlib) [ 2993.313282] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 2993.396863] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 2994.975114] Key type lgssc registered [ 2995.289687] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3012.795090] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3014.499284] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3020.913145] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3031.534099] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3036.642049] Lustre: lustre-OST0000-osc-ffff8bf0458fa800: Connection to lustre-OST0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3041.993502] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8bf0458fa800.ost_server_uuid 50 [ 3042.499877] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 3051.811554] Lustre: Unmounted lustre-client [ 3062.430292] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 19:54:01 (1788911641) [ 3072.512362] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3074.249791] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3080.300280] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3087.885946] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3088.034405] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3093.475664] Lustre: lustre-OST0000-osc-ffff8bf049371800: Connection to lustre-OST0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3107.366224] Lustre: Unmounted lustre-client [ 3129.706255] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 19:55:08 (1788911708) [ 3139.269202] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3140.972139] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3147.167894] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3153.516220] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3153.680924] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3159.010407] Lustre: lustre-OST0000-osc-ffff8bf04abd1800: Connection to lustre-OST0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3170.276131] Lustre: Unmounted lustre-client [ 3201.095850] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 19:56:20 (1788911780) [ 3229.996136] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3231.718695] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3239.510956] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3276.238835] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3277.984447] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3284.502779] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3305.306511] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3333.375094] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3333.907579] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3334.270955] Lustre: Unmounted lustre-client [ 3344.488466] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 19:58:43 (1788911923) [ 3355.155327] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3356.956231] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3363.455228] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3380.622640] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3393.516603] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3420.875262] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3421.346445] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3424.226489] Lustre: lustre-OST0001-osc-ffff8bf046c1c000: Connection to lustre-OST0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3428.890357] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3439.161756] Lustre: Unmounted lustre-client [ 3468.132359] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 20:00:47 (1788912047) [ 3477.957404] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3479.627791] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3485.720524] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3485.854299] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3493.187307] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3495.670265] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 2 sec [ 3499.786518] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8bf048f79800.ost_server_uuid 50 [ 3500.224887] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8bf048f79800.ost_server_uuid in FULL state after 0 sec [ 3500.803196] Lustre: Unmounted lustre-client [ 3500.882211] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3500.883881] Lustre: Skipped 3 previous similar messages [ 3501.226243] LustreError: 149062:0:(sec.c:403:import_sec_validate_get()) import 000000008f8a5436 (NEW) with no sec [ 3531.053302] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 20:01:50 (1788912110) [ 3541.086446] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3542.800275] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3549.150076] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3555.655612] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3555.776469] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3555.808660] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3555.810719] Lustre: Skipped 1 previous similar message [ 3566.339102] Lustre: Unmounted lustre-client [ 3566.340627] Lustre: Skipped 1 previous similar message [ 3591.158255] Key type lgssc unregistered [ 3591.281598] LNet: 152469:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3591.283933] LNetError: 152469:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3591.292228] LNet: Removed LNI 192.168.203.34@tcp [ 3591.559318] Key type .llcrypt unregistered [ 3591.560712] Key type ._llcrypt unregistered [ 3596.473742] Key type ._llcrypt registered [ 3596.474839] Key type .llcrypt registered [ 3596.921978] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 20:02:56 (1788912176) [ 3597.320341] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3597.329766] alg: No test for adler32 (adler32-zlib) [ 3598.174476] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 3598.253987] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 3599.831144] Key type lgssc registered [ 3600.182725] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3618.085955] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3619.757861] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3625.952872] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3632.177090] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3632.294119] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3637.744076] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3639.595185] LustreError: lustre-MDT0001-mdc-ffff8bf0583ed800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 3639.601916] Lustre: lustre-MDT0001-mdc-ffff8bf0583ed800: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 3641.985022] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3642.535721] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3649.060652] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3655.630308] Lustre: Unmounted lustre-client [ 3674.863690] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 20:04:14 (1788912254) [ 3705.236886] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3707.091647] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3715.270569] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3715.429094] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3726.124534] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3726.663170] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3738.595479] Lustre: lustre-OST0001-osc-ffff8bf04a663800: Connection to lustre-OST0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3743.766383] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3754.044992] Lustre: Unmounted lustre-client [ 3777.469093] Key type lgssc unregistered [ 3777.582598] LNet: 162013:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3777.585306] LNetError: 162013:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3777.599615] LNet: Removed LNI 192.168.203.34@tcp [ 3777.843123] Key type .llcrypt unregistered [ 3777.845060] Key type ._llcrypt unregistered [ 3787.790710] Key type ._llcrypt registered [ 3787.791810] Key type .llcrypt registered [ 3788.247609] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 20:06:07 (1788912367) [ 3788.950753] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3789.004529] alg: No test for adler32 (adler32-zlib) [ 3789.880328] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 3789.976604] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 3791.559175] Key type lgssc registered [ 3791.928845] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3809.646037] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3811.401171] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3817.875556] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3819.038903] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3856.246181] Lustre: Unmounted lustre-client [ 3873.356950] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3873.512791] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3905.795135] Lustre: Unmounted lustre-client [ 3922.693309] Key type lgssc unregistered [ 3922.807541] LNet: 166442:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3922.809612] LNetError: 166442:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3922.819509] LNet: Removed LNI 192.168.203.34@tcp [ 3923.069268] Key type .llcrypt unregistered [ 3923.070268] Key type ._llcrypt unregistered [ 3927.868818] Key type ._llcrypt registered [ 3927.869850] Key type .llcrypt registered [ 3928.309782] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 20:08:27 (1788912507) [ 3928.963466] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3928.996339] alg: No test for adler32 (adler32-zlib) [ 3929.836534] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 3929.917962] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 3931.495164] Key type lgssc registered [ 3931.810860] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3948.373727] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3950.136602] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3956.826760] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3967.471360] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 3974.104203] Lustre: Unmounted lustre-client [ 3991.195317] Key type lgssc unregistered [ 3991.308581] LNet: 170177:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3991.311049] LNetError: 170177:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3991.317728] LNet: Removed LNI 192.168.203.34@tcp [ 3991.554707] Key type .llcrypt unregistered [ 3991.556507] Key type ._llcrypt unregistered [ 3995.823488] Key type ._llcrypt registered [ 3995.824649] Key type .llcrypt registered [ 3996.007756] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3996.014016] alg: No test for adler32 (adler32-zlib) [ 3996.871179] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 3996.971931] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 3998.551138] Key type lgssc registered [ 3998.957282] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4017.341343] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4019.207894] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4026.064794] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4036.592498] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 4039.475440] Lustre: Unmounted lustre-client [ 4056.385870] Key type lgssc unregistered [ 4056.506449] LNet: 173226:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4056.508808] LNetError: 173226:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4056.516629] LNet: Removed LNI 192.168.203.34@tcp [ 4056.759156] Key type .llcrypt unregistered [ 4056.760957] Key type ._llcrypt unregistered [ 4061.479704] Key type ._llcrypt registered [ 4061.480698] Key type .llcrypt registered [ 4061.888121] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 20:10:41 (1788912641) [ 4062.610860] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4062.617367] alg: No test for adler32 (adler32-zlib) [ 4063.464711] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4063.540689] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4065.119162] Key type lgssc registered [ 4065.473347] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4083.305805] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4085.240463] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4092.247893] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4102.640721] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 4109.295248] Lustre: Unmounted lustre-client [ 4126.304897] Key type lgssc unregistered [ 4126.409652] LNet: 176963:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4126.413803] LNetError: 176963:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4126.424443] LNet: Removed LNI 192.168.203.34@tcp [ 4126.669778] Key type .llcrypt unregistered [ 4126.670981] Key type ._llcrypt unregistered [ 4130.775603] Key type ._llcrypt registered [ 4130.783684] Key type .llcrypt registered [ 4130.965631] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4130.970393] alg: No test for adler32 (adler32-zlib) [ 4131.821461] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4131.908616] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4133.487233] Key type lgssc registered [ 4133.888666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4151.342415] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4153.132581] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4159.609835] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4170.225525] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 4172.973098] Lustre: Unmounted lustre-client [ 4198.555855] Key type lgssc unregistered [ 4198.679530] LNet: 180023:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4198.682244] LNetError: 180023:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4198.693731] LNet: Removed LNI 192.168.203.34@tcp [ 4198.943901] Key type .llcrypt unregistered [ 4198.944970] Key type ._llcrypt unregistered [ 4203.834012] Key type ._llcrypt registered [ 4203.834975] Key type .llcrypt registered [ 4204.272985] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 20:13:03 (1788912783) [ 4210.851773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4210.892226] alg: No test for adler32 (adler32-zlib) [ 4211.752765] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4211.846700] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4213.431126] Key type lgssc registered [ 4213.827231] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4254.387666] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4256.176403] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4264.352148] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4304.113496] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 20:14:43 (1788912883) [ 4315.462096] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4317.457167] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4324.778382] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4335.094323] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 4337.174132] Lustre: Unmounted lustre-client [ 4355.154627] Key type lgssc unregistered [ 4355.277361] LNet: 187095:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4355.280772] LNetError: 187095:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4355.289761] LNet: Removed LNI 192.168.203.34@tcp [ 4355.566062] Key type .llcrypt unregistered [ 4355.567390] Key type ._llcrypt unregistered [ 4361.188127] Key type ._llcrypt registered [ 4361.189087] Key type .llcrypt registered [ 4361.672893] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4362.265953] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 20:15:41 (1788912941) [ 4368.555270] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4368.601488] alg: No test for adler32 (adler32-zlib) [ 4369.482223] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4369.576478] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4371.167383] Key type lgssc registered [ 4371.580532] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4403.349900] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4405.101537] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4412.830802] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4419.438150] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4420.598721] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 4426.646682] Lustre: Unmounted lustre-client [ 4524.277766] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4526.762949] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4537.056626] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4564.971655] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 20:19:04 (1788913144) [ 4565.603576] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4566.365537] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 20:19:05 (1788913145) [ 4617.494964] Key type lgssc unregistered [ 4617.634536] LNet: 198485:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4617.638385] LNetError: 198485:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4617.648572] LNet: Removed LNI 192.168.203.34@tcp [ 4617.983621] Key type .llcrypt unregistered [ 4617.985266] Key type ._llcrypt unregistered [ 4624.872079] Key type ._llcrypt registered [ 4624.874867] Key type .llcrypt registered [ 4625.541098] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 20:20:04 (1788913204) [ 4650.814864] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4650.828142] alg: No test for adler32 (adler32-zlib) [ 4651.736090] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4651.867501] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4653.488427] Key type lgssc registered [ 4654.124295] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4675.103405] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4678.194825] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4713.825503] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4749.441599] Key type lgssc unregistered [ 4749.778551] LNet: 202205:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4749.789255] LNetError: 202205:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4749.821819] LNet: Removed LNI 192.168.203.34@tcp [ 4750.741931] Key type .llcrypt unregistered [ 4750.754799] Key type ._llcrypt unregistered [ 4766.877159] Key type ._llcrypt registered [ 4766.878628] Key type .llcrypt registered [ 4768.030821] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 20:22:26 (1788913346) [ 4769.996493] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4770.034351] alg: No test for adler32 (adler32-zlib) [ 4771.071131] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4771.246721] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4772.879216] Key type lgssc registered [ 4773.933611] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4817.020515] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4821.795248] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4842.354887] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4844.025391] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 4854.254480] Lustre: lustre-MDT0000-mdc-ffff8bf04a67a000: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4859.405948] Lustre: lustre-MDT0001-mdc-ffff8bf04a67a000: Connection to lustre-MDT0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4875.744123] Lustre: 203191:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788913439/real 1788913439] req@000000006a611b55 x1875811604971520/t0(0) o400->MGC192.168.203.134@tcp@192.168.203.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1788913455 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4875.780988] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 4886.065130] Lustre: Evicted from MGS (at 192.168.203.134@tcp) after server handle changed from 0x57fe0e3aeec2028e to 0x57fe0e3aeec21dca [ 4886.087686] Lustre: MGC192.168.203.134@tcp: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 4904.942096] LustreError: lustre-MDT0000-mdc-ffff8bf04a67a000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4905.020132] Lustre: lustre-MDT0000-mdc-ffff8bf04a67a000: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 4905.351534] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4906.588351] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4911.485623] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4912.758214] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4915.698101] Lustre: Unmounted lustre-client [ 4949.161458] Key type lgssc unregistered [ 4949.464115] LNet: 207138:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4949.487186] LNetError: 207138:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4949.510156] LNet: Removed LNI 192.168.203.34@tcp [ 4950.269226] Key type .llcrypt unregistered [ 4950.271143] Key type ._llcrypt unregistered [ 4964.135289] Key type ._llcrypt registered [ 4964.137400] Key type .llcrypt registered [ 4965.316869] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 20:25:43 (1788913543) [ 4967.345954] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4967.358051] alg: No test for adler32 (adler32-zlib) [ 4968.499379] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 4968.738190] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 4970.399191] Key type lgssc registered [ 4971.459863] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5012.882366] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5016.504417] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5056.320580] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5060.101308] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5085.224941] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5100.232876] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5140.021646] Key type lgssc unregistered [ 5140.227479] LNet: 212421:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5140.233157] LNetError: 212421:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5140.249546] LNet: Removed LNI 192.168.203.34@tcp [ 5140.796500] Key type .llcrypt unregistered [ 5140.799270] Key type ._llcrypt unregistered [ 5171.461464] Key type ._llcrypt registered [ 5171.463471] Key type .llcrypt registered [ 5172.278147] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 20:29:11 (1788913751) [ 5196.917054] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5196.951111] alg: No test for adler32 (adler32-zlib) [ 5197.956878] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 5198.130747] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 5199.770179] Key type lgssc registered [ 5200.589174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5257.426438] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5260.780852] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5269.897639] hrtimer: interrupt took 10112153 ns [ 5276.668803] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5315.913580] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 20:31:34 (1788913894) [ 5320.671447] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 20:31:39 (1788913899) [ 5341.198777] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5344.550258] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5356.301993] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5358.680318] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 5366.096449] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 5367.074547] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5368.045906] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5368.945240] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 5373.926610] Lustre: lustre-MDT0000-mdc-ffff8bf0581f8800: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5389.285042] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 5389.295931] Lustre: Evicted from MGS (at 192.168.203.134@tcp) after server handle changed from 0xc8155a2486988077 to 0xc8155a24869882ed [ 5389.303203] Lustre: MGC192.168.203.134@tcp: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 5389.995673] Lustre: lustre-MDT0000-mdc-ffff8bf0581f8800: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 5392.552596] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5393.390571] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5395.696197] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 5399.526148] Lustre: lustre-MDT0000-mdc-ffff8bf0581f8800: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5414.882982] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 5414.896537] Lustre: 220304:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.203.134@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 5414.902915] Lustre: Evicted from MGS (at 192.168.203.134@tcp) after server handle changed from 0xc8155a24869882ed to 0xc8155a24869885e1 [ 5414.910032] Lustre: MGC192.168.203.134@tcp: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 5417.157639] Lustre: lustre-MDT0000-mdc-ffff8bf0581f8800: Connection restored to 192.168.203.134@tcp (at 192.168.203.134@tcp) [ 5420.296544] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5421.192512] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5423.514705] Lustre: Unmounted lustre-client [ 5465.575350] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5468.176312] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5478.586187] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5478.843052] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 5489.765098] Lustre: Unmounted lustre-client [ 5508.839904] Key type lgssc unregistered [ 5508.985501] LNet: 224880:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5508.989568] LNetError: 224880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5509.000870] LNet: Removed LNI 192.168.203.34@tcp [ 5509.295093] Key type .llcrypt unregistered [ 5509.296411] Key type ._llcrypt unregistered [ 5516.997398] Key type ._llcrypt registered [ 5516.998953] Key type .llcrypt registered [ 5517.622813] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 20:34:56 (1788914096) [ 5519.583428] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5519.596481] alg: No test for adler32 (adler32-zlib) [ 5520.502819] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 5520.636679] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 5522.247178] Key type lgssc registered [ 5522.864664] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5581.228938] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5595.334785] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5626.876717] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5629.075208] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 5637.503044] Lustre: Unmounted lustre-client [ 5703.515838] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5708.612885] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5728.835599] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5729.323764] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 5738.141256] Lustre: Unmounted lustre-client [ 5795.687588] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5800.856231] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5822.761743] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5823.386319] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 5825.642049] Lustre: Unmounted lustre-client [ 5852.758449] Key type lgssc unregistered [ 5853.080079] LNet: 231926:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5853.088106] LNetError: 231926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5853.120422] LNet: Removed LNI 192.168.203.34@tcp [ 5854.114104] Key type .llcrypt unregistered [ 5854.117480] Key type ._llcrypt unregistered [ 5872.431480] Key type ._llcrypt registered [ 5872.433957] Key type .llcrypt registered [ 5873.788324] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 20:40:51 (1788914451) [ 5877.043472] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5877.149167] alg: No test for adler32 (adler32-zlib) [ 5878.356106] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 5878.636710] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 5880.367979] Key type lgssc registered [ 5881.823783] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5926.145808] Key type lgssc unregistered [ 5926.467693] LNet: 234241:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5926.476374] LNetError: 234241:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5926.498499] LNet: Removed LNI 192.168.203.34@tcp [ 5927.220361] Key type .llcrypt unregistered [ 5927.225548] Key type ._llcrypt unregistered [ 5964.244359] Key type ._llcrypt registered [ 5964.253047] Key type .llcrypt registered [ 5964.625323] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5964.636710] alg: No test for adler32 (adler32-zlib) [ 5965.813236] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 5966.024845] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 5967.703264] Key type lgssc registered [ 5968.889276] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6043.282849] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6048.113808] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6067.196438] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6101.484837] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 6102.839408] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 20:44:41 (1788914681) [ 6134.016898] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6139.650696] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6161.732885] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6187.998907] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6190.051290] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 6195.191809] Lustre: lustre-OST0001-osc-ffff8bf047b71800: Connection to lustre-OST0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6203.509976] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6213.883650] Lustre: Unmounted lustre-client [ 6255.510113] Key type lgssc unregistered [ 6255.808325] LNet: 241349:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6255.821556] LNetError: 241349:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6255.848545] LNet: Removed LNI 192.168.203.34@tcp [ 6256.701373] Key type .llcrypt unregistered [ 6256.706980] Key type ._llcrypt unregistered [ 6288.345349] Key type ._llcrypt registered [ 6288.349222] Key type .llcrypt registered [ 6289.611284] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 20:47:47 (1788914867) [ 6302.363558] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6302.508975] alg: No test for adler32 (adler32-zlib) [ 6303.556781] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 6303.793222] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 6305.511188] Key type lgssc registered [ 6306.914163] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6354.696736] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6360.377325] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6383.642594] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 20:49:21 (1788914961) [ 6417.432796] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6423.081563] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6442.130995] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6443.732623] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 6449.797948] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6460.609402] Lustre: Unmounted lustre-client [ 6564.955510] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6571.846859] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6624.894755] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6625.479809] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 6628.315176] Lustre: Unmounted lustre-client [ 6651.185837] Key type lgssc unregistered [ 6651.383350] LNet: 249030:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6651.391238] LNetError: 249030:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6651.412957] LNet: Removed LNI 192.168.203.34@tcp [ 6652.047066] Key type .llcrypt unregistered [ 6652.049201] Key type ._llcrypt unregistered [ 6680.570467] Key type ._llcrypt registered [ 6680.581075] Key type .llcrypt registered [ 6680.802242] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6680.828191] alg: No test for adler32 (adler32-zlib) [ 6681.944401] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 6682.204686] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 6683.863211] Key type lgssc registered [ 6684.908439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6771.310825] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6777.473048] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6804.146793] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6847.274492] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 6849.080138] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 20:57:07 (1788915427) [ 6882.731220] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6888.571645] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6911.382051] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6917.235796] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 6920.714277] Lustre: Unmounted lustre-client [ 6951.844996] Key type lgssc unregistered [ 6952.288293] LNet: 255666:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6952.315783] LNetError: 255666:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6952.335559] LNet: Removed LNI 192.168.203.34@tcp [ 6953.305786] Key type .llcrypt unregistered [ 6953.314879] Key type ._llcrypt unregistered [ 6972.379578] Key type ._llcrypt registered [ 6972.386791] Key type .llcrypt registered [ 6974.092714] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 6975.854336] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 20:59:14 (1788915554) [ 6985.645491] Key type .llcrypt unregistered [ 6985.647234] Key type ._llcrypt unregistered [ 6995.030403] Key type ._llcrypt registered [ 6995.041188] Key type .llcrypt registered [ 6995.557516] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6995.578600] alg: No test for adler32 (adler32-zlib) [ 6996.784549] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 6997.059409] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 6998.826717] Key type lgssc registered [ 7000.259568] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7054.154053] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7070.600510] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 7074.670265] Lustre: Unmounted lustre-client [ 7100.955877] Key type lgssc unregistered [ 7101.299047] LNet: 259132:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7101.306425] LNetError: 259132:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7101.320506] LNet: Removed LNI 192.168.203.34@tcp [ 7102.278649] Key type .llcrypt unregistered [ 7102.280488] Key type ._llcrypt unregistered [ 7121.182279] Key type ._llcrypt registered [ 7121.185354] Key type .llcrypt registered [ 7122.551535] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 21:01:40 (1788915700) [ 7124.749384] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7124.912668] alg: No test for adler32 (adler32-zlib) [ 7126.140115] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 7126.367342] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 7128.039149] Key type lgssc registered [ 7129.406523] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7216.507915] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7255.325205] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7262.709609] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7265.495915] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 7268.727847] Lustre: Unmounted lustre-client [ 7297.333641] Key type lgssc unregistered [ 7297.545292] LNet: 262669:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7297.555628] LNetError: 262669:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7297.576937] LNet: Removed LNI 192.168.203.34@tcp [ 7298.385121] Key type .llcrypt unregistered [ 7298.388791] Key type ._llcrypt unregistered [ 7316.809308] Key type ._llcrypt registered [ 7316.811757] Key type .llcrypt registered [ 7318.461765] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 21:04:56 (1788915896) [ 7321.252036] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7321.358245] alg: No test for adler32 (adler32-zlib) [ 7322.475798] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 7322.926607] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 7324.791261] Key type lgssc registered [ 7326.641932] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7386.006428] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7392.605269] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7415.493989] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7417.435382] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 7422.456388] Lustre: lustre-MDT0000-mdc-ffff8bf043959800: Connection to lustre-MDT0000 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7428.908041] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7428.931822] LustreError: 265822:0:(file.c:6191:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 7429.466704] LustreError: MGC192.168.203.134@tcp: Connection to MGS (at 192.168.203.134@tcp) was lost; in progress operations using this service will fail [ 7429.538695] Lustre: Unmounted lustre-client [ 7452.067869] Key type lgssc unregistered [ 7452.448060] LNet: 266236:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7452.458058] LNetError: 266236:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7452.489440] LNet: Removed LNI 192.168.203.34@tcp [ 7453.341763] Key type .llcrypt unregistered [ 7453.347956] Key type ._llcrypt unregistered [ 7470.695564] Key type ._llcrypt registered [ 7470.701210] Key type .llcrypt registered [ 7472.013579] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 21:07:30 (1788916050) [ 7474.599298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7474.651983] alg: No test for adler32 (adler32-zlib) [ 7475.859226] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 7476.305895] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 7477.975529] Key type lgssc registered [ 7479.515152] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7535.072172] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7541.091518] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7564.750219] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7567.479479] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 7572.488892] Lustre: lustre-MDT0001-mdc-ffff8bf04390e000: Connection to lustre-MDT0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7577.537814] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7580.520805] Lustre: Unmounted lustre-client [ 7603.941977] Key type lgssc unregistered [ 7604.167051] LNet: 269811:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7604.177896] LNetError: 269811:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7604.211532] LNet: Removed LNI 192.168.203.34@tcp [ 7604.850924] Key type .llcrypt unregistered [ 7604.858949] Key type ._llcrypt unregistered [ 7622.199462] Key type ._llcrypt registered [ 7622.201689] Key type .llcrypt registered [ 7623.573316] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 21:10:01 (1788916201) [ 7643.097626] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7643.199036] alg: No test for adler32 (adler32-zlib) [ 7644.377402] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 7644.615910] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 7646.351177] Key type lgssc registered [ 7647.899584] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7762.138501] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7764.861091] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 7803.375445] Lustre: lustre-MDT0001-mdc-ffff8bf04abd4000: Connection to lustre-MDT0001 (at 192.168.203.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7810.698250] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7821.042542] Lustre: Unmounted lustre-client [ 7847.117156] Key type lgssc unregistered [ 7847.393848] LNet: 275614:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7847.405063] LNetError: 275614:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7847.416274] LNet: Removed LNI 192.168.203.34@tcp [ 7847.872467] Key type .llcrypt unregistered [ 7847.875766] Key type ._llcrypt unregistered [ 7861.914916] Key type ._llcrypt registered [ 7861.917140] Key type .llcrypt registered [ 7863.435119] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 21:14:01 (1788916441) [ 7865.211794] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 7866.815812] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 21:14:05 (1788916445) [ 7868.780588] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 7870.706559] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 21:14:08 (1788916448) [ 7872.856726] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 7875.541211] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 21:14:13 (1788916453) [ 7878.982356] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 7882.432600] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 21:14:19 (1788916459) [ 7884.589786] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 7887.418572] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 21:14:24 (1788916464) [ 7898.296356] Key type .llcrypt unregistered [ 7898.314819] Key type ._llcrypt unregistered [ 7906.412843] Key type ._llcrypt registered [ 7906.414486] Key type .llcrypt registered [ 7907.467925] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7907.508677] alg: No test for adler32 (adler32-zlib) [ 7908.638237] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 7908.802261] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 7910.543314] Key type lgssc registered [ 7911.769302] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7987.989727] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7994.132542] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8019.545739] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8021.390745] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 8024.113665] Lustre: Unmounted lustre-client [ 8066.583284] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 21:17:25 (1788916645) [ 8101.434225] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8108.803976] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8148.808038] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8149.886344] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 8153.691302] Lustre: Unmounted lustre-client [ 8197.475874] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 21:19:35 (1788916775) [ 8209.890475] LNet: 1 local NIs in recovery (showing 1): 192.168.203.34@tcp [ 8821.807514] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8825.089875] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8849.431741] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8904.574770] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 21:31:23 (1788917483) [ 8910.085283] Key type lgssc unregistered [ 8910.241480] LNet: 289126:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8910.245104] LNetError: 289126:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8910.258149] LNet: Removed LNI 192.168.203.34@tcp [ 8910.593416] Key type .llcrypt unregistered [ 8910.595245] Key type ._llcrypt unregistered [ 8973.720458] Key type ._llcrypt registered [ 8973.740116] Key type .llcrypt registered [ 8973.928683] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8973.941470] alg: No test for adler32 (adler32-zlib) [ 8974.873198] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 8975.014879] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 8976.623169] Key type lgssc registered [ 8977.247827] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9020.941743] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9023.746526] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9035.330496] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9066.270491] Key type lgssc unregistered [ 9066.426543] LNet: 292797:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9066.433130] LNetError: 292797:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9066.446675] LNet: Removed LNI 192.168.203.34@tcp [ 9066.804462] Key type .llcrypt unregistered [ 9066.808080] Key type ._llcrypt unregistered [ 9096.649084] Key type ._llcrypt registered [ 9096.650891] Key type .llcrypt registered [ 9097.335673] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 21:34:36 (1788917676) [ 9107.578943] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9107.587082] alg: No test for adler32 (adler32-zlib) [ 9108.507935] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 9108.626915] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 9110.247162] Key type lgssc registered [ 9110.822467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9133.836974] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 21:35:12 (1788917712) [ 9139.194648] Key type lgssc unregistered [ 9139.339441] LNet: 296341:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9139.344168] LNetError: 296341:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9139.355714] LNet: Removed LNI 192.168.203.34@tcp [ 9139.667199] Key type .llcrypt unregistered [ 9139.668915] Key type ._llcrypt unregistered [ 9144.728323] Key type ._llcrypt registered [ 9144.729952] Key type .llcrypt registered [ 9144.939786] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9144.954770] alg: No test for adler32 (adler32-zlib) [ 9145.868477] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 9145.987155] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 9147.608153] Key type lgssc registered [ 9148.234696] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9177.109566] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9179.976674] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9192.523426] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9311.418085] LNet: Added LNI 192.168.203.34@tcp50 [8/256/0/180] [ 9312.393788] LNet: Removed LNI 192.168.203.34@tcp [ 9313.841287] Lustre: 300699:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8bf048367800: config has no valid NIDs, force dynamic NIDs [ 9314.912495] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 9314.974138] Lustre: Unmounted lustre-client [ 9316.034231] Key type lgssc unregistered [ 9316.204707] LNet: 300956:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9316.208901] LNetError: 300956:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9316.221489] LNet: Removed LNI 192.168.203.34@tcp50 [ 9316.471392] Key type .llcrypt unregistered [ 9316.473057] Key type ._llcrypt unregistered [ 9326.898317] Key type ._llcrypt registered [ 9326.901160] Key type .llcrypt registered [ 9327.112839] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9327.143547] alg: No test for adler32 (adler32-zlib) [ 9328.018156] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 9328.120824] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 9329.711130] Key type lgssc registered [ 9330.170361] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9360.173311] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9362.300535] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9365.001836] LNet: Added LNI 192.168.203.34@tcp50 [8/256/0/180] [ 9365.302765] LNet: Removed LNI 192.168.203.34@tcp [ 9366.388476] Lustre: 303635:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8bf04abd1800: config has no valid NIDs, force dynamic NIDs [ 9367.448424] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 9367.668809] Lustre: Unmounted lustre-client [ 9388.026622] Key type lgssc unregistered [ 9388.184607] LNet: 304502:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9388.188079] LNetError: 304502:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9388.195217] LNet: Removed LNI 192.168.203.34@tcp50 [ 9388.442602] Key type .llcrypt unregistered [ 9388.444894] Key type ._llcrypt unregistered [ 9392.680616] Key type ._llcrypt registered [ 9392.682017] Key type .llcrypt registered [ 9393.207332] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 21:39:32 (1788917972) [ 9399.790808] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9399.800809] alg: No test for adler32 (adler32-zlib) [ 9400.670253] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 9400.769728] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 9402.359156] Key type lgssc registered [ 9402.838928] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9437.595939] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9439.872801] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9449.696655] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9469.855051] Key type lgssc unregistered [ 9469.984619] LNet: 309230:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9469.987422] LNetError: 309230:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9469.997473] LNet: Removed LNI 192.168.203.34@tcp [ 9470.266977] Key type .llcrypt unregistered [ 9470.268914] Key type ._llcrypt unregistered [ 9474.390659] Key type ._llcrypt registered [ 9474.392199] Key type .llcrypt registered [ 9474.927827] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 21:40:54 (1788918054) [ 9475.708482] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9475.716135] alg: No test for adler32 (adler32-zlib) [ 9476.595770] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 9476.706939] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 9478.303394] Key type lgssc registered [ 9478.783986] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9499.160266] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9501.238459] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9508.415703] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9519.102777] Lustre: Mounted lustre-client - version 2.17.57_86_g8205644 [ 9541.920942] Lustre: Mounted fs15246-client - version 2.17.57_86_g8205644 [ 9547.040459] Lustre: Unmounted fs15246-client [ 9560.057503] Lustre: Unmounted lustre-client [ 9577.080760] Key type lgssc unregistered [ 9577.199523] LNet: 314070:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9577.201867] LNetError: 314070:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9577.212769] LNet: Removed LNI 192.168.203.34@tcp [ 9577.473070] Key type .llcrypt unregistered [ 9577.474159] Key type ._llcrypt unregistered [ 9581.191612] Key type ._llcrypt registered [ 9581.193144] Key type .llcrypt registered [ 9581.693529] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 21:42:40 (1788918160) [ 9582.346045] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9582.360909] alg: No test for adler32 (adler32-zlib) [ 9583.223578] Lustre: Lustre: Build Version: 2.17.57_86_g8205644 [ 9583.315647] LNet: Added LNI 192.168.203.34@tcp [8/256/0/180] [ 9584.903142] Key type lgssc registered [ 9585.276899] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9632.088812] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9633.818158] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9641.831354] Lustre: DEBUG MARKER: oleg334-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9682.475942] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 9490 sec ========== 21:44:21 (1788918261) [ 9683.015854] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 21:44:22 (1788918262) === [ 9684.075639] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 21:44:23 (1788918263) === [ 9695.209027] Key type lgssc unregistered [ 9695.321421] LNet: 323306:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9695.324714] LNetError: 323306:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9695.332434] LNet: Removed LNI 192.168.203.34@tcp [ 9695.573715] Key type .llcrypt unregistered [ 9695.574946] Key type ._llcrypt unregistered