[ 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 440529159 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.001012] APIC: Switch to symmetric I/O mode setup [ 0.002403] x2apic enabled [ 0.003012] Switched APIC routing to physical x2apic. [ 0.004019] kvm-guest: setup PV IPIs [ 0.007429] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008025] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009012] pid_max: default: 32768 minimum: 301 [ 0.010149] LSM: Security Framework initializing [ 0.011048] Yama: becoming mindful. [ 0.012054] SELinux: Initializing. [ 0.013063] *** VALIDATE selinux *** [ 0.021724] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025739] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026155] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028085] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030066] *** VALIDATE tmpfs *** [ 0.031481] *** VALIDATE proc *** [ 0.032231] *** VALIDATE cgroup *** [ 0.033010] *** VALIDATE cgroup2 *** [ 0.034291] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035185] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037033] Spectre V2 : User space: Vulnerable [ 0.038012] Speculative Store Bypass: Vulnerable [ 0.040947] debug: unmapping init [mem 0xffffffffaf459000-0xffffffffaf460fff] [ 0.042806] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043773] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044027] ... version: 2 [ 0.045014] ... bit width: 48 [ 0.046014] ... generic registers: 4 [ 0.047015] ... value mask: 0000ffffffffffff [ 0.048015] ... max period: 00007fffffffffff [ 0.049018] ... fixed-purpose events: 3 [ 0.050015] ... event mask: 000000070000000f [ 0.051318] rcu: Hierarchical SRCU implementation. [ 0.053621] smp: Bringing up secondary CPUs ... [ 0.054588] x86: Booting SMP configuration: [ 0.055029] .... node #0, CPUs: #1 #2 #3 [ 0.058334] smp: Brought up 1 node, 4 CPUs [ 0.060015] smpboot: Max logical packages: 1 [ 0.061021] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.297485] node 0 deferred pages initialised in 232ms [ 0.300138] devtmpfs: initialized [ 0.301233] x86/mm: Memory block size: 128MB [ 0.303893] gcov: version magic: 0x41383552 [ 0.304649] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.308116] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.311375] pinctrl core: initialized pinctrl subsystem [ 0.314184] [ 0.314730] ************************************************************* [ 0.317014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.319013] ** ** [ 0.321013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.323012] ** ** [ 0.325017] ** This means that this kernel is built to expose internal ** [ 0.328016] ** IOMMU data structures, which may compromise security on ** [ 0.330013] ** your system. ** [ 0.333013] ** ** [ 0.335017] ** If you see this message and you are not debugging the ** [ 0.337019] ** kernel, report this immediately to your vendor! ** [ 0.339015] ** ** [ 0.342015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.344010] ************************************************************* [ 0.346773] NET: Registered protocol family 16 [ 0.348491] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.351066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.353045] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.356110] cpuidle: using governor menu [ 0.357562] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.359286] PCI: Using configuration type 1 for base access [ 0.362173] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.374087] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.377034] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.380103] cryptd: max_cpu_qlen set to 1000 [ 0.383755] ACPI: Added _OSI(Module Device) [ 0.385022] ACPI: Added _OSI(Processor Device) [ 0.387021] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.388020] ACPI: Added _OSI(Processor Aggregator Device) [ 0.394339] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.402610] ACPI: Interpreter enabled [ 0.404081] ACPI: PM: (supports S0 S3 S4 S5) [ 0.406026] ACPI: Using IOAPIC for interrupt routing [ 0.408157] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.412547] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.422816] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.425053] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.428030] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.432103] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.437389] acpiphp: Slot [2] registered [ 0.439124] acpiphp: Slot [5] registered [ 0.440151] acpiphp: Slot [6] registered [ 0.442152] acpiphp: Slot [3] registered [ 0.443097] acpiphp: Slot [4] registered [ 0.445128] acpiphp: Slot [7] registered [ 0.447112] acpiphp: Slot [8] registered [ 0.448133] acpiphp: Slot [9] registered [ 0.450187] acpiphp: Slot [10] registered [ 0.451159] acpiphp: Slot [11] registered [ 0.453176] acpiphp: Slot [12] registered [ 0.454153] acpiphp: Slot [13] registered [ 0.455497] acpiphp: Slot [14] registered [ 0.458165] acpiphp: Slot [15] registered [ 0.459229] acpiphp: Slot [16] registered [ 0.461269] acpiphp: Slot [17] registered [ 0.463247] acpiphp: Slot [18] registered [ 0.465176] acpiphp: Slot [19] registered [ 0.467162] acpiphp: Slot [20] registered [ 0.469171] acpiphp: Slot [21] registered [ 0.470230] acpiphp: Slot [22] registered [ 0.472174] acpiphp: Slot [23] registered [ 0.474140] acpiphp: Slot [24] registered [ 0.475154] acpiphp: Slot [25] registered [ 0.476191] acpiphp: Slot [26] registered [ 0.477164] acpiphp: Slot [27] registered [ 0.479184] acpiphp: Slot [28] registered [ 0.482213] acpiphp: Slot [29] registered [ 0.484184] acpiphp: Slot [30] registered [ 0.485128] acpiphp: Slot [31] registered [ 0.487080] PCI host bridge to bus 0000:00 [ 0.489030] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.491032] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.494032] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.496027] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.499032] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.501029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.503221] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.507058] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.510469] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.518020] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.522066] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.526035] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.528028] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.530027] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.534177] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.536922] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.540065] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.542949] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.548000] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.558025] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.561796] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.568496] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.576020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.580021] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.592021] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.601125] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.608016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.612017] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.624016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.633292] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.636419] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.639411] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.641444] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.645283] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.650198] iommu: Default domain type: Passthrough [ 0.652486] SCSI subsystem initialized [ 0.653120] ACPI: bus type USB registered [ 0.655121] usbcore: registered new interface driver usbfs [ 0.656077] usbcore: registered new interface driver hub [ 0.658089] usbcore: registered new device driver usb [ 0.660182] pps_core: LinuxPPS API ver. 1 registered [ 0.662016] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.665078] PTP clock support registered [ 0.666252] EDAC MC: Ver: 3.0.0 [ 0.668442] PCI: Using ACPI for IRQ routing [ 0.670753] NetLabel: Initializing [ 0.671012] NetLabel: domain hash size = 128 [ 0.673011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.674087] NetLabel: unlabeled traffic allowed by default [ 0.676147] vgaarb: loaded [ 0.678308] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.679015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.685005] clocksource: Switched to clocksource kvm-clock [ 0.800242] VFS: Disk quotas dquot_6.6.0 [ 0.802485] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.805432] *** VALIDATE ramfs *** [ 0.807080] *** VALIDATE hugetlbfs *** [ 0.808748] pnp: PnP ACPI init [ 0.811477] pnp: PnP ACPI: found 6 devices [ 0.834376] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.838335] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.840958] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.843465] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.846183] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.848876] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.852215] NET: Registered protocol family 2 [ 0.855076] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.860907] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.865249] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.871537] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.875549] TCP: Hash tables configured (established 65536 bind 65536) [ 0.878531] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.882084] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.885460] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.888782] NET: Registered protocol family 1 [ 0.891945] RPC: Registered named UNIX socket transport module. [ 0.894668] RPC: Registered udp transport module. [ 0.896832] RPC: Registered tcp transport module. [ 0.898828] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.901366] NET: Registered protocol family 44 [ 0.903288] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.905734] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.908256] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.911086] PCI: CLS 0 bytes, default 64 [ 0.913211] Unpacking initramfs... [ 2.379568] debug: unmapping init [mem 0xffff984b3cc64000-0xffff984b3ffcffff] [ 2.386308] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.388994] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.393736] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.914812] Initialise system trusted keyrings [ 2.917292] Key type blacklist registered [ 2.919779] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.933267] zbud: loaded [ 2.936890] *** VALIDATE nfs *** [ 2.938585] *** VALIDATE nfs4 *** [ 2.940958] pstore: using deflate compression [ 2.944994] Platform Keyring initialized [ 3.054679] NET: Registered protocol family 38 [ 3.059765] Key type asymmetric registered [ 3.061021] Asymmetric key parser 'x509' registered [ 3.062968] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.066475] io scheduler mq-deadline registered [ 3.068225] io scheduler kyber registered [ 3.069688] io scheduler bfq registered [ 3.071401] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.074515] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.076983] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.079451] ACPI: Power Button [PWRF] [ 3.084853] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.092960] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.109442] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.139375] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.169049] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.174488] Non-volatile memory driver v1.3 [ 3.176967] Linux agpgart interface v0.103 [ 3.209325] virtio_blk virtio1: [vda] 146016 512-byte logical blocks (74.8 MB/71.3 MiB) [ 3.214075] vda: detected capacity change from 0 to 74760192 [ 3.234611] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.237811] vdb: detected capacity change from 0 to 1073741824 [ 3.246706] libphy: Fixed MDIO Bus: probed [ 3.255542] usbcore: registered new interface driver usbserial_generic [ 3.258441] usbserial: USB Serial support registered for generic [ 3.261025] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.265610] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.267625] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.270523] mousedev: PS/2 mouse device common for all mice [ 3.274531] rtc_cmos 00:05: RTC can wake from S4 [ 3.277230] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.279230] rtc_cmos 00:05: registered as rtc0 [ 3.283763] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.286939] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.287729] intel_pstate: CPU model not supported [ 3.292219] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.297962] hid: raw HID events driver (C) Jiri Kosina [ 3.301922] usbcore: registered new interface driver usbhid [ 3.304485] usbhid: USB HID core driver [ 3.306280] drop_monitor: Initializing network drop monitor service [ 3.309303] Initializing XFRM netlink socket [ 3.311784] NET: Registered protocol family 10 [ 3.315281] Segment Routing with IPv6 [ 3.316803] NET: Registered protocol family 17 [ 3.319140] mpls_gso: MPLS GSO support [ 3.325363] RAS: Correctable Errors collector initialized. [ 3.327900] AVX version of gcm_enc/dec engaged. [ 3.330074] AES CTR mode by8 optimization enabled [ 3.409604] sched_clock: Marking stable (3409569162, 0)->(4329451473, -919882311) [ 3.413169] registered taskstats version 1 [ 3.415452] Loading compiled-in X.509 certificates [ 3.417523] zswap: loaded using pool lzo/zbud [ 3.443956] Key type big_key registered [ 3.458769] Key type encrypted registered [ 3.460711] ima: No TPM chip found, activating TPM-bypass! [ 3.463108] ima: Allocated hash algorithm: sha1 [ 3.465283] ima: No architecture policies found [ 3.467196] evm: Initialising EVM extended attributes: [ 3.469316] evm: security.selinux [ 3.470779] evm: security.ima [ 3.472013] evm: security.capability [ 3.473559] evm: HMAC attrs: 0x1 [ 3.476149] rtc_cmos 00:05: setting system clock to 2026-08-29 09:52:57 UTC (1787997177) [ 3.482937] debug: unmapping init [mem 0xffffffffb0403000-0xffffffffb05fffff] [ 3.486528] debug: unmapping init [mem 0xffffffffaf182000-0xffffffffaf458fff] [ 3.495538] Write protecting the kernel read-only data: 28672k [ 3.498959] debug: unmapping init [mem 0xffffffffad803000-0xffffffffad9fffff] [ 3.502316] debug: unmapping init [mem 0xffffffffae114000-0xffffffffae1fffff] [ 3.536523] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.546237] systemd[1]: Detected virtualization kvm. [ 3.548651] systemd[1]: Detected architecture x86-64. [ 3.550537] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.575268] systemd[1]: No hostname configured. [ 3.577280] systemd[1]: Set hostname to . [ 3.579618] random: systemd: uninitialized urandom read (16 bytes read) [ 3.581968] systemd[1]: Initializing machine ID from random generator. [ 3.644789] random: ln: uninitialized urandom read (6 bytes read) [ 3.748507] random: systemd: uninitialized urandom read (16 bytes read) [ 3.751299] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.759285] systemd[1]: Reached target Local Encrypted Volumes. [ OK ] Reached target Local Encrypted Volumes. [ 3.764248] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Local File Systems. [ OK ] Reached target Paths. Starting Setup Virtual Console... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Timers. [ OK ] Reached target Swap. Starting Create Volatile Files and Directories... [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.482297] device-mapper: uevent: version 1.0.3 [ 4.484801] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 5.268475] virtio_net virtio0 ens2: renamed from eth0 [ 5.347090] scsi host0: ata_piix [ 5.373954] scsi host1: ata_piix [ 5.375515] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.377900] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.955739] dracut-initqueue[582]: RTNETLINK answers: File exists [ 9.978397] random: crng init done [ 9.979671] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.940616] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 12.115202] printk: systemd: 26 output lines suppressed due to ratelimiting [ 12.384678] SELinux: Disabled at runtime. [ 12.449237] 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) [ 12.460410] systemd[1]: Detected virtualization kvm. [ 12.462669] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.979778] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.983763] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.989760] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.994752] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.998648] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 13.008855] systemd[1]: Starting Journal Service... Starting Journal Service... [ 13.021810] systemd[1]: Mounting Huge Pages File System... Mounting Huge Pages File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting POSIX Message Queue File System... [ OK ] Reached target rpc_pipefs.target. Starting Apply Kernel Variables... [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Initrd Root File System. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... Activating swap /dev/disk/by-label/SWAP... Starting Remount Root and Kernel File Systems... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK [[ 13.159655] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS 0m] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 13.539844] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.926434] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.943865] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 14.034861] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 14.061584] EDAC sbridge: Ver: 1.1.2 [ 15.336723] Key type dns_resolver registered [ 15.654987] NFS: Registering the id_resolver key type [ 15.657279] Key type id_resolver registered [ 15.659041] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] 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. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target sshd-keygen.target. Starting Network Manager... [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Authorization Manager. [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg447-client login: [ 43.391146] libcfs: loading out-of-tree module taints kernel. [ 43.446442] Key type ._llcrypt registered [ 43.448904] Key type .llcrypt registered [ 43.703391] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 43.713839] alg: No test for adler32 (adler32-zlib) [ 44.786358] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 45.180855] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 46.831194] Key type lgssc registered [ 47.673846] Lustre: Echo OBD driver; http://www.lustre.org/ [ 222.121124] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 228.262893] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 244.290809] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing check_logdir /tmp/testlogs/ [ 247.775619] Lustre: lustre-OST0000-osc-ffff984b84ec9000: disconnect after 23s idle [ 249.046979] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing yml_node [ 253.943871] Lustre: DEBUG MARKER: Client: 2.17.57.44 [ 256.771782] Lustre: DEBUG MARKER: MDS: 2.17.57.44 [ 259.644839] Lustre: DEBUG MARKER: OSS: 2.17.57.44 [ 261.530662] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sat Aug 29 05:57:13 EDT 2026 [ 275.350073] hrtimer: interrupt took 5058593 ns [ 279.723309] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 281.401957] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 284.715890] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 295.051850] Lustre: Unmounted lustre-client [ 414.905474] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 420.808732] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 447.561362] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 491.190244] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 06:01:03 (1787997663) [ 493.984372] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 496.084129] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 06:01:08 (1787997668) [ 534.933580] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 540.402263] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 563.810887] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 564.515395] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 571.213208] Lustre: Unmounted lustre-client [ 599.882233] Key type lgssc unregistered [ 600.188992] LNet: 15071:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 600.206632] LNetError: 15071:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 600.229857] LNet: Removed LNI 192.168.204.47@tcp [ 600.991166] Key type .llcrypt unregistered [ 600.993969] Key type ._llcrypt unregistered [ 619.374641] Key type ._llcrypt registered [ 619.376968] Key type .llcrypt registered [ 620.705334] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 06:03:13 (1787997793) [ 622.791343] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 622.976473] alg: No test for adler32 (adler32-zlib) [ 623.967508] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 624.163467] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 625.847212] Key type lgssc registered [ 626.998328] Lustre: Echo OBD driver; http://www.lustre.org/ [ 715.570063] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 810.148836] Lustre: Unmounted lustre-client [ 836.852485] Key type lgssc unregistered [ 837.066856] LNet: 18859:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 837.072408] LNetError: 18859:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 837.100625] LNet: Removed LNI 192.168.204.47@tcp [ 838.091498] Key type .llcrypt unregistered [ 838.095667] Key type ._llcrypt unregistered [ 848.713140] Key type ._llcrypt registered [ 848.715694] Key type .llcrypt registered [ 850.144174] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 06:07:02 (1787998022) [ 853.341921] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 853.354823] alg: No test for adler32 (adler32-zlib) [ 854.559902] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 854.786593] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 856.503310] Key type lgssc registered [ 857.781512] Lustre: Echo OBD driver; http://www.lustre.org/ [ 909.030609] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 915.093026] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 937.864724] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 940.540757] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 952.189468] Lustre: Unmounted lustre-client [ 975.901830] Key type lgssc unregistered [ 976.151250] LNet: 22471:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 976.166380] LNetError: 22471:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 976.180976] LNet: Removed LNI 192.168.204.47@tcp [ 976.752876] Key type .llcrypt unregistered [ 976.758115] Key type ._llcrypt unregistered [ 989.685248] Key type ._llcrypt registered [ 989.688032] Key type .llcrypt registered [ 991.191985] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 06:09:23 (1787998163) [ 994.343820] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 994.515411] alg: No test for adler32 (adler32-zlib) [ 995.714283] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 996.029508] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 997.687312] Key type lgssc registered [ 998.902316] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1051.580164] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1057.219488] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1080.040250] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1081.979377] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 1091.003225] Lustre: Unmounted lustre-client [ 1125.725881] Key type lgssc unregistered [ 1125.977097] LNet: 25664:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1125.983895] LNetError: 25664:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1126.005924] LNet: Removed LNI 192.168.204.47@tcp [ 1126.719872] Key type .llcrypt unregistered [ 1126.723035] Key type ._llcrypt unregistered [ 1142.356848] Key type ._llcrypt registered [ 1142.362099] Key type .llcrypt registered [ 1143.794320] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 06:11:56 (1787998316) [ 1146.096708] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1146.188895] alg: No test for adler32 (adler32-zlib) [ 1147.321363] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 1147.598557] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 1149.303208] Key type lgssc registered [ 1150.483789] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1198.711852] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1208.028741] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1231.449143] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1233.385670] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 1238.504701] Lustre: lustre-MDT0000-mdc-ffff984b82be2800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1248.764361] Lustre: lustre-MDT0001-mdc-ffff984b82be2800: Connection to lustre-MDT0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1256.782634] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1264.031372] Lustre: 26624:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787998422/real 1787998422] req@00000000aa9b49e7 x1874852127446912/t0(0) o400->MGC192.168.204.147@tcp@192.168.204.147@tcp:26/25 lens 224/224 e 0 to 1 dl 1787998438 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1264.085901] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 1267.114225] Lustre: Unmounted lustre-client [ 1288.851931] Key type lgssc unregistered [ 1289.158533] LNet: 29324:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1289.173673] LNetError: 29324:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1289.211094] LNet: Removed LNI 192.168.204.47@tcp [ 1289.966515] Key type .llcrypt unregistered [ 1289.976887] Key type ._llcrypt unregistered [ 1305.775474] Key type ._llcrypt registered [ 1305.777768] Key type .llcrypt registered [ 1307.193332] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 06:14:39 (1787998479) [ 1310.094673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1310.139018] alg: No test for adler32 (adler32-zlib) [ 1311.370741] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 1311.760772] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 1313.535267] Key type lgssc registered [ 1315.204509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1369.603434] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1375.493334] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1396.890441] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1398.482503] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 1410.353464] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1420.724418] Lustre: Unmounted lustre-client [ 1464.515861] Key type lgssc unregistered [ 1464.856195] LNet: 32941:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1464.868100] LNetError: 32941:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1464.877599] LNet: Removed LNI 192.168.204.47@tcp [ 1465.534670] Key type .llcrypt unregistered [ 1465.536880] Key type ._llcrypt unregistered [ 1480.003303] Key type ._llcrypt registered [ 1480.006364] Key type .llcrypt registered [ 1481.786269] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 06:17:33 (1787998653) [ 1485.145612] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1485.180537] alg: No test for adler32 (adler32-zlib) [ 1486.402878] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 1486.665604] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 1488.449426] Key type lgssc registered [ 1489.504285] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1541.211973] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1546.374680] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1572.895126] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1575.659337] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 1579.308956] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1582.068573] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1593.599669] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-29 6h19m26s [ 1595.909463] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1601.515915] Lustre: lustre-MDT0000-mdc-ffff984b82add800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1605.522108] LustreError: 36734:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff984b82add800: can't stat MDS #0: rc = -19 [ 1606.864292] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1613.798026] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 1613.818615] LustreError: lustre-MDT0000-mdc-ffff984b82add800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1613.840737] Lustre: lustre-MDT0000-mdc-ffff984b82add800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 1613.841282] Lustre: Evicted from MGS (at 192.168.204.147@tcp) after server handle changed from 0x6490f63a944279fb to 0x6490f63a94427ca9 [ 1620.127190] Lustre: DEBUG MARKER: Wait for df (36734) ... [ 1621.604987] Lustre: DEBUG MARKER: done [ 1623.667650] Lustre: Unmounted lustre-client [ 1650.476304] Key type lgssc unregistered [ 1650.701836] LNet: 37752:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1650.708592] LNetError: 37752:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1650.744563] LNet: Removed LNI 192.168.204.47@tcp [ 1651.450089] Key type .llcrypt unregistered [ 1651.451951] Key type ._llcrypt unregistered [ 1683.377305] Key type ._llcrypt registered [ 1683.379643] Key type .llcrypt registered [ 1684.632727] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 06:20:57 (1787998857) [ 1687.146174] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1687.207036] alg: No test for adler32 (adler32-zlib) [ 1688.272747] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 1688.462762] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 1690.151284] Key type lgssc registered [ 1691.420323] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1743.196459] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1749.083874] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1769.284473] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1770.864613] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 1777.170424] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-29 6h22m28s [ 1778.725883] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1785.049510] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1787.073842] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1807.327320] Lustre: 41897:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787998961/real 1787998961] req@00000000a7d1f88e x1874852694727296/t0(0) o101->lustre-MDT0000-mdc-ffff984b89b25800@192.168.204.147@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787998981 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1807.341717] Lustre: lustre-MDT0000-mdc-ffff984b89b25800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1807.357676] Lustre: lustre-MDT0000-mdc-ffff984b89b25800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 1828.644459] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1832.140884] Lustre: DEBUG MARKER: done [ 1834.491862] Lustre: Unmounted lustre-client [ 1862.793514] Key type lgssc unregistered [ 1863.049273] LNet: 42786:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1863.055531] LNetError: 42786:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1863.085433] LNet: Removed LNI 192.168.204.47@tcp [ 1863.890445] Key type .llcrypt unregistered [ 1863.894167] Key type ._llcrypt unregistered [ 1894.208897] Key type ._llcrypt registered [ 1894.213336] Key type .llcrypt registered [ 1895.378297] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 06:24:28 (1787999068) [ 1897.370321] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1899.033609] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 06:24:31 (1787999071) [ 1902.957347] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1903.066251] alg: No test for adler32 (adler32-zlib) [ 1904.167760] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 1904.440076] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 1906.119184] Key type lgssc registered [ 1907.231418] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1934.083994] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 06:25:06 (1787999106) [ 1963.808487] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1968.802713] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1989.524656] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1992.513700] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 1996.047929] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1999.127424] Lustre: Unmounted lustre-client [ 2010.529152] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2060.185713] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2067.231664] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2067.778751] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 2072.324164] Lustre: Unmounted lustre-client [ 2127.260569] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2132.448060] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2133.092662] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 2136.302215] Lustre: Unmounted lustre-client [ 2152.227399] Lustre: DEBUG MARKER: files compared the same [ 2174.413989] Key type lgssc unregistered [ 2174.687793] LNet: 50408:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2174.698590] LNetError: 50408:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2174.724808] LNet: Removed LNI 192.168.204.47@tcp [ 2175.368765] Key type .llcrypt unregistered [ 2175.379564] Key type ._llcrypt unregistered [ 2189.398893] Key type ._llcrypt registered [ 2189.412846] Key type .llcrypt registered [ 2190.920841] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 06:29:23 (1787999363) [ 2193.292488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2193.316707] alg: No test for adler32 (adler32-zlib) [ 2194.386624] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 2194.624944] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 2196.304919] Key type lgssc registered [ 2197.367696] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2242.522400] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2247.615640] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2268.318160] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2269.824687] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 2274.247287] Lustre: Unmounted lustre-client [ 2300.781662] Key type lgssc unregistered [ 2301.042572] LNet: 53992:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2301.050070] LNetError: 53992:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2302.123451] LNet: Removed LNI 192.168.204.47@tcp [ 2302.841734] Key type .llcrypt unregistered [ 2302.845281] Key type ._llcrypt unregistered [ 2316.274936] Key type ._llcrypt registered [ 2316.276641] Key type .llcrypt registered [ 2317.466813] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 06:31:30 (1787999490) [ 2319.548843] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2319.634941] alg: No test for adler32 (adler32-zlib) [ 2320.691883] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 2320.867319] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 2322.528112] Key type lgssc registered [ 2323.634493] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2399.172906] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2427.453787] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2432.199299] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2456.217765] Key type lgssc unregistered [ 2456.441596] LNet: 57486:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2456.452132] LNetError: 57486:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2456.466234] LNet: Removed LNI 192.168.204.47@tcp [ 2457.089211] Key type .llcrypt unregistered [ 2457.098603] Key type ._llcrypt unregistered [ 2469.477924] Key type ._llcrypt registered [ 2469.479571] Key type .llcrypt registered [ 2470.704197] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 06:34:03 (1787999643) [ 2473.497655] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2473.615712] alg: No test for adler32 (adler32-zlib) [ 2474.627286] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 2474.820646] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 2476.487201] Key type lgssc registered [ 2477.388317] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2534.229449] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 2540.742140] Lustre: Unmounted lustre-client [ 2575.075587] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 06:35:47 (1787999747) [ 2670.019245] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2688.557897] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 2695.218576] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2695.224485] LustreError: 63950:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff984b98982800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2695.239917] Lustre: 58470:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.147@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2705.540706] Lustre: Unmounted lustre-client [ 2754.624229] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 06:38:47 (1787999927) [ 2763.080783] Key type lgssc unregistered [ 2763.305653] LNet: 65165:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2763.312294] LNetError: 65165:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2763.333667] LNet: Removed LNI 192.168.204.47@tcp [ 2763.879359] Key type .llcrypt unregistered [ 2763.882683] Key type ._llcrypt unregistered [ 2772.826297] Key type ._llcrypt registered [ 2772.837979] Key type .llcrypt registered [ 2773.091547] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2773.104172] alg: No test for adler32 (adler32-zlib) [ 2774.211727] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 2774.457490] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 2776.207798] Key type lgssc registered [ 2777.217281] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2818.243315] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2823.093472] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2840.713161] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2843.344628] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 2846.842267] Lustre: Unmounted lustre-client [ 2871.455933] Key type lgssc unregistered [ 2871.671869] LNet: 68179:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2871.677272] LNetError: 68179:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2871.697566] LNet: Removed LNI 192.168.204.47@tcp [ 2872.424738] Key type .llcrypt unregistered [ 2872.433738] Key type ._llcrypt unregistered [ 2881.792232] Key type ._llcrypt registered [ 2881.794207] Key type .llcrypt registered [ 2882.241165] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2882.298481] alg: No test for adler32 (adler32-zlib) [ 2883.376536] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 2883.577704] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 2885.239226] Key type lgssc registered [ 2886.331398] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2977.337532] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2981.618648] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2998.596951] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3004.491249] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3006.436758] Lustre: Unmounted lustre-client [ 3029.652196] Key type lgssc unregistered [ 3029.869278] LNet: 71611:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3029.879031] LNetError: 71611:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3029.898404] LNet: Removed LNI 192.168.204.47@tcp [ 3030.510543] Key type .llcrypt unregistered [ 3030.513213] Key type ._llcrypt unregistered [ 3042.883935] Key type ._llcrypt registered [ 3042.889226] Key type .llcrypt registered [ 3043.887644] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 06:43:36 (1788000216) [ 3045.667696] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3045.689211] alg: No test for adler32 (adler32-zlib) [ 3046.789719] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3047.073518] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3048.727438] Key type lgssc registered [ 3049.633444] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3087.541822] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3091.715907] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3107.779059] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3114.545160] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3119.287346] Lustre: Unmounted lustre-client [ 3119.752166] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3122.098049] Lustre: Unmounted lustre-client [ 3144.992487] Key type lgssc unregistered [ 3145.180680] LNet: 75293:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3145.186145] LNetError: 75293:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3145.205455] LNet: Removed LNI 192.168.204.47@tcp [ 3145.751188] Key type .llcrypt unregistered [ 3145.753206] Key type ._llcrypt unregistered [ 3154.464624] Key type ._llcrypt registered [ 3154.469743] Key type .llcrypt registered [ 3154.747830] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3154.766268] alg: No test for adler32 (adler32-zlib) [ 3155.791549] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3156.005053] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3157.647254] Key type lgssc registered [ 3158.647248] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3199.732776] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3204.115859] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3222.292984] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3228.207177] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3231.521311] Lustre: Unmounted lustre-client [ 3255.833784] Key type lgssc unregistered [ 3256.073531] LNet: 78337:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3256.081456] LNetError: 78337:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3256.092577] LNet: Removed LNI 192.168.204.47@tcp [ 3256.671731] Key type .llcrypt unregistered [ 3256.674855] Key type ._llcrypt unregistered [ 3267.347912] Key type ._llcrypt registered [ 3267.349961] Key type .llcrypt registered [ 3268.286196] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 06:47:21 (1788000441) [ 3270.061746] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3270.080106] alg: No test for adler32 (adler32-zlib) [ 3271.084851] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3271.286478] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3272.943627] Key type lgssc registered [ 3273.905281] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3309.696094] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3313.925852] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3328.753150] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3340.841901] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3354.148046] Lustre: lustre: nosquash_nids is cleared [ 3354.181386] Lustre: lustre: root_squash is set to 500:500 [ 3361.622881] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.47@tcp 192.168.0.[2,10]@tcp [ 3367.579237] Lustre: lustre: nosquash_nids set to 192.168.204.47/24@tcp [ 3369.721627] Lustre: Unmounted lustre-client [ 3392.004798] Key type lgssc unregistered [ 3392.189731] LNet: 82268:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3392.195283] LNetError: 82268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3392.208352] LNet: Removed LNI 192.168.204.47@tcp [ 3392.718213] Key type .llcrypt unregistered [ 3392.722187] Key type ._llcrypt unregistered [ 3402.993841] Key type ._llcrypt registered [ 3402.997704] Key type .llcrypt registered [ 3403.976963] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 06:49:36 (1788000576) [ 3405.745514] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3407.190924] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 06:49:40 (1788000580) [ 3408.882819] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3408.921228] alg: No test for adler32 (adler32-zlib) [ 3409.939552] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3410.134402] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3411.783328] Key type lgssc registered [ 3412.624083] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3450.956546] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3455.224824] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3469.784267] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3470.164835] Lustre: lustre: root_squash is set to 500:500 [ 3470.185432] Lustre: lustre: nosquash_nids set to 192.168.204.47/24@tcp [ 3480.587332] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3484.357744] Lustre: Unmounted lustre-client [ 3513.577931] Key type lgssc unregistered [ 3513.727035] LNet: 86230:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3513.732411] LNetError: 86230:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3513.741451] LNet: Removed LNI 192.168.204.47@tcp [ 3514.085937] Key type .llcrypt unregistered [ 3514.088914] Key type ._llcrypt unregistered [ 3523.014341] Key type ._llcrypt registered [ 3523.018960] Key type .llcrypt registered [ 3523.953644] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3525.260641] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 06:51:38 (1788000698) [ 3538.987177] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3539.011960] alg: No test for adler32 (adler32-zlib) [ 3540.009028] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3540.218850] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3541.871198] Key type lgssc registered [ 3542.816543] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3602.774664] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3607.420283] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3624.864332] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3692.179549] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3696.042411] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3709.704804] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3723.633962] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3743.786155] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff984b87131000.ost_server_uuid 50 [ 3744.779908] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff984b87131000.ost_server_uuid in FULL state after 0 sec [ 3745.028486] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3747.403216] Lustre: Unmounted lustre-client [ 3748.316908] Lustre: Unmounted lustre-client [ 3779.801426] Key type lgssc unregistered [ 3780.010198] LNet: 93880:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3780.019220] LNetError: 93880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3780.034349] LNet: Removed LNI 192.168.204.47@tcp [ 3780.521341] Key type .llcrypt unregistered [ 3780.524227] Key type ._llcrypt unregistered [ 3801.363899] Key type ._llcrypt registered [ 3801.366190] Key type .llcrypt registered [ 3802.159889] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 06:56:15 (1788000975) [ 3812.817417] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3812.870651] alg: No test for adler32 (adler32-zlib) [ 3813.835181] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3814.028669] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3815.655236] Key type lgssc registered [ 3816.342843] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3865.220506] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3868.701100] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3882.818259] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3885.269250] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 3906.015117] Lustre: 95251:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788001064/real 1788001064] req@00000000496bdebc x1874854923998464/t0(0) o400->lustre-OST0000-osc-ffff984b91fb2800@192.168.204.147@tcp:28/4 lens 224/224 e 0 to 1 dl 1788001080 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3906.039428] Lustre: lustre-OST0000-osc-ffff984b91fb2800: Connection to lustre-OST0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3908.272895] Lustre: lustre-OST0000-osc-ffff984b91fb2800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 3911.143189] Lustre: 95252:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788001069/real 1788001069] req@000000006319867e x1874854923998976/t0(0) o400->lustre-OST0000-osc-ffff984b91fb2800@192.168.204.147@tcp:28/4 lens 224/224 e 0 to 1 dl 1788001085 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3911.152837] Lustre: lustre-MDT0000-mdc-ffff984b91fb2800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3916.301634] Lustre: 95252:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788001074/real 1788001074] req@00000000daa6bd48 x1874854923999488/t0(0) o400->lustre-OST0000-osc-ffff984b91fb2800@192.168.204.147@tcp:28/4 lens 224/224 e 0 to 1 dl 1788001090 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3926.507126] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 3926.516851] Lustre: 98418:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.204.147@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 3926.522103] Lustre: Evicted from MGS (at 192.168.204.147@tcp) after server handle changed from 0x9d43b1c5799e8d31 to 0x9d43b1c5799e8fed [ 3926.532876] Lustre: MGC192.168.204.147@tcp: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 3931.314317] Lustre: lustre-MDT0000-mdc-ffff984b91fb2800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 3932.554514] Lustre: Unmounted lustre-client [ 3954.114656] Key type lgssc unregistered [ 3954.289182] LNet: 99541:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3954.294955] LNetError: 99541:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3954.306234] LNet: Removed LNI 192.168.204.47@tcp [ 3954.733586] Key type .llcrypt unregistered [ 3954.735243] Key type ._llcrypt unregistered [ 3963.514735] Key type ._llcrypt registered [ 3963.516544] Key type .llcrypt registered [ 3964.267033] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 06:58:57 (1788001137) [ 3977.004050] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3977.019339] alg: No test for adler32 (adler32-zlib) [ 3977.970399] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 3978.127554] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 3979.759985] Key type lgssc registered [ 3980.507235] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4002.734829] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4055.665255] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4058.732439] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4071.803267] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4078.601514] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4079.876505] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4080.941826] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 07:00:54 (1788001254) [ 4216.788956] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4227.072760] Lustre: Unmounted lustre-client [ 4306.354688] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4309.355154] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4322.254958] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4348.435355] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 07:05:21 (1788001521) [ 4399.054390] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4402.201115] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4415.534407] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4415.912063] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4418.297868] Lustre: Unmounted lustre-client [ 4440.382546] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 07:06:53 (1788001613) [ 4489.369400] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4492.168389] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4504.287960] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4504.664357] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4506.907223] Lustre: Unmounted lustre-client [ 4529.605169] Key type lgssc unregistered [ 4529.749670] LNet: 122504:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4529.753907] LNetError: 122504:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4529.762939] LNet: Removed LNI 192.168.204.47@tcp [ 4530.093554] Key type .llcrypt unregistered [ 4530.096188] Key type ._llcrypt unregistered [ 4537.113986] Key type ._llcrypt registered [ 4537.115627] Key type .llcrypt registered [ 4537.741435] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 07:08:31 (1788001711) [ 4538.866703] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4538.880271] alg: No test for adler32 (adler32-zlib) [ 4539.787474] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 4539.902497] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 4541.511274] Key type lgssc registered [ 4542.152769] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4567.589765] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4570.066503] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4580.291394] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4582.704186] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4598.062212] Lustre: Unmounted lustre-client [ 4617.419844] Key type lgssc unregistered [ 4617.551649] LNet: 126093:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4617.555575] LNetError: 126093:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4617.564321] LNet: Removed LNI 192.168.204.47@tcp [ 4617.894122] Key type .llcrypt unregistered [ 4617.896122] Key type ._llcrypt unregistered [ 4624.414216] Key type ._llcrypt registered [ 4624.416139] Key type .llcrypt registered [ 4625.112063] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 07:09:58 (1788001798) [ 4626.060051] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4626.110470] alg: No test for adler32 (adler32-zlib) [ 4626.990837] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 4627.102586] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 4628.711227] Key type lgssc registered [ 4629.412441] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4654.730148] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4657.593804] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4666.928988] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4673.524607] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4684.875895] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff984b84859800.ost_server_uuid 50 [ 4699.103485] Lustre: 127050:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788001857/real 1788001857] req@0000000048da4f4e x1874855776491520/t0(0) o400->lustre-OST0000-osc-ffff984b84859800@192.168.204.147@tcp:28/4 lens 224/224 e 0 to 1 dl 1788001873 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4699.119784] Lustre: lustre-OST0000-osc-ffff984b84859800: Connection to lustre-OST0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4700.250592] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 4704.223155] Lustre: 127049:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788001862/real 1788001862] req@00000000e8777b37 x1874855776492032/t0(0) o400->lustre-OST0000-osc-ffff984b84859800@192.168.204.147@tcp:28/4 lens 224/224 e 0 to 1 dl 1788001878 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4710.169149] Lustre: Unmounted lustre-client [ 4722.756483] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 07:11:36 (1788001896) [ 4737.859033] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4740.249647] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4749.362500] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4760.202571] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4760.455792] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4765.668571] Lustre: lustre-OST0000-osc-ffff984b84906000: Connection to lustre-OST0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4781.791190] Lustre: Unmounted lustre-client [ 4809.755923] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 07:13:02 (1788001982) [ 4824.112865] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4826.626421] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4835.310028] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4843.959099] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4844.209826] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 4849.636067] Lustre: lustre-OST0000-osc-ffff984b870af800: Connection to lustre-OST0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4869.805479] Lustre: Unmounted lustre-client [ 4894.166427] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 07:14:27 (1788002067) [ 4925.642778] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4927.540691] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4936.347343] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4968.626543] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4970.784471] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4978.776431] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4998.152524] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5026.573899] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5027.090817] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5027.435134] Lustre: Unmounted lustre-client [ 5038.314050] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 07:16:51 (1788002211) [ 5049.972219] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5051.994492] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5059.565678] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5076.318144] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5085.927056] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5114.403815] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5114.952320] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5116.898194] Lustre: lustre-OST0001-osc-ffff984b84eca800: Connection to lustre-OST0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5118.665555] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5128.956183] Lustre: Unmounted lustre-client [ 5160.219273] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 07:18:53 (1788002333) [ 5172.849614] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5174.977272] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5182.999637] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5183.228509] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5192.193435] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5193.725265] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 5198.942361] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff984b91fb0800.ost_server_uuid 50 [ 5199.484259] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff984b91fb0800.ost_server_uuid in FULL state after 0 sec [ 5200.223184] Lustre: Unmounted lustre-client [ 5200.333115] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5200.336321] Lustre: Skipped 3 previous similar messages [ 5200.374263] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5200.756661] LustreError: 149515:0:(sec.c:403:import_sec_validate_get()) import 00000000cea2c5a6 (NEW) with no sec [ 5234.328752] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 07:20:07 (1788002407) [ 5246.992331] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5248.934626] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5256.144092] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5263.528700] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5263.686401] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5268.979892] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5271.690183] Lustre: Unmounted lustre-client [ 5271.691434] Lustre: Skipped 1 previous similar message [ 5304.502505] Key type lgssc unregistered [ 5304.623584] LNet: 152888:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5304.626316] LNetError: 152888:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5304.636592] LNet: Removed LNI 192.168.204.47@tcp [ 5304.898053] Key type .llcrypt unregistered [ 5304.899862] Key type ._llcrypt unregistered [ 5309.866093] Key type ._llcrypt registered [ 5309.867445] Key type .llcrypt registered [ 5310.391933] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 07:21:23 (1788002483) [ 5310.789884] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5310.797326] alg: No test for adler32 (adler32-zlib) [ 5311.655713] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5311.747926] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5313.335171] Key type lgssc registered [ 5313.718214] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5332.715290] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5334.551875] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5341.375404] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5348.169496] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5348.303852] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5353.459744] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5354.013740] LustreError: lustre-MDT0001-mdc-ffff984b913fc800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5354.020619] Lustre: lustre-MDT0001-mdc-ffff984b913fc800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 5356.015123] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5356.596588] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5371.878401] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5373.113557] Lustre: Unmounted lustre-client [ 5392.245413] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 07:22:45 (1788002565) [ 5422.273406] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5423.986645] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5431.861937] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5432.052714] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5442.334635] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5442.848466] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5456.867431] Lustre: lustre-OST0001-osc-ffff984b98984000: Connection to lustre-OST0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5460.350137] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5470.648130] Lustre: Unmounted lustre-client [ 5502.321414] Key type lgssc unregistered [ 5502.448360] LNet: 162454:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5502.451563] LNetError: 162454:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5502.460471] LNet: Removed LNI 192.168.204.47@tcp [ 5502.715912] Key type .llcrypt unregistered [ 5502.716943] Key type ._llcrypt unregistered [ 5512.999228] Key type ._llcrypt registered [ 5513.000378] Key type .llcrypt registered [ 5513.486112] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 07:24:46 (1788002686) [ 5514.149675] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5514.157360] alg: No test for adler32 (adler32-zlib) [ 5515.024437] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5515.114745] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5516.695169] Key type lgssc registered [ 5517.096914] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5534.975272] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5536.790418] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5543.290352] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5549.530984] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5586.266561] Lustre: Unmounted lustre-client [ 5602.649838] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5602.796589] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5634.865393] Lustre: Unmounted lustre-client [ 5652.099631] Key type lgssc unregistered [ 5652.227637] LNet: 166899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5652.229664] LNetError: 166899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5652.239669] LNet: Removed LNI 192.168.204.47@tcp [ 5652.505068] Key type .llcrypt unregistered [ 5652.506144] Key type ._llcrypt unregistered [ 5657.884207] Key type ._llcrypt registered [ 5657.885141] Key type .llcrypt registered [ 5658.365300] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 07:27:11 (1788002831) [ 5659.187928] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5659.193970] alg: No test for adler32 (adler32-zlib) [ 5660.057244] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5660.173013] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5661.759147] Key type lgssc registered [ 5662.136640] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5679.852914] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5681.684852] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5688.237176] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5698.544116] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5705.380205] Lustre: Unmounted lustre-client [ 5722.664442] Key type lgssc unregistered [ 5722.781585] LNet: 170639:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5722.784538] LNetError: 170639:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5722.793450] LNet: Removed LNI 192.168.204.47@tcp [ 5723.052914] Key type .llcrypt unregistered [ 5723.053957] Key type ._llcrypt unregistered [ 5727.330449] Key type ._llcrypt registered [ 5727.336725] Key type .llcrypt registered [ 5727.554672] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5727.562581] alg: No test for adler32 (adler32-zlib) [ 5728.446158] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5728.569187] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5730.175267] Key type lgssc registered [ 5730.633345] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5749.336695] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5751.284287] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5757.784726] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5768.196936] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5770.998171] Lustre: Unmounted lustre-client [ 5796.550487] Key type lgssc unregistered [ 5796.665702] LNet: 173698:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5796.668342] LNetError: 173698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5796.679196] LNet: Removed LNI 192.168.204.47@tcp [ 5796.952169] Key type .llcrypt unregistered [ 5796.953502] Key type ._llcrypt unregistered [ 5802.533130] Key type ._llcrypt registered [ 5802.534648] Key type .llcrypt registered [ 5803.069180] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 07:29:36 (1788002976) [ 5803.904124] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5803.938981] alg: No test for adler32 (adler32-zlib) [ 5804.808922] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5804.906242] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5806.503274] Key type lgssc registered [ 5806.950367] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5825.537609] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5827.382354] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5833.974491] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5844.464170] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5851.162263] Lustre: Unmounted lustre-client [ 5876.379851] Key type lgssc unregistered [ 5876.492562] LNet: 177442:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5876.494912] LNetError: 177442:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5876.503204] LNet: Removed LNI 192.168.204.47@tcp [ 5876.760197] Key type .llcrypt unregistered [ 5876.761838] Key type ._llcrypt unregistered [ 5880.944371] Key type ._llcrypt registered [ 5880.945953] Key type .llcrypt registered [ 5881.093288] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5881.098199] alg: No test for adler32 (adler32-zlib) [ 5881.951629] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5882.036634] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5883.631207] Key type lgssc registered [ 5884.021288] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5901.672653] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5903.457053] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5910.017109] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5920.754703] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 5923.558356] Lustre: Unmounted lustre-client [ 5932.290759] Key type lgssc unregistered [ 5932.394490] LNet: 180497:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5932.396834] LNetError: 180497:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5932.405355] LNet: Removed LNI 192.168.204.47@tcp [ 5932.655827] Key type .llcrypt unregistered [ 5932.657131] Key type ._llcrypt unregistered [ 5937.550809] Key type ._llcrypt registered [ 5937.551833] Key type .llcrypt registered [ 5937.977700] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 07:31:51 (1788003111) [ 5944.442842] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5944.484618] alg: No test for adler32 (adler32-zlib) [ 5945.328134] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 5945.415308] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 5946.999148] Key type lgssc registered [ 5947.379822] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5977.772557] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5979.663851] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5987.953501] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6009.563606] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 07:33:03 (1788003183) [ 6020.269033] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6022.095430] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6028.568064] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6039.026695] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6041.057164] Lustre: Unmounted lustre-client [ 6058.364170] Key type lgssc unregistered [ 6058.489333] LNet: 187569:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6058.491430] LNetError: 187569:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6058.500259] LNet: Removed LNI 192.168.204.47@tcp [ 6058.795116] Key type .llcrypt unregistered [ 6058.796379] Key type ._llcrypt unregistered [ 6063.784450] Key type ._llcrypt registered [ 6063.785326] Key type .llcrypt registered [ 6064.234026] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 6064.753489] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 07:33:58 (1788003238) [ 6070.342514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6070.352185] alg: No test for adler32 (adler32-zlib) [ 6071.219752] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 6071.305767] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 6072.887147] Key type lgssc registered [ 6073.232336] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6104.739811] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6106.560381] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6114.420744] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6120.701654] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6121.858326] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6127.601911] Lustre: Unmounted lustre-client [ 6191.842663] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6193.767784] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6201.621736] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6224.956641] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 07:36:38 (1788003398) [ 6225.457492] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 6226.004555] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 07:36:39 (1788003399) [ 6269.229350] Key type lgssc unregistered [ 6269.350574] LNet: 198965:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6269.352679] LNetError: 198965:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6269.360764] LNet: Removed LNI 192.168.204.47@tcp [ 6269.595427] Key type .llcrypt unregistered [ 6269.596229] Key type ._llcrypt unregistered [ 6274.832647] Key type ._llcrypt registered [ 6274.833516] Key type .llcrypt registered [ 6275.267100] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 07:37:28 (1788003448) [ 6297.611698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6297.639843] alg: No test for adler32 (adler32-zlib) [ 6298.527692] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 6298.630383] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 6300.223134] Key type lgssc registered [ 6300.609592] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6314.826156] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6316.553116] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6336.057307] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6355.371314] Key type lgssc unregistered [ 6355.486358] LNet: 202685:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6355.489750] LNetError: 202685:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6355.504238] LNet: Removed LNI 192.168.204.47@tcp [ 6355.736240] Key type .llcrypt unregistered [ 6355.737733] Key type ._llcrypt unregistered [ 6360.652194] Key type ._llcrypt registered [ 6360.653108] Key type .llcrypt registered [ 6361.085756] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 07:38:54 (1788003534) [ 6361.838659] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6361.869905] alg: No test for adler32 (adler32-zlib) [ 6362.729471] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 6362.812201] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 6364.391201] Key type lgssc registered [ 6364.782034] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6381.726538] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6383.424304] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6392.251640] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6404.059735] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6409.187097] Lustre: lustre-MDT0000-mdc-ffff984b84ecb800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6414.306456] Lustre: lustre-MDT0001-mdc-ffff984b84ecb800: Connection to lustre-MDT0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6424.544689] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 6424.549744] Lustre: Evicted from MGS (at 192.168.204.147@tcp) after server handle changed from 0x90513f51983c757a to 0x90513f51983c8ee1 [ 6424.552721] Lustre: MGC192.168.204.147@tcp: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 6430.178274] Lustre: 205786:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.204.147@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 6447.538817] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6449.122827] LustreError: lustre-MDT0000-mdc-ffff984b84ecb800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6449.148369] Lustre: lustre-MDT0000-mdc-ffff984b84ecb800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 6450.075384] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 2 sec [ 6451.930572] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6452.502384] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6453.164143] Lustre: Unmounted lustre-client [ 6470.691140] Key type lgssc unregistered [ 6470.811661] LNet: 207633:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6470.814400] LNetError: 207633:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6470.824354] LNet: Removed LNI 192.168.204.47@tcp [ 6471.126360] Key type .llcrypt unregistered [ 6471.127315] Key type ._llcrypt unregistered [ 6476.700096] Key type ._llcrypt registered [ 6476.701943] Key type .llcrypt registered [ 6477.153590] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 07:40:50 (1788003650) [ 6477.935294] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6478.000166] alg: No test for adler32 (adler32-zlib) [ 6478.875342] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 6478.970609] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 6480.551235] Key type lgssc registered [ 6480.992244] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6499.656733] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6501.514797] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6523.875661] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6525.748515] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6540.034351] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6547.449974] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6572.611726] Key type lgssc unregistered [ 6572.744385] LNet: 212908:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6572.748414] LNetError: 212908:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6572.756348] LNet: Removed LNI 192.168.204.47@tcp [ 6573.027780] Key type .llcrypt unregistered [ 6573.029216] Key type ._llcrypt unregistered [ 6593.705296] Key type ._llcrypt registered [ 6593.706626] Key type .llcrypt registered [ 6594.177866] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 07:42:47 (1788003767) [ 6605.334137] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6605.373075] alg: No test for adler32 (adler32-zlib) [ 6606.245155] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 6606.337167] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 6607.919115] Key type lgssc registered [ 6608.353737] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6638.436163] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6640.144817] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6647.655808] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6678.444324] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 07:44:11 (1788003851) [ 6680.954063] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 07:44:14 (1788003854) [ 6691.808840] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6693.646098] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6700.500350] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6711.278727] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6714.343151] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 6715.035580] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 6715.558037] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 6716.050983] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 6721.505457] Lustre: lustre-MDT0000-mdc-ffff984b83bdf800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6731.745220] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 6731.754200] Lustre: Evicted from MGS (at 192.168.204.147@tcp) after server handle changed from 0x41395c0cba490d93 to 0x41395c0cba491009 [ 6731.759625] Lustre: MGC192.168.204.147@tcp: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 6735.008449] Lustre: lustre-MDT0000-mdc-ffff984b83bdf800: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 6736.796082] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6737.354910] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6739.264081] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 6741.986761] Lustre: lustre-MDT0000-mdc-ffff984b83bdf800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6757.345260] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 6757.353324] Lustre: Evicted from MGS (at 192.168.204.147@tcp) after server handle changed from 0x41395c0cba491009 to 0x41395c0cba491319 [ 6757.357135] Lustre: MGC192.168.204.147@tcp: Connection restored to 192.168.204.147@tcp (at 192.168.204.147@tcp) [ 6760.326771] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6760.872211] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6762.448562] Lustre: Unmounted lustre-client [ 6794.675472] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6796.393766] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6802.615773] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6813.169701] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6813.528332] Lustre: Unmounted lustre-client [ 6831.001717] Key type lgssc unregistered [ 6831.119326] LNet: 225339:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6831.122180] LNetError: 225339:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6831.128728] LNet: Removed LNI 192.168.204.47@tcp [ 6831.357302] Key type .llcrypt unregistered [ 6831.358715] Key type ._llcrypt unregistered [ 6836.902132] Key type ._llcrypt registered [ 6836.904223] Key type .llcrypt registered [ 6837.460717] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 07:46:50 (1788004010) [ 6838.945179] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6838.953908] alg: No test for adler32 (adler32-zlib) [ 6839.823387] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 6839.908612] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 6841.487146] Key type lgssc registered [ 6841.897752] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6860.323584] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6862.114278] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6868.724300] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6879.217196] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6882.203194] Lustre: Unmounted lustre-client [ 6914.446125] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6916.284212] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6922.713882] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6933.490173] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6939.580973] Lustre: Unmounted lustre-client [ 6971.703288] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6973.458140] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6980.292391] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6990.833084] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 6991.196160] Lustre: Unmounted lustre-client [ 7008.399154] Key type lgssc unregistered [ 7008.508534] LNet: 232360:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7008.511495] LNetError: 232360:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7008.519483] LNet: Removed LNI 192.168.204.47@tcp [ 7008.747829] Key type .llcrypt unregistered [ 7008.748858] Key type ._llcrypt unregistered [ 7013.611691] Key type ._llcrypt registered [ 7013.613322] Key type .llcrypt registered [ 7014.026491] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 07:49:47 (1788004187) [ 7015.093243] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7015.101749] alg: No test for adler32 (adler32-zlib) [ 7015.947133] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7016.030430] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7017.607147] Key type lgssc registered [ 7017.941318] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7032.417330] Key type lgssc unregistered [ 7032.527347] LNet: 234677:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7032.529360] LNetError: 234677:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7032.537347] LNet: Removed LNI 192.168.204.47@tcp [ 7032.788766] Key type .llcrypt unregistered [ 7032.789689] Key type ._llcrypt unregistered [ 7041.555263] Key type ._llcrypt registered [ 7041.556129] Key type .llcrypt registered [ 7041.723727] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7041.728600] alg: No test for adler32 (adler32-zlib) [ 7042.570708] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7042.650832] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7044.231156] Key type lgssc registered [ 7044.575716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7071.342414] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7073.010717] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7080.518316] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7109.296990] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 7109.834607] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 07:51:23 (1788004283) [ 7119.357682] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7120.956070] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7126.967824] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7134.460449] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7135.636956] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7138.975098] LustreError: lustre-OST0001-osc-ffff984b88554000: operation ost_statfs to node 192.168.204.147@tcp failed: rc = -107 [ 7138.977700] Lustre: lustre-OST0001-osc-ffff984b88554000: Connection to lustre-OST0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7139.270239] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7149.562155] Lustre: Unmounted lustre-client [ 7172.945430] Key type lgssc unregistered [ 7173.055756] LNet: 241759:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7173.060329] LNetError: 241759:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7173.072364] LNet: Removed LNI 192.168.204.47@tcp [ 7173.292212] Key type .llcrypt unregistered [ 7173.293189] Key type ._llcrypt unregistered [ 7182.639564] Key type ._llcrypt registered [ 7182.640638] Key type .llcrypt registered [ 7183.046182] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 07:52:36 (1788004356) [ 7187.107328] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7187.126567] alg: No test for adler32 (adler32-zlib) [ 7187.975835] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7188.066477] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7189.647119] Key type lgssc registered [ 7190.060801] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7206.698349] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7208.295640] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7227.730094] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 07:53:21 (1788004401) [ 7237.551171] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7239.319768] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7245.897850] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7247.074239] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7251.046507] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7258.083245] Lustre: Unmounted lustre-client [ 7306.138864] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7307.873580] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7341.382398] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7351.792735] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7352.190140] Lustre: Unmounted lustre-client [ 7369.273075] Key type lgssc unregistered [ 7369.388559] LNet: 249495:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7369.390907] LNetError: 249495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7369.399817] LNet: Removed LNI 192.168.204.47@tcp [ 7369.647070] Key type .llcrypt unregistered [ 7369.648167] Key type ._llcrypt unregistered [ 7378.207779] Key type ._llcrypt registered [ 7378.208808] Key type .llcrypt registered [ 7378.378853] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7378.391436] alg: No test for adler32 (adler32-zlib) [ 7379.236958] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7379.319896] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7380.895131] Key type lgssc registered [ 7381.222224] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7408.522832] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7410.264585] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7417.660588] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7438.174880] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 7438.679748] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 07:56:52 (1788004612) [ 7448.715277] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7450.545458] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7456.539456] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7468.016557] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7468.820439] Lustre: Unmounted lustre-client [ 7485.878480] Key type lgssc unregistered [ 7485.985663] LNet: 256102:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7485.987801] LNetError: 256102:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7485.994824] LNet: Removed LNI 192.168.204.47@tcp [ 7486.248540] Key type .llcrypt unregistered [ 7486.249845] Key type ._llcrypt unregistered [ 7491.268169] Key type ._llcrypt registered [ 7491.269050] Key type .llcrypt registered [ 7491.722873] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 7492.285113] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 07:57:45 (1788004665) [ 7495.149385] Key type .llcrypt unregistered [ 7495.150531] Key type ._llcrypt unregistered [ 7498.131134] Key type ._llcrypt registered [ 7498.131986] Key type .llcrypt registered [ 7498.278851] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7498.283480] alg: No test for adler32 (adler32-zlib) [ 7499.130887] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7499.231439] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7500.815137] Key type lgssc registered [ 7501.240976] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7523.821965] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7534.590632] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7535.193587] Lustre: Unmounted lustre-client [ 7552.415212] Key type lgssc unregistered [ 7552.547677] LNet: 259549:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7552.553188] LNetError: 259549:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7552.564265] LNet: Removed LNI 192.168.204.47@tcp [ 7552.901996] Key type .llcrypt unregistered [ 7552.903685] Key type ._llcrypt unregistered [ 7558.388533] Key type ._llcrypt registered [ 7558.389485] Key type .llcrypt registered [ 7558.918109] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 07:58:52 (1788004732) [ 7559.802416] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7559.809815] alg: No test for adler32 (adler32-zlib) [ 7560.668981] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7560.760439] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7562.367165] Key type lgssc registered [ 7562.748254] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7624.894343] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7639.775835] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7641.867055] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7644.095553] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7644.560164] Lustre: Unmounted lustre-client [ 7661.416947] Key type lgssc unregistered [ 7661.536455] LNet: 263081:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7661.539254] LNetError: 263081:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7661.545645] LNet: Removed LNI 192.168.204.47@tcp [ 7661.778520] Key type .llcrypt unregistered [ 7661.779517] Key type ._llcrypt unregistered [ 7666.986401] Key type ._llcrypt registered [ 7666.987406] Key type .llcrypt registered [ 7667.459934] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 08:00:40 (1788004840) [ 7668.184364] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7668.205223] alg: No test for adler32 (adler32-zlib) [ 7669.073904] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7669.158225] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7670.735160] Key type lgssc registered [ 7671.131840] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7688.908478] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7690.647562] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7696.949303] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7707.630082] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7712.738097] Lustre: lustre-MDT0000-mdc-ffff984b89ac6800: Connection to lustre-MDT0000 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7715.122916] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7715.132429] LustreError: 266236:0:(file.c:6166:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 7715.228087] LustreError: MGC192.168.204.147@tcp: Connection to MGS (at 192.168.204.147@tcp) was lost; in progress operations using this service will fail [ 7715.247365] Lustre: Unmounted lustre-client [ 7725.724765] Key type lgssc unregistered [ 7725.836347] LNet: 266652:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7725.838524] LNetError: 266652:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7725.846270] LNet: Removed LNI 192.168.204.47@tcp [ 7726.081399] Key type .llcrypt unregistered [ 7726.082258] Key type ._llcrypt unregistered [ 7731.164645] Key type ._llcrypt registered [ 7731.165560] Key type .llcrypt registered [ 7731.587287] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 08:01:45 (1788004905) [ 7732.228982] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7732.282205] alg: No test for adler32 (adler32-zlib) [ 7733.133994] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7733.220736] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7734.807179] Key type lgssc registered [ 7735.167832] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7751.491351] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7753.391427] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7760.253672] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7770.609038] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7775.714494] Lustre: lustre-MDT0001-mdc-ffff984b89b23800: Connection to lustre-MDT0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7778.225742] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7778.577385] Lustre: Unmounted lustre-client [ 7789.439188] Key type lgssc unregistered [ 7789.552483] LNet: 270228:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7789.556210] LNetError: 270228:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7789.564895] LNet: Removed LNI 192.168.204.47@tcp [ 7789.799313] Key type .llcrypt unregistered [ 7789.800565] Key type ._llcrypt unregistered [ 7795.118736] Key type ._llcrypt registered [ 7795.119808] Key type .llcrypt registered [ 7795.559483] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 08:02:49 (1788004969) [ 7802.109659] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7802.155811] alg: No test for adler32 (adler32-zlib) [ 7803.025484] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7803.123871] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7804.703198] Key type lgssc registered [ 7805.271614] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7850.925261] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7852.163435] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7870.949126] Lustre: lustre-MDT0001-mdc-ffff984b89ac3800: Connection to lustre-MDT0001 (at 192.168.204.147@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7877.889117] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7888.191627] Lustre: Unmounted lustre-client [ 7915.263132] Key type lgssc unregistered [ 7915.402858] LNet: 276000:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7915.409833] LNetError: 276000:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7915.426437] LNet: Removed LNI 192.168.204.47@tcp [ 7915.831134] Key type .llcrypt unregistered [ 7915.833454] Key type ._llcrypt unregistered [ 7922.772700] Key type ._llcrypt registered [ 7922.773707] Key type .llcrypt registered [ 7923.381023] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 08:04:56 (1788005096) [ 7924.220371] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 7925.105544] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 08:04:58 (1788005098) [ 7925.861552] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 7926.796307] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 08:05:00 (1788005100) [ 7927.546711] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 7928.070202] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 08:05:01 (1788005101) [ 7928.717521] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 7929.686484] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 08:05:02 (1788005102) [ 7930.587193] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 7931.474935] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 08:05:04 (1788005104) [ 7936.037354] Key type .llcrypt unregistered [ 7936.038754] Key type ._llcrypt unregistered [ 7938.596786] Key type ._llcrypt registered [ 7938.597846] Key type .llcrypt registered [ 7938.847824] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7938.855079] alg: No test for adler32 (adler32-zlib) [ 7939.748196] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 7939.853433] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 7941.455188] Key type lgssc registered [ 7941.917967] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7976.401822] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7978.595853] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7986.278391] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7992.797413] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 7993.221280] Lustre: Unmounted lustre-client [ 8016.219320] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 08:06:29 (1788005189) [ 8030.032418] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8032.342087] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8053.643959] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8069.105809] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 8069.451180] Lustre: Unmounted lustre-client [ 8100.779580] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 08:07:54 (1788005274) [ 8113.951351] LNet: 1 local NIs in recovery (showing 1): 192.168.204.47@tcp [ 8693.213244] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8695.056394] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8714.782568] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8761.918367] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 08:18:55 (1788005935) [ 8765.889093] Key type lgssc unregistered [ 8766.004556] LNet: 289494:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8766.006625] LNetError: 289494:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8766.017768] LNet: Removed LNI 192.168.204.47@tcp [ 8766.252670] Key type .llcrypt unregistered [ 8766.253831] Key type ._llcrypt unregistered [ 8841.010639] Key type ._llcrypt registered [ 8841.011751] Key type .llcrypt registered [ 8841.129411] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8841.134883] alg: No test for adler32 (adler32-zlib) [ 8841.998656] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 8842.096619] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 8843.679167] Key type lgssc registered [ 8844.116363] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8878.381291] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8880.394940] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8889.005809] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8908.711682] Key type lgssc unregistered [ 8908.830585] LNet: 293174:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8908.834386] LNetError: 293174:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8908.841489] LNet: Removed LNI 192.168.204.47@tcp [ 8909.106882] Key type .llcrypt unregistered [ 8909.108355] Key type ._llcrypt unregistered [ 8937.267154] Key type ._llcrypt registered [ 8937.268204] Key type .llcrypt registered [ 8937.772073] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 08:21:51 (1788006111) [ 8944.697411] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8944.704816] alg: No test for adler32 (adler32-zlib) [ 8945.568408] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 8945.662897] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 8947.247229] Key type lgssc registered [ 8947.669828] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8965.852668] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 08:22:19 (1788006139) [ 8970.165875] Key type lgssc unregistered [ 8970.292593] LNet: 296721:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8970.295714] LNetError: 296721:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8970.304430] LNet: Removed LNI 192.168.204.47@tcp [ 8970.597537] Key type .llcrypt unregistered [ 8970.598796] Key type ._llcrypt unregistered [ 8974.834231] Key type ._llcrypt registered [ 8974.835877] Key type .llcrypt registered [ 8975.027707] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8975.035305] alg: No test for adler32 (adler32-zlib) [ 8975.913416] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 8976.015217] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 8977.607258] Key type lgssc registered [ 8978.079871] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9000.718528] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9002.595889] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9010.930214] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9102.019715] LNet: Added LNI 192.168.204.47@tcp50 [8/256/0/180] [ 9102.941443] LNet: Removed LNI 192.168.204.47@tcp [ 9104.373469] Lustre: 301081:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff984b98985000: config has no valid NIDs, force dynamic NIDs [ 9105.430217] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 9105.489779] Lustre: Unmounted lustre-client [ 9106.676621] Key type lgssc unregistered [ 9106.861334] LNet: 301342:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9106.865861] LNetError: 301342:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9106.875635] LNet: Removed LNI 192.168.204.47@tcp50 [ 9107.124871] Key type .llcrypt unregistered [ 9107.126338] Key type ._llcrypt unregistered [ 9117.962306] Key type ._llcrypt registered [ 9117.964243] Key type .llcrypt registered [ 9118.171895] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9118.181554] alg: No test for adler32 (adler32-zlib) [ 9119.065023] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 9119.170432] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 9120.783871] Key type lgssc registered [ 9121.293907] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9151.051972] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9153.121391] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9155.903183] LNet: Added LNI 192.168.204.47@tcp50 [8/256/0/180] [ 9156.246325] LNet: Removed LNI 192.168.204.47@tcp [ 9157.365049] Lustre: 304042:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff984b82da3800: config has no valid NIDs, force dynamic NIDs [ 9158.435104] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 9158.660149] Lustre: Unmounted lustre-client [ 9187.047937] Key type lgssc unregistered [ 9187.204404] LNet: 304914:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9187.208725] LNetError: 304914:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9187.217782] LNet: Removed LNI 192.168.204.47@tcp50 [ 9187.472147] Key type .llcrypt unregistered [ 9187.473872] Key type ._llcrypt unregistered [ 9191.749540] Key type ._llcrypt registered [ 9191.751014] Key type .llcrypt registered [ 9192.326597] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 08:26:05 (1788006365) [ 9198.785158] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9198.797980] alg: No test for adler32 (adler32-zlib) [ 9199.658041] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 9199.754448] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 9201.343217] Key type lgssc registered [ 9201.773269] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9233.995416] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9236.045495] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9245.157344] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9264.719411] Key type lgssc unregistered [ 9264.832466] LNet: 309648:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9264.834741] LNetError: 309648:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9264.842308] LNet: Removed LNI 192.168.204.47@tcp [ 9265.082587] Key type .llcrypt unregistered [ 9265.084026] Key type ._llcrypt unregistered [ 9268.976789] Key type ._llcrypt registered [ 9268.978037] Key type .llcrypt registered [ 9269.428956] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 08:27:22 (1788006442) [ 9270.177384] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9270.211187] alg: No test for adler32 (adler32-zlib) [ 9271.075943] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 9271.166516] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 9272.751287] Key type lgssc registered [ 9273.172740] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9291.862938] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9293.816249] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9301.004421] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9311.730145] Lustre: Mounted lustre-client - version 2.17.57_44_gac22094 [ 9333.077569] Lustre: Mounted fs15246-client - version 2.17.57_44_gac22094 [ 9337.865160] Lustre: Unmounted fs15246-client [ 9350.315925] Lustre: Unmounted lustre-client [ 9367.564317] Key type lgssc unregistered [ 9367.701419] LNet: 314489:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9367.703769] LNetError: 314489:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9367.713810] LNet: Removed LNI 192.168.204.47@tcp [ 9367.973562] Key type .llcrypt unregistered [ 9367.975039] Key type ._llcrypt unregistered [ 9372.022444] Key type ._llcrypt registered [ 9372.023566] Key type .llcrypt registered [ 9372.501237] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 08:29:05 (1788006545) [ 9373.123909] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9373.130660] alg: No test for adler32 (adler32-zlib) [ 9373.994797] Lustre: Lustre: Build Version: 2.17.57_44_gac22094 [ 9374.095631] LNet: Added LNI 192.168.204.47@tcp [8/256/0/180] [ 9375.687171] Key type lgssc registered [ 9376.107992] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9420.832981] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9422.596970] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9430.480180] Lustre: DEBUG MARKER: oleg447-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9469.014217] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 9207 sec ========== 08:30:42 (1788006642) [ 9469.533139] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 08:30:43 (1788006643) === [ 9470.588743] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 08:30:44 (1788006644) === [ 9481.154464] Key type lgssc unregistered [ 9481.265452] LNet: 323720:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9481.268175] LNetError: 323720:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9481.274473] LNet: Removed LNI 192.168.204.47@tcp [ 9481.514702] Key type .llcrypt unregistered [ 9481.515958] Key type ._llcrypt unregistered