[ 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 431103101 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 2592MB 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001013] APIC: Switch to symmetric I/O mode setup [ 0.003121] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009017] pid_max: default: 32768 minimum: 301 [ 0.010138] LSM: Security Framework initializing [ 0.012030] Yama: becoming mindful. [ 0.013042] SELinux: Initializing. [ 0.014077] *** VALIDATE selinux *** [ 0.022502] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026775] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028159] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030052] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031122] *** VALIDATE tmpfs *** [ 0.032479] *** VALIDATE proc *** [ 0.034215] *** VALIDATE cgroup *** [ 0.035010] *** VALIDATE cgroup2 *** [ 0.037029] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038165] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040030] Spectre V2 : User space: Vulnerable [ 0.041014] Speculative Store Bypass: Vulnerable [ 0.044553] debug: unmapping init [mem 0xffffffffb5859000-0xffffffffb5860fff] [ 0.046175] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047747] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048028] ... version: 2 [ 0.049020] ... bit width: 48 [ 0.050014] ... generic registers: 4 [ 0.051018] ... value mask: 0000ffffffffffff [ 0.052020] ... max period: 00007fffffffffff [ 0.053018] ... fixed-purpose events: 3 [ 0.054027] ... event mask: 000000070000000f [ 0.055347] rcu: Hierarchical SRCU implementation. [ 0.057512] smp: Bringing up secondary CPUs ... [ 0.058632] x86: Booting SMP configuration: [ 0.059031] .... node #0, CPUs: #1 #2 #3 [ 0.063014] smp: Brought up 1 node, 4 CPUs [ 0.065025] smpboot: Max logical packages: 1 [ 0.066019] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.138166] node 0 deferred pages initialised in 70ms [ 0.143119] devtmpfs: initialized [ 0.144371] x86/mm: Memory block size: 128MB [ 0.148796] gcov: version magic: 0x41383552 [ 0.152293] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.153079] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.154309] pinctrl core: initialized pinctrl subsystem [ 0.155155] [ 0.155560] ************************************************************* [ 0.157012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.159014] ** ** [ 0.161019] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.162012] ** ** [ 0.165014] ** This means that this kernel is built to expose internal ** [ 0.167013] ** IOMMU data structures, which may compromise security on ** [ 0.170014] ** your system. ** [ 0.172015] ** ** [ 0.175015] ** If you see this message and you are not debugging the ** [ 0.177014] ** kernel, report this immediately to your vendor! ** [ 0.180015] ** ** [ 0.182011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.184022] ************************************************************* [ 0.187752] NET: Registered protocol family 16 [ 0.189543] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.192076] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.196078] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.200156] cpuidle: using governor menu [ 0.202755] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.205620] PCI: Using configuration type 1 for base access [ 0.208126] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.218053] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.220033] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.223167] cryptd: max_cpu_qlen set to 1000 [ 0.227266] ACPI: Added _OSI(Module Device) [ 0.229016] ACPI: Added _OSI(Processor Device) [ 0.231016] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.233015] ACPI: Added _OSI(Processor Aggregator Device) [ 0.238060] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.243431] ACPI: Interpreter enabled [ 0.245063] ACPI: PM: (supports S0 S3 S4 S5) [ 0.246014] ACPI: Using IOAPIC for interrupt routing [ 0.248122] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.251567] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.261654] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.264041] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.267020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.270068] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.274355] acpiphp: Slot [2] registered [ 0.276132] acpiphp: Slot [5] registered [ 0.278133] acpiphp: Slot [6] registered [ 0.279126] acpiphp: Slot [3] registered [ 0.281096] acpiphp: Slot [4] registered [ 0.282130] acpiphp: Slot [7] registered [ 0.284140] acpiphp: Slot [8] registered [ 0.285097] acpiphp: Slot [9] registered [ 0.287064] acpiphp: Slot [10] registered [ 0.288137] acpiphp: Slot [11] registered [ 0.290114] acpiphp: Slot [12] registered [ 0.292125] acpiphp: Slot [13] registered [ 0.293140] acpiphp: Slot [14] registered [ 0.295101] acpiphp: Slot [15] registered [ 0.296179] acpiphp: Slot [16] registered [ 0.298138] acpiphp: Slot [17] registered [ 0.300113] acpiphp: Slot [18] registered [ 0.301124] acpiphp: Slot [19] registered [ 0.303132] acpiphp: Slot [20] registered [ 0.304100] acpiphp: Slot [21] registered [ 0.306173] acpiphp: Slot [22] registered [ 0.308131] acpiphp: Slot [23] registered [ 0.309103] acpiphp: Slot [24] registered [ 0.311169] acpiphp: Slot [25] registered [ 0.312108] acpiphp: Slot [26] registered [ 0.313127] acpiphp: Slot [27] registered [ 0.315112] acpiphp: Slot [28] registered [ 0.317113] acpiphp: Slot [29] registered [ 0.318132] acpiphp: Slot [30] registered [ 0.320102] acpiphp: Slot [31] registered [ 0.322149] PCI host bridge to bus 0000:00 [ 0.323022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.326021] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.328020] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.330023] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.333026] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.336025] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.338243] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.342129] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.345342] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.352646] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.357015] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.360020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.363022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.365018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.367477] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.370822] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.373061] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.376645] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.381016] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.391842] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.396015] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.402245] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.408909] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.421016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.435013] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.444209] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.450017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.458016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.475014] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.485763] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.488389] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.490382] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.493388] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.495153] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.500145] iommu: Default domain type: Passthrough [ 0.502447] SCSI subsystem initialized [ 0.504171] ACPI: bus type USB registered [ 0.506134] usbcore: registered new interface driver usbfs [ 0.508086] usbcore: registered new interface driver hub [ 0.510084] usbcore: registered new device driver usb [ 0.512175] pps_core: LinuxPPS API ver. 1 registered [ 0.514012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.517047] PTP clock support registered [ 0.519136] EDAC MC: Ver: 3.0.0 [ 0.521140] PCI: Using ACPI for IRQ routing [ 0.522743] NetLabel: Initializing [ 0.524011] NetLabel: domain hash size = 128 [ 0.526010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.528078] NetLabel: unlabeled traffic allowed by default [ 0.530137] vgaarb: loaded [ 0.532259] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.534011] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.540000] clocksource: Switched to clocksource kvm-clock [ 0.645612] VFS: Disk quotas dquot_6.6.0 [ 0.647415] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.649642] *** VALIDATE ramfs *** [ 0.650964] *** VALIDATE hugetlbfs *** [ 0.652669] pnp: PnP ACPI init [ 0.655127] pnp: PnP ACPI: found 6 devices [ 0.701131] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.704756] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.707065] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.709297] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.711647] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.714097] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.717894] NET: Registered protocol family 2 [ 0.720251] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.725452] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.729443] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.735061] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.738356] TCP: Hash tables configured (established 65536 bind 65536) [ 0.741339] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.744328] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.746857] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.749830] NET: Registered protocol family 1 [ 0.752321] RPC: Registered named UNIX socket transport module. [ 0.754508] RPC: Registered udp transport module. [ 0.756272] RPC: Registered tcp transport module. [ 0.758047] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.760518] NET: Registered protocol family 44 [ 0.761770] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.763751] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.765833] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.768040] PCI: CLS 0 bytes, default 64 [ 0.769812] Unpacking initramfs... [ 2.181153] debug: unmapping init [mem 0xffff99ed7cc64000-0xffff99ed7ffcffff] [ 2.185483] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.187921] software IO TLB: mapped [mem 0x00000000b8c64000-0x00000000bcc64000] (64MB) [ 2.190867] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.694989] Initialise system trusted keyrings [ 2.696980] Key type blacklist registered [ 2.699195] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.709491] zbud: loaded [ 2.712953] *** VALIDATE nfs *** [ 2.714438] *** VALIDATE nfs4 *** [ 2.716595] pstore: using deflate compression [ 2.723550] Platform Keyring initialized [ 2.849693] NET: Registered protocol family 38 [ 2.851634] Key type asymmetric registered [ 2.853156] Asymmetric key parser 'x509' registered [ 2.854751] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.857274] io scheduler mq-deadline registered [ 2.858757] io scheduler kyber registered [ 2.860268] io scheduler bfq registered [ 2.862065] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.864850] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.867660] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.870262] ACPI: Power Button [PWRF] [ 2.875522] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.882505] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.905192] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.931797] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.962110] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.969261] Non-volatile memory driver v1.3 [ 2.970896] Linux agpgart interface v0.103 [ 2.999527] virtio_blk virtio1: [vda] 146616 512-byte logical blocks (75.1 MB/71.6 MiB) [ 3.001586] vda: detected capacity change from 0 to 75067392 [ 3.016897] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.019978] vdb: detected capacity change from 0 to 1073741824 [ 3.029444] libphy: Fixed MDIO Bus: probed [ 3.034400] usbcore: registered new interface driver usbserial_generic [ 3.036886] usbserial: USB Serial support registered for generic [ 3.039361] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.043680] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.045411] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.047892] mousedev: PS/2 mouse device common for all mice [ 3.051279] rtc_cmos 00:05: RTC can wake from S4 [ 3.053637] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.057869] rtc_cmos 00:05: registered as rtc0 [ 3.059305] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.060428] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.067287] intel_pstate: CPU model not supported [ 3.067721] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.073679] hid: raw HID events driver (C) Jiri Kosina [ 3.076175] usbcore: registered new interface driver usbhid [ 3.078135] usbhid: USB HID core driver [ 3.079737] drop_monitor: Initializing network drop monitor service [ 3.082254] Initializing XFRM netlink socket [ 3.084310] NET: Registered protocol family 10 [ 3.087419] Segment Routing with IPv6 [ 3.088882] NET: Registered protocol family 17 [ 3.091116] mpls_gso: MPLS GSO support [ 3.097177] RAS: Correctable Errors collector initialized. [ 3.098599] AVX version of gcm_enc/dec engaged. [ 3.099651] AES CTR mode by8 optimization enabled [ 3.171482] sched_clock: Marking stable (3171463072, 0)->(4077194603, -905731531) [ 3.174441] registered taskstats version 1 [ 3.177053] Loading compiled-in X.509 certificates [ 3.178581] zswap: loaded using pool lzo/zbud [ 3.203024] Key type big_key registered [ 3.214424] Key type encrypted registered [ 3.216067] ima: No TPM chip found, activating TPM-bypass! [ 3.219045] ima: Allocated hash algorithm: sha1 [ 3.221077] ima: No architecture policies found [ 3.222773] evm: Initialising EVM extended attributes: [ 3.224907] evm: security.selinux [ 3.226351] evm: security.ima [ 3.227725] evm: security.capability [ 3.229122] evm: HMAC attrs: 0x1 [ 3.231373] rtc_cmos 00:05: setting system clock to 2026-08-26 22:49:32 UTC (1787784572) [ 3.236591] debug: unmapping init [mem 0xffffffffb6803000-0xffffffffb69fffff] [ 3.239902] debug: unmapping init [mem 0xffffffffb5582000-0xffffffffb5858fff] [ 3.253091] Write protecting the kernel read-only data: 28672k [ 3.257874] debug: unmapping init [mem 0xffffffffb3c03000-0xffffffffb3dfffff] [ 3.260504] debug: unmapping init [mem 0xffffffffb4514000-0xffffffffb45fffff] [ 3.294563] 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.302881] systemd[1]: Detected virtualization kvm. [ 3.304169] systemd[1]: Detected architecture x86-64. [ 3.305845] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.330198] systemd[1]: No hostname configured. [ 3.331957] systemd[1]: Set hostname to . [ 3.334263] random: systemd: uninitialized urandom read (16 bytes read) [ 3.335941] systemd[1]: Initializing machine ID from random generator. [ 3.378155] random: ln: uninitialized urandom read (6 bytes read) [ 3.460825] random: systemd: uninitialized urandom read (16 bytes read) [ 3.462655] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.466539] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.470472] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Swap. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Slices. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket. Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.113093] device-mapper: uevent: version 1.0.3 [ 4.115984] 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. [ 4.750550] random: fast init done [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.892756] virtio_net virtio0 ens2: renamed from eth0 [ 4.971567] scsi host0: ata_piix [ 4.987191] scsi host1: ata_piix [ 4.989542] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.992691] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.408589] dracut-initqueue[591]: RTNETLINK answers: File exists [ 9.733426] random: crng init done [ 9.735281] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.176476] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Sockets. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.339650] printk: systemd: 23 output lines suppressed due to ratelimiting [ 11.599172] SELinux: Disabled at runtime. [ 11.659750] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.669468] systemd[1]: Detected virtualization kvm. [ 11.671549] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.182842] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.187509] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.193458] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.200686] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.204613] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.213909] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.218878] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on udev Kernel Socket. Mounting POSIX Message Queue File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on udev Control Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-getty.slice. Starting udev Coldplug all Devices... Activating swap /dev/disk/by-label/SWAP... Starting Apply Kernel Variables... Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Kernel Debug File System... [ 12.336169] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Stopped target Initrd Root File System. [ OK ] Reached target Local Encrypted Volumes. Starting Create list of required st…ce nodes for the current kernel... Mounting Huge Pages File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 12.693441] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.001927] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.034281] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.083523] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.105988] EDAC sbridge: Ver: 1.1.2 [ 14.178379] Key type dns_resolver registered [ 14.478851] NFS: Registering the id_resolver key type [ 14.481458] Key type id_resolver registered [ 14.483231] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ 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 Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started OpenSSH server 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 Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] 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 oleg422-client login: [ 46.329592] libcfs: loading out-of-tree module taints kernel. [ 46.353434] Key type ._llcrypt registered [ 46.355142] Key type .llcrypt registered [ 46.731432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 46.739289] alg: No test for adler32 (adler32-zlib) [ 47.833560] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 48.235433] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 49.880200] Key type lgssc registered [ 50.638429] Lustre: Echo OBD driver; http://www.lustre.org/ [ 114.137308] hrtimer: interrupt took 10237344 ns [ 231.321479] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 236.708607] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 251.489446] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing check_logdir /tmp/testlogs/ [ 256.476823] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing yml_node [ 256.993834] Lustre: lustre-OST0000-osc-ffff99edd2104800: disconnect after 23s idle [ 260.866944] Lustre: DEBUG MARKER: Client: 2.17.57.54 [ 263.279847] Lustre: DEBUG MARKER: MDS: 2.17.57.54 [ 266.239707] Lustre: DEBUG MARKER: OSS: 2.17.57.54 [ 268.009659] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Aug 26 18:53:55 EDT 2026 [ 286.346911] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 288.294594] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 291.433937] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 301.717306] Lustre: Unmounted lustre-client [ 432.340398] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 438.167852] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 460.316346] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 505.749498] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 18:57:52 (1787785072) [ 509.031493] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 511.010569] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 18:57:58 (1787785078) [ 549.953692] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 557.372651] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 584.466621] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 590.410960] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 595.073411] Lustre: Unmounted lustre-client [ 625.204162] Key type lgssc unregistered [ 625.537382] LNet: 15041:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 625.548197] LNetError: 15041:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 625.566492] LNet: Removed LNI 192.168.204.22@tcp [ 626.647179] Key type .llcrypt unregistered [ 626.655286] Key type ._llcrypt unregistered [ 645.173787] Key type ._llcrypt registered [ 645.178675] Key type .llcrypt registered [ 646.781598] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 19:00:14 (1787785214) [ 648.765040] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 648.799496] alg: No test for adler32 (adler32-zlib) [ 649.941425] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 650.308609] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 652.032181] Key type lgssc registered [ 653.593938] Lustre: Echo OBD driver; http://www.lustre.org/ [ 740.080792] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 826.869869] Lustre: Unmounted lustre-client [ 857.149654] Key type lgssc unregistered [ 857.507451] LNet: 18870:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 857.514892] LNetError: 18870:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 857.543222] LNet: Removed LNI 192.168.204.22@tcp [ 858.601088] Key type .llcrypt unregistered [ 858.611149] Key type ._llcrypt unregistered [ 871.010315] Key type ._llcrypt registered [ 871.013864] Key type .llcrypt registered [ 873.132545] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 19:04:00 (1787785440) [ 876.316886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 876.372435] alg: No test for adler32 (adler32-zlib) [ 877.523801] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 877.762701] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 879.449214] Key type lgssc registered [ 881.252582] Lustre: Echo OBD driver; http://www.lustre.org/ [ 942.531239] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 950.243888] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 975.935412] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 987.199464] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 1000.412861] Lustre: Unmounted lustre-client [ 1036.541674] Key type lgssc unregistered [ 1036.760420] LNet: 22481:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1036.769799] LNetError: 22481:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1036.793589] LNet: Removed LNI 192.168.204.22@tcp [ 1037.541826] Key type .llcrypt unregistered [ 1037.547904] Key type ._llcrypt unregistered [ 1048.124043] Key type ._llcrypt registered [ 1048.126082] Key type .llcrypt registered [ 1049.402605] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 19:06:57 (1787785617) [ 1052.051627] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1052.119959] alg: No test for adler32 (adler32-zlib) [ 1053.284562] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 1053.635460] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 1055.298096] Key type lgssc registered [ 1056.655346] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1114.009326] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1122.047176] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1147.453782] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1158.738528] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 1165.766452] Lustre: Unmounted lustre-client [ 1197.024342] Key type lgssc unregistered [ 1197.410329] LNet: 25681:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1197.417922] LNetError: 25681:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1197.437932] LNet: Removed LNI 192.168.204.22@tcp [ 1198.399537] Key type .llcrypt unregistered [ 1198.401732] Key type ._llcrypt unregistered [ 1214.603684] Key type ._llcrypt registered [ 1214.607156] Key type .llcrypt registered [ 1215.860686] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 19:09:43 (1787785783) [ 1218.403508] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1218.456716] alg: No test for adler32 (adler32-zlib) [ 1219.640887] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 1219.973217] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 1221.706659] Key type lgssc registered [ 1222.846497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1279.401288] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1285.570263] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1308.889342] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1310.631680] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 1320.956601] Lustre: lustre-MDT0000-mdc-ffff99edc81a6000: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1331.176866] Lustre: lustre-MDT0001-mdc-ffff99edc81a6000: Connection to lustre-MDT0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1342.432470] Lustre: 26656:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787785895/real 1787785895] req@00000000cc169bac x1874629271492608/t0(0) o400->MGC192.168.204.122@tcp@192.168.204.122@tcp:26/25 lens 224/224 e 0 to 1 dl 1787785911 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1342.476718] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [ 1345.492102] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1355.864762] Lustre: Unmounted lustre-client [ 1371.651150] Key type lgssc unregistered [ 1371.935798] LNet: 29358:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1371.941294] LNetError: 29358:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1371.956551] LNet: Removed LNI 192.168.204.22@tcp [ 1372.796575] Key type .llcrypt unregistered [ 1372.799124] Key type ._llcrypt unregistered [ 1388.432555] Key type ._llcrypt registered [ 1388.434222] Key type .llcrypt registered [ 1389.994579] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 19:12:37 (1787785957) [ 1392.591305] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1392.668059] alg: No test for adler32 (adler32-zlib) [ 1393.784345] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 1394.018392] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 1395.712281] Key type lgssc registered [ 1396.797329] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1446.757974] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1452.417316] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1472.557201] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1475.168316] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 1480.175511] Lustre: lustre-OST0000-osc-ffff99edc81c8800: Connection to lustre-OST0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1494.745604] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1505.039515] Lustre: Unmounted lustre-client [ 1540.106816] Key type lgssc unregistered [ 1540.433484] LNet: 32976:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1540.449420] LNetError: 32976:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1540.480808] LNet: Removed LNI 192.168.204.22@tcp [ 1541.308509] Key type .llcrypt unregistered [ 1541.316161] Key type ._llcrypt unregistered [ 1554.779475] Key type ._llcrypt registered [ 1554.787415] Key type .llcrypt registered [ 1556.418840] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 19:15:23 (1787786123) [ 1558.709666] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1558.743853] alg: No test for adler32 (adler32-zlib) [ 1559.916891] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 1560.224920] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 1561.984158] Key type lgssc registered [ 1564.303749] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1615.064693] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1621.188509] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1643.182609] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1645.768555] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 1653.873392] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1657.368445] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1669.223653] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-2619h17m16s [ 1672.179277] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1676.777261] Lustre: lustre-MDT0000-mdc-ffff99edc93e3800: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1683.060804] LustreError: 36766:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff99edc93e3800: can't stat MDS #0: rc = -19 [ 1684.705306] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1695.205540] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [ 1695.229833] Lustre: Evicted from MGS (at 192.168.204.122@tcp) after server handle changed from 0xa7ae39bc74a22015 to 0xa7ae39bc74a222df [ 1695.246812] Lustre: MGC192.168.204.122@tcp: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 1696.306154] LustreError: lustre-MDT0000-mdc-ffff99edc93e3800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1696.325582] Lustre: lustre-MDT0000-mdc-ffff99edc93e3800: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 1700.366712] Lustre: DEBUG MARKER: Wait for df (36766) ... [ 1702.146592] Lustre: DEBUG MARKER: done [ 1704.385387] Lustre: Unmounted lustre-client [ 1741.444567] Key type lgssc unregistered [ 1741.758602] LNet: 37789:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1741.765721] LNetError: 37789:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1741.792070] LNet: Removed LNI 192.168.204.22@tcp [ 1742.425130] Key type .llcrypt unregistered [ 1742.428871] Key type ._llcrypt unregistered [ 1773.235887] Key type ._llcrypt registered [ 1773.238194] Key type .llcrypt registered [ 1774.498064] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 19:19:02 (1787786342) [ 1777.490502] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1777.518689] alg: No test for adler32 (adler32-zlib) [ 1778.671938] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 1779.021234] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 1780.729112] Key type lgssc registered [ 1781.730358] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1827.724826] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1833.769824] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1853.649647] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1855.482809] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 1859.919109] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-2619h20m27s [ 1861.499780] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1869.128637] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1871.583791] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1892.320412] Lustre: 41940:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787786441/real 1787786441] req@00000000eecb7c1f x1874629857647232/t0(0) o101->lustre-MDT0000-mdc-ffff99edc3082000@192.168.204.122@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787786461 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1892.357120] Lustre: lustre-MDT0000-mdc-ffff99edc3082000: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1892.393527] Lustre: lustre-MDT0000-mdc-ffff99edc3082000: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 1913.510401] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1916.435715] Lustre: DEBUG MARKER: done [ 1920.610315] Lustre: Unmounted lustre-client [ 1946.003938] Key type lgssc unregistered [ 1946.352088] LNet: 42820:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1946.357848] LNetError: 42820:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1946.378349] LNet: Removed LNI 192.168.204.22@tcp [ 1947.117507] Key type .llcrypt unregistered [ 1947.120500] Key type ._llcrypt unregistered [ 1980.157443] Key type ._llcrypt registered [ 1980.160310] Key type .llcrypt registered [ 1981.491000] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 19:22:29 (1787786549) [ 1982.985398] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1984.910607] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 19:22:32 (1787786552) [ 1989.084650] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1989.097898] alg: No test for adler32 (adler32-zlib) [ 1990.298410] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 1990.624892] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 1992.392262] Key type lgssc registered [ 1993.723678] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2026.409861] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 19:23:13 (1787786593) [ 2064.000132] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2071.023374] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2096.448068] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2098.179963] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 2101.889799] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2106.553478] Lustre: Unmounted lustre-client [ 2133.127337] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2178.023812] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2183.073030] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2183.803939] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 2187.791470] Lustre: Unmounted lustre-client [ 2253.951557] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2259.084525] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2259.722128] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 2263.369165] Lustre: Unmounted lustre-client [ 2278.677732] Lustre: DEBUG MARKER: files compared the same [ 2303.398830] Key type lgssc unregistered [ 2303.748118] LNet: 50454:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2303.754840] LNetError: 50454:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2303.779356] LNet: Removed LNI 192.168.204.22@tcp [ 2305.092120] Key type .llcrypt unregistered [ 2305.095364] Key type ._llcrypt unregistered [ 2323.692207] Key type ._llcrypt registered [ 2323.696702] Key type .llcrypt registered [ 2325.867646] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 19:28:12 (1787786892) [ 2330.455766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2330.516990] alg: No test for adler32 (adler32-zlib) [ 2332.215167] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 2332.628361] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 2334.472181] Key type lgssc registered [ 2336.235122] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2390.056565] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2395.673389] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2416.995100] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2419.841759] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 2425.464373] Lustre: Unmounted lustre-client [ 2464.144627] Key type lgssc unregistered [ 2464.356055] LNet: 54047:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2464.364601] LNetError: 54047:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2464.401648] LNet: Removed LNI 192.168.204.22@tcp [ 2465.167150] Key type .llcrypt unregistered [ 2465.173165] Key type ._llcrypt unregistered [ 2481.417314] Key type ._llcrypt registered [ 2481.421467] Key type .llcrypt registered [ 2482.699713] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 19:30:50 (1787787050) [ 2485.162505] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2485.205780] alg: No test for adler32 (adler32-zlib) [ 2486.318441] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 2486.535690] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 2488.192210] Key type lgssc registered [ 2489.302633] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2574.187770] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2607.239642] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2614.008755] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2643.599382] Key type lgssc unregistered [ 2643.895145] LNet: 57540:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2643.905801] LNetError: 57540:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2643.926136] LNet: Removed LNI 192.168.204.22@tcp [ 2644.880158] Key type .llcrypt unregistered [ 2644.886323] Key type ._llcrypt unregistered [ 2658.756539] Key type ._llcrypt registered [ 2658.759225] Key type .llcrypt registered [ 2660.063881] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 19:33:47 (1787787227) [ 2663.296764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2663.321415] alg: No test for adler32 (adler32-zlib) [ 2664.397503] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 2664.664454] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 2666.416624] Key type lgssc registered [ 2667.442042] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2745.825503] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 2753.019693] Lustre: Unmounted lustre-client [ 2788.169745] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 19:35:56 (1787787356) [ 2913.547742] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2934.342758] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 2941.576042] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2941.588199] LustreError: 64010:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff99edc4d46000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2941.619215] Lustre: 58522:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.122@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2951.973584] Lustre: Unmounted lustre-client [ 2995.727508] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 19:39:23 (1787787563) [ 3009.389875] Key type lgssc unregistered [ 3009.637153] LNet: 65226:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3009.652601] LNetError: 65226:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3009.687453] LNet: Removed LNI 192.168.204.22@tcp [ 3010.467974] Key type .llcrypt unregistered [ 3010.473052] Key type ._llcrypt unregistered [ 3023.695831] Key type ._llcrypt registered [ 3023.699843] Key type .llcrypt registered [ 3024.045841] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3024.067325] alg: No test for adler32 (adler32-zlib) [ 3025.244535] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 3025.519559] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 3027.224453] Key type lgssc registered [ 3028.529962] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3081.255800] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3087.898046] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3110.884942] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3113.791718] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3118.174182] Lustre: Unmounted lustre-client [ 3145.968752] Key type lgssc unregistered [ 3146.308059] LNet: 68243:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3146.323541] LNetError: 68243:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3146.353424] LNet: Removed LNI 192.168.204.22@tcp [ 3147.318905] Key type .llcrypt unregistered [ 3147.321628] Key type ._llcrypt unregistered [ 3159.050223] Key type ._llcrypt registered [ 3159.053823] Key type .llcrypt registered [ 3159.593432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3159.615412] alg: No test for adler32 (adler32-zlib) [ 3160.714520] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 3161.048405] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 3162.784661] Key type lgssc registered [ 3164.103477] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3280.619971] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3287.790067] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3314.337778] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3315.985881] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3319.775454] Lustre: Unmounted lustre-client [ 3349.173989] Key type lgssc unregistered [ 3349.527538] LNet: 71676:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3349.533840] LNetError: 71676:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3349.546651] LNet: Removed LNI 192.168.204.22@tcp [ 3350.344802] Key type .llcrypt unregistered [ 3350.347150] Key type ._llcrypt unregistered [ 3366.830822] Key type ._llcrypt registered [ 3366.833551] Key type .llcrypt registered [ 3368.424503] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 19:45:35 (1787787935) [ 3371.449041] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3371.533436] alg: No test for adler32 (adler32-zlib) [ 3372.539676] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 3372.689509] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 3374.392495] Key type lgssc registered [ 3375.530639] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3431.551533] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3437.349574] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3460.672267] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3463.593604] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3469.651637] Lustre: Unmounted lustre-client [ 3470.164895] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3473.901979] Lustre: Unmounted lustre-client [ 3503.893281] Key type lgssc unregistered [ 3504.187049] LNet: 75366:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3504.202333] LNetError: 75366:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3504.226382] LNet: Removed LNI 192.168.204.22@tcp [ 3504.842993] Key type .llcrypt unregistered [ 3504.845875] Key type ._llcrypt unregistered [ 3518.041719] Key type ._llcrypt registered [ 3518.050073] Key type .llcrypt registered [ 3518.532857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3518.555826] alg: No test for adler32 (adler32-zlib) [ 3519.627352] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 3519.932566] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 3521.672257] Key type lgssc registered [ 3523.007507] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3583.662700] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3590.665842] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3615.965373] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3623.016871] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3628.351572] Lustre: Unmounted lustre-client [ 3660.113375] Key type lgssc unregistered [ 3660.393378] LNet: 78402:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3660.397780] LNetError: 78402:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3660.426362] LNet: Removed LNI 192.168.204.22@tcp [ 3661.220945] Key type .llcrypt unregistered [ 3661.224963] Key type ._llcrypt unregistered [ 3678.076428] Key type ._llcrypt registered [ 3678.078742] Key type .llcrypt registered [ 3679.944527] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 19:50:47 (1787788247) [ 3682.458383] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3682.516709] alg: No test for adler32 (adler32-zlib) [ 3683.577983] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 3683.811985] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 3685.472227] Key type lgssc registered [ 3686.617264] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3738.347101] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3745.546844] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3769.571290] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3772.654264] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3784.786123] Lustre: lustre: root_squash is set to 0:0 [ 3784.840426] Lustre: lustre: nosquash_nids is cleared [ 3792.608266] Lustre: lustre: root_squash is set to 500:500 [ 3800.819701] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.22@tcp 192.168.0.[2,10]@tcp [ 3809.616971] Lustre: lustre: nosquash_nids set to 192.168.204.22/24@tcp [ 3813.830528] Lustre: Unmounted lustre-client [ 3843.785902] Key type lgssc unregistered [ 3844.036703] LNet: 82317:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3844.065441] LNetError: 82317:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3844.092065] LNet: Removed LNI 192.168.204.22@tcp [ 3844.818951] Key type .llcrypt unregistered [ 3844.821961] Key type ._llcrypt unregistered [ 3863.218075] Key type ._llcrypt registered [ 3863.223235] Key type .llcrypt registered [ 3864.527810] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 19:53:52 (1787788432) [ 3867.401624] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3869.304873] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 19:53:57 (1787788437) [ 3871.671242] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3871.754108] alg: No test for adler32 (adler32-zlib) [ 3872.833107] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 3873.114952] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 3874.776401] Key type lgssc registered [ 3875.932939] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3929.321110] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3936.036315] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3959.366415] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3960.891389] Lustre: lustre: root_squash is set to 500:500 [ 3960.925822] Lustre: lustre: nosquash_nids set to 192.168.204.22/24@tcp [ 3961.957247] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 3966.967115] Lustre: Unmounted lustre-client [ 3994.106149] Key type lgssc unregistered [ 3994.385520] LNet: 86278:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3994.400592] LNetError: 86278:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3994.433609] LNet: Removed LNI 192.168.204.22@tcp [ 3995.192439] Key type .llcrypt unregistered [ 3995.197402] Key type ._llcrypt unregistered [ 4012.376749] Key type ._llcrypt registered [ 4012.383896] Key type .llcrypt registered [ 4013.882952] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4015.598925] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 19:56:23 (1787788583) [ 4034.122447] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4034.150430] alg: No test for adler32 (adler32-zlib) [ 4035.127574] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 4035.367865] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 4037.072218] Key type lgssc registered [ 4038.360863] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4125.688940] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4132.619383] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4155.329569] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4228.292078] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4234.849844] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4256.428718] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4267.855360] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 4300.505864] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99edc986c800.ost_server_uuid 50 [ 4301.731870] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99edc986c800.ost_server_uuid in IDLE state after 0 sec [ 4302.163349] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 4305.320596] Lustre: Unmounted lustre-client [ 4306.886178] Lustre: Unmounted lustre-client [ 4366.969077] Key type lgssc unregistered [ 4367.190591] LNet: 93962:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4367.204910] LNetError: 93962:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4367.227210] LNet: Removed LNI 192.168.204.22@tcp [ 4367.792352] Key type .llcrypt unregistered [ 4367.799734] Key type ._llcrypt unregistered [ 4395.647490] Key type ._llcrypt registered [ 4395.650464] Key type .llcrypt registered [ 4396.940646] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 20:02:44 (1787788964) [ 4413.621385] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4413.682231] alg: No test for adler32 (adler32-zlib) [ 4414.761510] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 4414.955270] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 4416.617234] Key type lgssc registered [ 4417.686178] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4481.863680] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4486.508975] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4504.184346] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4505.650047] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 4526.050131] Lustre: 95322:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787789079/real 1787789079] req@000000009ce030cb x1874632621692032/t0(0) o400->lustre-OST0000-osc-ffff99edc2f5c000@192.168.204.122@tcp:28/4 lens 224/224 e 0 to 1 dl 1787789095 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4526.077916] Lustre: lustre-OST0000-osc-ffff99edc2f5c000: Connection to lustre-OST0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4530.923973] Lustre: lustre-OST0000-osc-ffff99edc2f5c000: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 4532.192973] Lustre: 95322:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787789085/real 1787789085] req@00000000eb84f0e1 x1874632621692544/t0(0) o400->lustre-OST0000-osc-ffff99edc2f5c000@192.168.204.122@tcp:28/4 lens 224/224 e 0 to 1 dl 1787789101 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4536.296071] Lustre: lustre-MDT0000-mdc-ffff99edc2f5c000: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4537.312322] Lustre: 95321:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787789090/real 1787789090] req@000000006cccd97e x1874632621693056/t0(0) o400->lustre-OST0000-osc-ffff99edc2f5c000@192.168.204.122@tcp:28/4 lens 224/224 e 0 to 1 dl 1787789106 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4552.672177] Lustre: 95321:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787789105/real 1787789105] req@00000000416cb533 x1874632621695104/t0(0) o400->MGC192.168.204.122@tcp@192.168.204.122@tcp:26/25 lens 224/224 e 0 to 1 dl 1787789121 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4552.701871] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [ 4552.737901] Lustre: Evicted from MGS (at 192.168.204.122@tcp) after server handle changed from 0xf746c7e67c95d894 to 0xf746c7e67c95da15 [ 4552.748219] Lustre: MGC192.168.204.122@tcp: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 4559.339826] Lustre: 98493:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.204.122@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4566.796820] Lustre: lustre-MDT0000-mdc-ffff99edc2f5c000: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 4570.210670] Lustre: Unmounted lustre-client [ 4589.136565] Key type lgssc unregistered [ 4589.319618] LNet: 99619:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4589.325630] LNetError: 99619:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4589.338991] LNet: Removed LNI 192.168.204.22@tcp [ 4589.765948] Key type .llcrypt unregistered [ 4589.768338] Key type ._llcrypt unregistered [ 4601.441913] Key type ._llcrypt registered [ 4601.444569] Key type .llcrypt registered [ 4602.547815] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 20:06:10 (1787789170) [ 4616.541760] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4616.562896] alg: No test for adler32 (adler32-zlib) [ 4617.626527] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 4617.839364] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 4619.488235] Key type lgssc registered [ 4620.560523] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4658.037996] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4740.001395] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4744.983833] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4763.731214] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4766.366085] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 4767.820385] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4769.161641] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 20:08:57 (1787789337) [ 4982.579744] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4992.909504] Lustre: Unmounted lustre-client [ 5085.449435] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5089.853819] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5106.938670] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5146.867833] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 20:15:15 (1787789715) [ 5225.075641] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5231.662209] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5251.709467] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5252.469985] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 5255.821203] Lustre: Unmounted lustre-client [ 5294.020540] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 20:17:42 (1787789862) [ 5368.584213] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5373.134734] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5390.267152] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5390.696582] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 5393.951906] Lustre: Unmounted lustre-client [ 5416.581242] Key type lgssc unregistered [ 5416.767760] LNet: 122611:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5416.772881] LNetError: 122611:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5416.786966] LNet: Removed LNI 192.168.204.22@tcp [ 5417.523744] Key type .llcrypt unregistered [ 5417.525968] Key type ._llcrypt unregistered [ 5429.959731] Key type ._llcrypt registered [ 5429.966864] Key type .llcrypt registered [ 5431.415440] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 20:19:59 (1787789999) [ 5433.863342] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5433.889371] alg: No test for adler32 (adler32-zlib) [ 5434.911676] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 5435.166201] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 5436.848252] Key type lgssc registered [ 5437.810595] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5475.680714] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5479.711503] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5496.179233] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5508.149040] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 5521.322543] Lustre: Unmounted lustre-client [ 5545.686542] Key type lgssc unregistered [ 5545.941788] LNet: 126206:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5545.953131] LNetError: 126206:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5545.978155] LNet: Removed LNI 192.168.204.22@tcp [ 5546.751577] Key type .llcrypt unregistered [ 5546.755874] Key type ._llcrypt unregistered [ 5558.831211] Key type ._llcrypt registered [ 5558.834090] Key type .llcrypt registered [ 5559.967889] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 20:22:07 (1787790127) [ 5561.723344] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5561.744317] alg: No test for adler32 (adler32-zlib) [ 5562.719022] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 5562.926273] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 5564.584333] Key type lgssc registered [ 5565.540497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5606.415699] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5610.695607] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5627.637915] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5633.563240] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 5638.640415] Lustre: lustre-OST0000-osc-ffff99edd2106800: Connection to lustre-OST0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5649.471271] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff99edd2106800.ost_server_uuid 50 [ 5650.761241] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5661.351181] Lustre: Unmounted lustre-client [ 5679.898666] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 20:24:08 (1787790248) [ 5705.014300] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5709.203961] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5726.585181] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5745.823353] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5746.394538] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 5751.791510] Lustre: lustre-OST0000-osc-ffff99edc4f78000: Connection to lustre-OST0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5773.809885] Lustre: Unmounted lustre-client [ 5814.194385] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 20:26:22 (1787790382) [ 5841.452702] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5846.663901] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5865.515606] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5882.822363] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5883.355673] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 5888.486786] Lustre: lustre-OST0000-osc-ffff99edc3080800: Connection to lustre-OST0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5903.116541] Lustre: Unmounted lustre-client [ 5943.331237] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 20:28:31 (1787790511) [ 6021.267523] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6026.940458] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6046.191990] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6107.737111] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6112.681979] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6133.636211] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6160.967515] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 6201.252358] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6208.326176] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 5 sec [ 6210.128208] Lustre: Unmounted lustre-client [ 6234.636490] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 20:33:22 (1787790802) [ 6264.226072] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6269.121751] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6287.509733] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6318.497882] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6345.778178] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 6386.124664] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6387.563959] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6391.795194] Lustre: lustre-OST0001-osc-ffff99edc4817000: Connection to lustre-OST0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6399.281275] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6409.633492] Lustre: Unmounted lustre-client [ 6459.070064] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 20:37:07 (1787791027) [ 6487.332465] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6492.385886] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6512.560682] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6513.128511] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 6534.015270] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6535.319218] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6547.920962] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99edc4f7d000.ost_server_uuid 50 [ 6549.474766] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99edc4f7d000.ost_server_uuid in IDLE state after 0 sec [ 6552.405324] Lustre: Unmounted lustre-client [ 6552.726985] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6552.733319] Lustre: Skipped 3 previous similar messages [ 6552.837479] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 6553.905161] LustreError: 149625:0:(sec.c:403:import_sec_validate_get()) import 0000000001e23f4d (NEW) with no sec [ 6616.699475] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 20:39:44 (1787791184) [ 6645.597079] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6650.402972] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6666.665511] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6681.994459] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6682.366352] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6682.499799] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 6696.698726] Lustre: Unmounted lustre-client [ 6696.705393] Lustre: Skipped 1 previous similar message [ 6731.689680] Key type lgssc unregistered [ 6731.882208] LNet: 153050:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6731.892483] LNetError: 153050:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6731.911172] LNet: Removed LNI 192.168.204.22@tcp [ 6732.480261] Key type .llcrypt unregistered [ 6732.482323] Key type ._llcrypt unregistered [ 6745.018268] Key type ._llcrypt registered [ 6745.020647] Key type .llcrypt registered [ 6746.317687] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 20:41:54 (1787791314) [ 6747.586328] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6747.648369] alg: No test for adler32 (adler32-zlib) [ 6748.668659] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 6748.883420] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 6750.576288] Key type lgssc registered [ 6751.731565] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6798.267445] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6803.634984] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6820.018808] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6839.791422] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6840.558060] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6841.718171] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 6847.548544] LustreError: lustre-MDT0001-mdc-ffff99edd057d000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6847.565598] Lustre: lustre-MDT0001-mdc-ffff99edd057d000: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 6853.287335] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6854.594867] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6875.163031] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6878.674262] Lustre: Unmounted lustre-client [ 6905.832894] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 20:44:33 (1787791473) [ 6979.147644] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6983.596954] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7000.924586] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7001.407370] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7021.040387] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7022.264719] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7027.695370] Lustre: lustre-OST0001-osc-ffff99edd2104800: Connection to lustre-OST0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7032.997948] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7043.328889] Lustre: Unmounted lustre-client [ 7073.287039] Key type lgssc unregistered [ 7073.511648] LNet: 162675:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7073.518210] LNetError: 162675:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7073.539537] LNet: Removed LNI 192.168.204.22@tcp [ 7074.125667] Key type .llcrypt unregistered [ 7074.130493] Key type ._llcrypt unregistered [ 7098.227424] Key type ._llcrypt registered [ 7098.233433] Key type .llcrypt registered [ 7099.403383] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 20:47:47 (1787791667) [ 7101.353542] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7101.404110] alg: No test for adler32 (adler32-zlib) [ 7102.458398] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 7102.685545] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 7104.360178] Key type lgssc registered [ 7105.320831] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7144.943054] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7149.713583] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7166.431722] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7167.957859] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7213.190169] Lustre: Unmounted lustre-client [ 7243.139313] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7243.604206] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7277.669141] Lustre: Unmounted lustre-client [ 7301.972667] Key type lgssc unregistered [ 7302.253641] LNet: 167114:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7302.264840] LNetError: 167114:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7302.293954] LNet: Removed LNI 192.168.204.22@tcp [ 7302.907305] Key type .llcrypt unregistered [ 7302.912953] Key type ._llcrypt unregistered [ 7315.094562] Key type ._llcrypt registered [ 7315.096834] Key type .llcrypt registered [ 7316.156727] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 20:51:24 (1787791884) [ 7318.237534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7318.282801] alg: No test for adler32 (adler32-zlib) [ 7319.315289] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 7319.517539] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 7321.170071] Key type lgssc registered [ 7322.183453] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7361.426447] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7365.481336] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7381.618721] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7387.177770] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7404.667628] Lustre: Unmounted lustre-client [ 7431.134176] Key type lgssc unregistered [ 7431.387067] LNet: 170871:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7431.394099] LNetError: 170871:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7431.413537] LNet: Removed LNI 192.168.204.22@tcp [ 7431.947763] Key type .llcrypt unregistered [ 7431.949884] Key type ._llcrypt unregistered [ 7442.506808] Key type ._llcrypt registered [ 7442.510666] Key type .llcrypt registered [ 7442.836827] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7442.850614] alg: No test for adler32 (adler32-zlib) [ 7443.865806] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 7444.149036] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 7445.825075] Key type lgssc registered [ 7446.642476] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7485.026471] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7489.039870] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7505.929276] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7511.580048] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7517.887063] Lustre: Unmounted lustre-client [ 7543.904686] Key type lgssc unregistered [ 7544.177278] LNet: 173939:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7544.183644] LNetError: 173939:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7544.202467] LNet: Removed LNI 192.168.204.22@tcp [ 7544.901175] Key type .llcrypt unregistered [ 7544.908091] Key type ._llcrypt unregistered [ 7559.843239] Key type ._llcrypt registered [ 7559.848239] Key type .llcrypt registered [ 7561.033711] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 20:55:28 (1787792128) [ 7562.571421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7562.589201] alg: No test for adler32 (adler32-zlib) [ 7563.704054] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 7563.914769] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 7565.584824] Key type lgssc registered [ 7566.638767] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7610.571638] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7614.867436] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7631.504732] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7637.537624] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7658.203832] Lustre: Unmounted lustre-client [ 7686.997291] Key type lgssc unregistered [ 7687.220395] LNet: 177694:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7687.228807] LNetError: 177694:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7687.248901] LNet: Removed LNI 192.168.204.22@tcp [ 7687.827850] Key type .llcrypt unregistered [ 7687.831905] Key type ._llcrypt unregistered [ 7698.492746] Key type ._llcrypt registered [ 7698.495680] Key type .llcrypt registered [ 7698.966821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7698.993989] alg: No test for adler32 (adler32-zlib) [ 7700.056552] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 7700.359602] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 7702.117181] Key type lgssc registered [ 7702.812663] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7751.110893] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7758.060624] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7783.853461] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7785.513489] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 7795.844166] Lustre: Unmounted lustre-client [ 7822.061293] Key type lgssc unregistered [ 7822.372079] LNet: 180763:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7822.384759] LNetError: 180763:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7822.416342] LNet: Removed LNI 192.168.204.22@tcp [ 7823.137217] Key type .llcrypt unregistered [ 7823.139457] Key type ._llcrypt unregistered [ 7838.336935] Key type ._llcrypt registered [ 7838.338729] Key type .llcrypt registered [ 7839.751939] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 21:00:07 (1787792407) [ 7859.733796] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7859.753790] alg: No test for adler32 (adler32-zlib) [ 7860.778290] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 7860.938700] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 7862.600260] Key type lgssc registered [ 7863.821646] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7948.279863] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7954.285430] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7977.608929] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8018.338511] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 21:03:06 (1787792586) [ 8053.529994] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8059.377579] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8078.173175] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8079.843895] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 8094.090939] Lustre: Unmounted lustre-client [ 8122.742885] Key type lgssc unregistered [ 8122.944992] LNet: 187885:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8122.954856] LNetError: 187885:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8122.970097] LNet: Removed LNI 192.168.204.22@tcp [ 8123.614570] Key type .llcrypt unregistered [ 8123.616267] Key type ._llcrypt unregistered [ 8143.320947] Key type ._llcrypt registered [ 8143.324318] Key type .llcrypt registered [ 8145.920528] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8148.953841] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 21:05:15 (1787792715) [ 8172.612977] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8172.662391] alg: No test for adler32 (adler32-zlib) [ 8173.719459] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 8173.993790] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 8175.680769] Key type lgssc registered [ 8176.632515] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8280.185829] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8285.577759] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8315.322604] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8343.410596] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8346.388778] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 8371.636469] Lustre: Unmounted lustre-client [ 8508.444992] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8515.338346] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8544.259132] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8601.035422] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 21:12:48 (1787793168) [ 8603.215749] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8605.809707] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 21:12:52 (1787793172) [ 8715.253419] Key type lgssc unregistered [ 8715.591077] LNet: 199344:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8715.601128] LNetError: 199344:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8715.614980] LNet: Removed LNI 192.168.204.22@tcp [ 8716.362839] Key type .llcrypt unregistered [ 8716.365435] Key type ._llcrypt unregistered [ 8734.289464] Key type ._llcrypt registered [ 8734.292792] Key type .llcrypt registered [ 8736.461301] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 21:15:03 (1787793303) [ 8782.846235] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8782.908176] alg: No test for adler32 (adler32-zlib) [ 8784.074217] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 8784.302592] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 8785.976229] Key type lgssc registered [ 8787.203554] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8838.340910] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8844.736078] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8881.412399] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8911.505767] Key type lgssc unregistered [ 8911.724772] LNet: 203086:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8911.730919] LNetError: 203086:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8911.746392] LNet: Removed LNI 192.168.204.22@tcp [ 8912.254771] Key type .llcrypt unregistered [ 8912.257528] Key type ._llcrypt unregistered [ 8926.820138] Key type ._llcrypt registered [ 8926.825232] Key type .llcrypt registered [ 8928.543646] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 21:18:15 (1787793495) [ 8931.682199] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8931.755333] alg: No test for adler32 (adler32-zlib) [ 8932.911180] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 8933.244022] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 8934.998988] Key type lgssc registered [ 8936.674950] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8991.429226] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8998.121028] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9025.277638] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9036.378195] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 9046.515997] Lustre: lustre-MDT0000-mdc-ffff99edc5d10000: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9056.760414] Lustre: lustre-MDT0001-mdc-ffff99edc5d10000: Connection to lustre-MDT0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9066.982589] Lustre: 204075:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787793620/real 1787793620] req@0000000040ad6800 x1874637359235840/t0(0) o400->MGC192.168.204.122@tcp@192.168.204.122@tcp:26/25 lens 224/224 e 0 to 1 dl 1787793636 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9067.023716] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [ 9093.612483] Lustre: Evicted from MGS (at 192.168.204.122@tcp) after server handle changed from 0x66e87032d0791e4e to 0x66e87032d0793c77 [ 9093.626721] Lustre: MGC192.168.204.122@tcp: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 9101.331167] LustreError: lustre-MDT0000-mdc-ffff99edc5d10000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9101.392485] Lustre: lustre-MDT0000-mdc-ffff99edc5d10000: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 9105.980873] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9107.480839] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9113.805512] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9115.510576] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9118.672140] Lustre: Unmounted lustre-client [ 9155.677826] Key type lgssc unregistered [ 9155.965174] LNet: 208037:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9155.972427] LNetError: 208037:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9155.989870] LNet: Removed LNI 192.168.204.22@tcp [ 9157.035707] Key type .llcrypt unregistered [ 9157.041377] Key type ._llcrypt unregistered [ 9174.163651] Key type ._llcrypt registered [ 9174.166407] Key type .llcrypt registered [ 9175.473345] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 21:22:23 (1787793743) [ 9178.161839] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9178.237116] alg: No test for adler32 (adler32-zlib) [ 9179.316514] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 9179.505492] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 9181.216294] Key type lgssc registered [ 9182.303589] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9233.406446] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9241.295142] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9303.349347] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9309.388678] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9349.989650] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9373.829188] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9413.332284] Key type lgssc unregistered [ 9413.561675] LNet: 213336:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9413.566672] LNetError: 213336:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9413.581276] LNet: Removed LNI 192.168.204.22@tcp [ 9414.407883] Key type .llcrypt unregistered [ 9414.413980] Key type ._llcrypt unregistered [ 9461.466168] Key type ._llcrypt registered [ 9461.470255] Key type .llcrypt registered [ 9462.897885] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 21:27:10 (1787794030) [ 9503.572740] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9503.594260] alg: No test for adler32 (adler32-zlib) [ 9504.763763] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [ 9505.042042] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [ 9506.696152] Key type lgssc registered [ 9507.936715] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9603.989870] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9612.073826] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9638.521121] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9686.071428] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 21:30:54 (1787794254) [ 9692.905773] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 21:31:00 (1787794260) [ 9727.385193] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9732.766441] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9753.540664] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9756.327452] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 9762.288370] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9763.814894] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9765.564517] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9767.477650] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9772.012421] Lustre: lustre-MDT0000-mdc-ffff99edc986b800: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9788.392292] Lustre: 215234:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787794341/real 1787794341] req@00000000d7f60453 x1874637958948608/t0(0) o400->MGC192.168.204.122@tcp@192.168.204.122@tcp:26/25 lens 224/224 e 0 to 1 dl 1787794357 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9788.434280] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [ 9795.874854] Lustre: lustre-MDT0000-mdc-ffff99edc986b800: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 9797.948739] Lustre: Evicted from MGS (at 192.168.204.122@tcp) after server handle changed from 0x93d66cfa9fe4bfed to 0x93d66cfa9fe4c39e [ 9797.961608] Lustre: MGC192.168.204.122@tcp: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 9806.894085] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9808.780542] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9812.676145] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9818.605648] Lustre: lustre-MDT0000-mdc-ffff99edc986b800: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9833.952272] Lustre: 215236:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787794387/real 1787794387] req@000000002c54302e x1874637958957312/t0(0) o400->MGC192.168.204.122@tcp@192.168.204.122@tcp:26/25 lens 224/224 e 0 to 1 dl 1787794403 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9833.989865] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [ 9844.218587] Lustre: Evicted from MGS (at 192.168.204.122@tcp) after server handle changed from 0x93d66cfa9fe4c39e to 0x93d66cfa9fe4c56c [ 9844.247551] Lustre: MGC192.168.204.122@tcp: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 9847.582437] Lustre: lustre-MDT0000-mdc-ffff99edc986b800: Connection restored to 192.168.204.122@tcp (at 192.168.204.122@tcp) [ 9858.559027] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9860.138083] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9864.712492] Lustre: Unmounted lustre-client [ 9942.277400] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9948.901781] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9972.497991] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9978.964666] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [ 9982.170317] Lustre: Unmounted lustre-client [10021.335171] Key type lgssc unregistered [10021.691432] LNet: 225831:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10021.700073] LNetError: 225831:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10022.758929] LNet: Removed LNI 192.168.204.22@tcp [10023.506169] Key type .llcrypt unregistered [10023.512608] Key type ._llcrypt unregistered [10042.082677] Key type ._llcrypt registered [10042.085316] Key type .llcrypt registered [10043.472642] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 21:36:51 (1787794611) [10048.042449] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10048.114827] alg: No test for adler32 (adler32-zlib) [10049.230769] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [10049.492969] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [10051.216219] Key type lgssc registered [10052.465524] Lustre: Echo OBD driver; http://www.lustre.org/ [10110.539118] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10117.518936] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10142.505900] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10153.552297] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [10160.125606] Lustre: Unmounted lustre-client [10226.643231] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10232.777671] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10254.715294] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10255.318133] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [10264.422806] Lustre: Unmounted lustre-client [10332.702372] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10338.377799] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10357.968141] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10358.604924] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [10360.572550] Lustre: Unmounted lustre-client [10396.610610] Key type lgssc unregistered [10396.944373] LNet: 232897:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10396.961272] LNetError: 232897:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10396.981969] LNet: Removed LNI 192.168.204.22@tcp [10397.763030] Key type .llcrypt unregistered [10397.766550] Key type ._llcrypt unregistered [10415.405321] Key type ._llcrypt registered [10415.407643] Key type .llcrypt registered [10416.984585] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 21:43:04 (1787794984) [10420.388072] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10420.441428] alg: No test for adler32 (adler32-zlib) [10421.561871] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [10421.799424] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [10423.480264] Key type lgssc registered [10424.950771] Lustre: Echo OBD driver; http://www.lustre.org/ [10470.707710] Key type lgssc unregistered [10470.973545] LNet: 235223:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10470.981909] LNetError: 235223:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10471.010857] LNet: Removed LNI 192.168.204.22@tcp [10471.842827] Key type .llcrypt unregistered [10471.847340] Key type ._llcrypt unregistered [10503.274905] Key type ._llcrypt registered [10503.278184] Key type .llcrypt registered [10503.546357] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10503.557919] alg: No test for adler32 (adler32-zlib) [10504.642494] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [10504.886797] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [10506.584398] Key type lgssc registered [10507.765042] Lustre: Echo OBD driver; http://www.lustre.org/ [10592.711512] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10600.284764] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10626.990968] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10666.699231] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10668.680926] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 21:47:16 (1787795236) [10700.016538] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10705.081239] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10725.654604] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10754.195214] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10756.138176] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [10761.216603] Lustre: lustre-OST0001-osc-ffff99edd050c800: Connection to lustre-OST0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [10768.773274] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10779.127934] Lustre: Unmounted lustre-client [10815.609412] Key type lgssc unregistered [10815.917963] LNet: 242348:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10815.928040] LNetError: 242348:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10815.952643] LNet: Removed LNI 192.168.204.22@tcp [10816.565685] Key type .llcrypt unregistered [10816.568081] Key type ._llcrypt unregistered [10850.432308] Key type ._llcrypt registered [10850.434894] Key type .llcrypt registered [10851.946607] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 21:50:19 (1787795419) [10866.116548] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10866.138962] alg: No test for adler32 (adler32-zlib) [10867.233549] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [10867.481697] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [10869.192829] Key type lgssc registered [10870.375347] Lustre: Echo OBD driver; http://www.lustre.org/ [10922.099724] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10927.779323] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10950.689691] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 21:51:58 (1787795518) [10987.634427] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10993.529785] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11015.958388] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11018.768991] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [11032.604733] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11035.966904] Lustre: Unmounted lustre-client [11143.096444] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11151.015097] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11204.294292] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11204.978136] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [11208.368613] Lustre: Unmounted lustre-client [11236.959989] Key type lgssc unregistered [11237.306973] LNet: 250031:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11237.325319] LNetError: 250031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11237.351973] LNet: Removed LNI 192.168.204.22@tcp [11238.305102] Key type .llcrypt unregistered [11238.307706] Key type ._llcrypt unregistered [11271.899438] Key type ._llcrypt registered [11271.901791] Key type .llcrypt registered [11272.400047] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11272.429233] alg: No test for adler32 (adler32-zlib) [11273.526804] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [11273.857722] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [11275.792255] Key type lgssc registered [11277.107437] Lustre: Echo OBD driver; http://www.lustre.org/ [11380.080627] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11386.717123] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11413.404531] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11460.117936] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11461.990257] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 22:00:29 (1787796029) [11499.948496] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11506.669793] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11531.958643] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11541.029340] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [11545.630779] Lustre: Unmounted lustre-client [11575.923772] Key type lgssc unregistered [11576.151910] LNet: 256693:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11576.159077] LNetError: 256693:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11576.178205] LNet: Removed LNI 192.168.204.22@tcp [11576.931462] Key type .llcrypt unregistered [11576.936386] Key type ._llcrypt unregistered [11595.083330] Key type ._llcrypt registered [11595.086121] Key type .llcrypt registered [11596.549783] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11598.286556] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 22:02:46 (1787796166) [11608.858753] Key type .llcrypt unregistered [11608.867235] Key type ._llcrypt unregistered [11618.741722] Key type ._llcrypt registered [11618.743495] Key type .llcrypt registered [11619.404698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11619.427994] alg: No test for adler32 (adler32-zlib) [11620.729083] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [11621.104972] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [11622.832253] Key type lgssc registered [11624.315130] Lustre: Echo OBD driver; http://www.lustre.org/ [11682.950348] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11702.649128] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [11706.140653] Lustre: Unmounted lustre-client [11735.301921] Key type lgssc unregistered [11735.702414] LNet: 260157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11735.719977] LNetError: 260157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11735.749334] LNet: Removed LNI 192.168.204.22@tcp [11736.908755] Key type .llcrypt unregistered [11736.911378] Key type ._llcrypt unregistered [11757.491562] Key type ._llcrypt registered [11757.497760] Key type .llcrypt registered [11759.732850] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 22:05:26 (1787796326) [11762.764613] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11762.852552] alg: No test for adler32 (adler32-zlib) [11764.009755] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [11764.361294] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [11766.128636] Key type lgssc registered [11767.963292] Lustre: Echo OBD driver; http://www.lustre.org/ [11861.202643] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11901.772381] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11909.309933] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11911.271239] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [11914.989513] Lustre: Unmounted lustre-client [11953.156929] Key type lgssc unregistered [11953.487511] LNet: 263711:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11953.501384] LNetError: 263711:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11953.522978] LNet: Removed LNI 192.168.204.22@tcp [11954.347951] Key type .llcrypt unregistered [11954.351348] Key type ._llcrypt unregistered [11974.081566] Key type ._llcrypt registered [11974.083960] Key type .llcrypt registered [11975.779786] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 22:09:03 (1787796543) [11978.743077] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11978.773359] alg: No test for adler32 (adler32-zlib) [11979.892604] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [11980.234576] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [11981.928244] Key type lgssc registered [11983.480281] Lustre: Echo OBD driver; http://www.lustre.org/ [12038.930985] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12045.486917] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12069.061127] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12071.871460] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [12077.032206] Lustre: lustre-MDT0000-mdc-ffff99edc5786000: Connection to lustre-MDT0000 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [12082.707420] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12082.739820] LustreError: 266870:0:(file.c:6176:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12083.226246] LustreError: MGC192.168.204.122@tcp: Connection to MGS (at 192.168.204.122@tcp) was lost; in progress operations using this service will fail [12083.317185] Lustre: Unmounted lustre-client [12104.091900] Key type lgssc unregistered [12104.368935] LNet: 267287:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12104.380407] LNetError: 267287:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12104.410173] LNet: Removed LNI 192.168.204.22@tcp [12105.198220] Key type .llcrypt unregistered [12105.200992] Key type ._llcrypt unregistered [12124.477716] Key type ._llcrypt registered [12124.480252] Key type .llcrypt registered [12125.922461] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 22:11:33 (1787796693) [12128.870570] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12129.008851] alg: No test for adler32 (adler32-zlib) [12130.149071] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [12130.501812] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [12132.328374] Key type lgssc registered [12134.149848] Lustre: Echo OBD driver; http://www.lustre.org/ [12196.213601] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12204.251669] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12228.962836] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12234.822379] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [12239.859985] Lustre: lustre-MDT0001-mdc-ffff99edc6302000: Connection to lustre-MDT0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [12246.220650] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12249.113228] Lustre: Unmounted lustre-client [12272.958697] Key type lgssc unregistered [12273.224967] LNet: 270875:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12273.232196] LNetError: 270875:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12273.254437] LNet: Removed LNI 192.168.204.22@tcp [12274.259818] Key type .llcrypt unregistered [12274.263238] Key type ._llcrypt unregistered [12293.158787] Key type ._llcrypt registered [12293.162866] Key type .llcrypt registered [12295.136485] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 22:14:22 (1787796862) [12318.095772] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12318.135565] alg: No test for adler32 (adler32-zlib) [12319.468431] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [12319.796144] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [12321.586453] Key type lgssc registered [12323.426663] Lustre: Echo OBD driver; http://www.lustre.org/ [12451.916125] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12453.700513] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [12500.467623] Lustre: lustre-MDT0001-mdc-ffff99edc2d0a000: Connection to lustre-MDT0001 (at 192.168.204.122@tcp) was lost; in progress operations using this service will wait for recovery to complete [12508.645507] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12518.935055] Lustre: Unmounted lustre-client [12547.394895] Key type lgssc unregistered [12547.710864] LNet: 276674:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12547.717748] LNetError: 276674:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12547.735731] LNet: Removed LNI 192.168.204.22@tcp [12548.526510] Key type .llcrypt unregistered [12548.531612] Key type ._llcrypt unregistered [12565.114711] Key type ._llcrypt registered [12565.122422] Key type .llcrypt registered [12566.590857] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 22:18:54 (1787797134) [12568.410564] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12570.186902] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 22:18:57 (1787797137) [12572.185443] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12574.466735] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 22:19:01 (1787797141) [12576.541243] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12578.909521] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 22:19:06 (1787797146) [12581.384702] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12584.202929] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 22:19:10 (1787797150) [12586.258913] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12588.642275] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 22:19:15 (1787797155) [12600.220445] Key type .llcrypt unregistered [12600.223499] Key type ._llcrypt unregistered [12610.638062] Key type ._llcrypt registered [12610.643205] Key type .llcrypt registered [12611.166167] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12611.194218] alg: No test for adler32 (adler32-zlib) [12612.487704] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [12612.991175] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [12614.744214] Key type lgssc registered [12616.691677] Lustre: Echo OBD driver; http://www.lustre.org/ [12710.720878] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12717.881533] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12749.894568] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12751.824614] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [12755.515244] Lustre: Unmounted lustre-client [12795.449836] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 22:22:43 (1787797363) [12832.793177] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12839.950246] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12877.929425] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12878.712184] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [12881.798971] Lustre: Unmounted lustre-client [12929.468345] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 22:24:56 (1787797496) [12939.680220] LNet: 1 local NIs in recovery (showing 1): 192.168.204.22@tcp [13587.026831] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13592.872110] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13630.290414] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13744.666788] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 22:38:32 (1787798312) [13756.619543] Key type lgssc unregistered [13756.912085] LNet: 290216:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13756.918859] LNetError: 290216:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13757.992426] LNet: Removed LNI 192.168.204.22@tcp [13758.654864] Key type .llcrypt unregistered [13758.659251] Key type ._llcrypt unregistered [13878.706782] Key type ._llcrypt registered [13878.708410] Key type .llcrypt registered [13879.193781] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13879.210180] alg: No test for adler32 (adler32-zlib) [13880.389529] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [13880.671709] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [13882.400291] Key type lgssc registered [13884.134228] Lustre: Echo OBD driver; http://www.lustre.org/ [13972.838290] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13979.252171] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14003.309952] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14036.098478] Key type lgssc unregistered [14036.357353] LNet: 293914:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14036.371914] LNetError: 293914:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14036.391474] LNet: Removed LNI 192.168.204.22@tcp [14037.163815] Key type .llcrypt unregistered [14037.166742] Key type ._llcrypt unregistered [14072.400125] Key type ._llcrypt registered [14072.403791] Key type .llcrypt registered [14073.767579] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 22:44:01 (1787798641) [14093.995598] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14094.023403] alg: No test for adler32 (adler32-zlib) [14095.101571] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [14095.336873] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [14097.041638] Key type lgssc registered [14098.332157] Lustre: Echo OBD driver; http://www.lustre.org/ [14148.923967] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 22:45:16 (1787798716) [14162.053259] Key type lgssc unregistered [14162.402134] LNet: 297473:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14162.414742] LNetError: 297473:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14162.431367] LNet: Removed LNI 192.168.204.22@tcp [14163.129773] Key type .llcrypt unregistered [14163.137132] Key type ._llcrypt unregistered [14173.756633] Key type ._llcrypt registered [14173.761357] Key type .llcrypt registered [14174.011468] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14174.038129] alg: No test for adler32 (adler32-zlib) [14175.096212] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [14175.599331] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [14177.296217] Key type lgssc registered [14179.140159] Lustre: Echo OBD driver; http://www.lustre.org/ [14247.489428] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14253.134878] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14274.948268] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14596.538232] LNet: Added LNI 192.168.204.22@tcp50 [8/256/0/180] [14599.244890] LNet: Removed LNI 192.168.204.22@tcp [14601.378694] Lustre: 301891:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff99edc2f59000: config has no valid NIDs, force dynamic NIDs [14602.600816] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [14602.802276] Lustre: Unmounted lustre-client [14605.660356] Key type lgssc unregistered [14606.077304] LNet: 302154:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14606.083310] LNetError: 302154:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14606.100975] LNet: Removed LNI 192.168.204.22@tcp50 [14606.732613] Key type .llcrypt unregistered [14606.736412] Key type ._llcrypt unregistered [14623.975781] Key type ._llcrypt registered [14623.977498] Key type .llcrypt registered [14624.585912] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14624.611771] alg: No test for adler32 (adler32-zlib) [14625.724209] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [14625.976127] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [14627.689469] Key type lgssc registered [14629.244456] Lustre: Echo OBD driver; http://www.lustre.org/ [14687.709371] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14692.778875] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14700.761700] LNet: Added LNI 192.168.204.22@tcp50 [8/256/0/180] [14701.575546] LNet: Removed LNI 192.168.204.22@tcp [14702.744775] Lustre: 304848:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff99edd86d1000: config has no valid NIDs, force dynamic NIDs [14703.970798] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [14704.567115] Lustre: Unmounted lustre-client [14737.247546] Key type lgssc unregistered [14737.624980] LNet: 305722:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14737.631202] LNetError: 305722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14737.653242] LNet: Removed LNI 192.168.204.22@tcp50 [14738.203226] Key type .llcrypt unregistered [14738.207414] Key type ._llcrypt unregistered [14751.477978] Key type ._llcrypt registered [14751.480201] Key type .llcrypt registered [14752.749609] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 22:55:20 (1787799320) [14776.252784] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14776.272845] alg: No test for adler32 (adler32-zlib) [14777.479350] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [14777.870756] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [14779.560715] Key type lgssc registered [14781.110045] Lustre: Echo OBD driver; http://www.lustre.org/ [14880.786794] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14886.150517] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14908.882988] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14960.601177] Key type lgssc unregistered [14960.895384] LNet: 310484:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14960.908903] LNetError: 310484:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14960.931201] LNet: Removed LNI 192.168.204.22@tcp [14961.735878] Key type .llcrypt unregistered [14961.741458] Key type ._llcrypt unregistered [14973.547305] Key type ._llcrypt registered [14973.550511] Key type .llcrypt registered [14974.782913] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 22:59:02 (1787799542) [14978.498390] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14978.508890] alg: No test for adler32 (adler32-zlib) [14979.898480] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [14980.276766] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [14982.033290] Key type lgssc registered [14984.032870] Lustre: Echo OBD driver; http://www.lustre.org/ [15039.716407] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15046.357760] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15069.132552] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15071.888753] Lustre: Mounted lustre-client - version 2.17.57_54_g0142cbb [15129.576773] Lustre: Mounted fs15246-client - version 2.17.57_54_g0142cbb [15145.119614] Lustre: Unmounted fs15246-client [15175.789179] Lustre: Unmounted lustre-client [15206.191629] Key type lgssc unregistered [15206.500633] LNet: 315352:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15206.540671] LNetError: 315352:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15206.572318] LNet: Removed LNI 192.168.204.22@tcp [15207.504635] Key type .llcrypt unregistered [15207.510228] Key type ._llcrypt unregistered [15219.760301] Key type ._llcrypt registered [15219.762210] Key type .llcrypt registered [15221.099142] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 23:03:08 (1787799788) [15223.453408] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15223.462404] alg: No test for adler32 (adler32-zlib) [15224.529360] Lustre: Lustre: Build Version: 2.17.57_54_g0142cbb [15224.756508] LNet: Added LNI 192.168.204.22@tcp [8/256/0/180] [15226.456187] Key type lgssc registered [15227.635834] Lustre: Echo OBD driver; http://www.lustre.org/ [15374.686443] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15381.167819] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15405.985779] Lustre: DEBUG MARKER: oleg422-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15509.572834] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15240 sec ========= 23:07:57 (1787800077) [15511.110368] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 23:07:59 (1787800079) === [15514.523458] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 23:08:02 (1787800082) === [15548.413072] Key type lgssc unregistered [15548.683807] LNet: 324619:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15548.698092] LNetError: 324619:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15548.733295] LNet: Removed LNI 192.168.204.22@tcp [15549.761138] Key type .llcrypt unregistered [15549.762851] Key type ._llcrypt unregistered