[ 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-8.fc42 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 450636993 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 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 0x00000000BFFE2421 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE22BD 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 00227D (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2331 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE23C1 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE23F9 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe22bd-0xbffe2330] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22bc] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2331-0xbffe23c0] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe23c1-0xbffe23f8] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe23f9-0xbffe2420] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003309] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005139] kvm-guest: setup PV IPIs [ 0.009347] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.010000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.010020] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.011013] pid_max: default: 32768 minimum: 301 [ 0.012269] LSM: Security Framework initializing [ 0.013055] Yama: becoming mindful. [ 0.014030] SELinux: Initializing. [ 0.015060] *** VALIDATE selinux *** [ 0.026220] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.033730] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.035160] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.036110] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.037113] *** VALIDATE tmpfs *** [ 0.038410] *** VALIDATE proc *** [ 0.039310] *** VALIDATE cgroup *** [ 0.040014] *** VALIDATE cgroup2 *** [ 0.041412] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.043009] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.045004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.046033] Spectre V2 : User space: Vulnerable [ 0.047013] Speculative Store Bypass: Vulnerable [ 0.050778] debug: unmapping init [mem 0xffffffffa8259000-0xffffffffa8260fff] [ 0.053237] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.054842] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.055023] ... version: 2 [ 0.056016] ... bit width: 48 [ 0.057012] ... generic registers: 4 [ 0.058012] ... value mask: 0000ffffffffffff [ 0.059011] ... max period: 00007fffffffffff [ 0.060011] ... fixed-purpose events: 3 [ 0.061012] ... event mask: 000000070000000f [ 0.062368] rcu: Hierarchical SRCU implementation. [ 0.064727] smp: Bringing up secondary CPUs ... [ 0.065665] x86: Booting SMP configuration: [ 0.066023] .... node #0, CPUs: #1 #2 #3 [ 0.073163] smp: Brought up 1 node, 4 CPUs [ 0.075012] smpboot: Max logical packages: 1 [ 0.076014] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.155208] node 0 deferred pages initialised in 74ms [ 0.160152] devtmpfs: initialized [ 0.161266] x86/mm: Memory block size: 128MB [ 0.164853] gcov: version magic: 0x41383552 [ 0.167335] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.171073] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.173277] pinctrl core: initialized pinctrl subsystem [ 0.175156] [ 0.175705] ************************************************************* [ 0.176011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.178012] ** ** [ 0.181014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.184011] ** ** [ 0.186010] ** This means that this kernel is built to expose internal ** [ 0.188011] ** IOMMU data structures, which may compromise security on ** [ 0.190011] ** your system. ** [ 0.193015] ** ** [ 0.195010] ** If you see this message and you are not debugging the ** [ 0.197011] ** kernel, report this immediately to your vendor! ** [ 0.199012] ** ** [ 0.202011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.204008] ************************************************************* [ 0.206732] NET: Registered protocol family 16 [ 0.208587] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.212058] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.215077] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.219093] cpuidle: using governor menu [ 0.220872] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.223607] PCI: Using configuration type 1 for base access [ 0.226163] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.236292] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.237071] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.239153] cryptd: max_cpu_qlen set to 1000 [ 0.240373] ACPI: Added _OSI(Module Device) [ 0.241000] ACPI: Added _OSI(Processor Device) [ 0.242011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.244011] ACPI: Added _OSI(Processor Aggregator Device) [ 0.249388] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.256746] ACPI: Interpreter enabled [ 0.258053] ACPI: PM: (supports S0 S3 S4 S5) [ 0.259010] ACPI: Using IOAPIC for interrupt routing [ 0.261230] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.265493] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.277897] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.280149] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.284020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.288077] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.293758] acpiphp: Slot [2] registered [ 0.295148] acpiphp: Slot [5] registered [ 0.296180] acpiphp: Slot [6] registered [ 0.297112] acpiphp: Slot [3] registered [ 0.299146] acpiphp: Slot [4] registered [ 0.300083] acpiphp: Slot [7] registered [ 0.302107] acpiphp: Slot [8] registered [ 0.304218] acpiphp: Slot [9] registered [ 0.306110] acpiphp: Slot [10] registered [ 0.307101] acpiphp: Slot [11] registered [ 0.309084] acpiphp: Slot [12] registered [ 0.310091] acpiphp: Slot [13] registered [ 0.312111] acpiphp: Slot [14] registered [ 0.315124] acpiphp: Slot [15] registered [ 0.316143] acpiphp: Slot [16] registered [ 0.318097] acpiphp: Slot [17] registered [ 0.319086] acpiphp: Slot [18] registered [ 0.320112] acpiphp: Slot [19] registered [ 0.322091] acpiphp: Slot [20] registered [ 0.324141] acpiphp: Slot [21] registered [ 0.326169] acpiphp: Slot [22] registered [ 0.328169] acpiphp: Slot [23] registered [ 0.330122] acpiphp: Slot [24] registered [ 0.331142] acpiphp: Slot [25] registered [ 0.332077] acpiphp: Slot [26] registered [ 0.333130] acpiphp: Slot [27] registered [ 0.335134] acpiphp: Slot [28] registered [ 0.337136] acpiphp: Slot [29] registered [ 0.338129] acpiphp: Slot [30] registered [ 0.340148] acpiphp: Slot [31] registered [ 0.342085] PCI host bridge to bus 0000:00 [ 0.344028] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.346030] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.349033] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.354040] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.359140] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.366249] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.370375] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.453557] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.461555] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.470641] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.475000] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.477023] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.478000] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.479018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.482188] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.486998] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.491091] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.495139] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.500799] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.510836] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.517013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.523095] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.528015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.536015] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.562014] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.588502] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.595014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.601015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.613994] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.626584] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.629348] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.632605] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.634381] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.637205] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.641293] iommu: Default domain type: Passthrough [ 0.643335] SCSI subsystem initialized [ 0.645134] ACPI: bus type USB registered [ 0.646089] usbcore: registered new interface driver usbfs [ 0.648101] usbcore: registered new interface driver hub [ 0.650190] usbcore: registered new device driver usb [ 0.652248] pps_core: LinuxPPS API ver. 1 registered [ 0.655053] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.658057] PTP clock support registered [ 0.660148] EDAC MC: Ver: 3.0.0 [ 0.662153] PCI: Using ACPI for IRQ routing [ 0.663866] NetLabel: Initializing [ 0.666011] NetLabel: domain hash size = 128 [ 0.667009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.669079] NetLabel: unlabeled traffic allowed by default [ 0.672327] vgaarb: loaded [ 0.674374] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.676017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.682000] clocksource: Switched to clocksource kvm-clock [ 0.805265] VFS: Disk quotas dquot_6.6.0 [ 0.806708] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.809208] *** VALIDATE ramfs *** [ 0.810535] *** VALIDATE hugetlbfs *** [ 0.811979] pnp: PnP ACPI init [ 0.814489] pnp: PnP ACPI: found 6 devices [ 0.831295] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.834613] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.836804] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.838972] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.841349] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.843653] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.846496] NET: Registered protocol family 2 [ 0.848888] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.854132] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.858295] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.864251] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.868115] TCP: Hash tables configured (established 65536 bind 65536) [ 0.871346] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.874839] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.877835] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.881261] NET: Registered protocol family 1 [ 0.883796] RPC: Registered named UNIX socket transport module. [ 0.885662] RPC: Registered udp transport module. [ 0.887581] RPC: Registered tcp transport module. [ 0.889637] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.892132] NET: Registered protocol family 44 [ 0.893924] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.896307] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.898369] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.900887] PCI: CLS 0 bytes, default 64 [ 0.902541] Unpacking initramfs... [ 2.589171] debug: unmapping init [mem 0xffff8b13bcc64000-0xffff8b13bffcffff] [ 2.593446] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.596226] software IO TLB: mapped [mem 0x00000000a3400000-0x00000000a7400000] (64MB) [ 2.599210] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 3.256525] Initialise system trusted keyrings [ 3.261131] Key type blacklist registered [ 3.264986] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.276778] zbud: loaded [ 3.280224] *** VALIDATE nfs *** [ 3.282376] *** VALIDATE nfs4 *** [ 3.285985] pstore: using deflate compression [ 3.294531] Platform Keyring initialized [ 3.424692] NET: Registered protocol family 38 [ 3.428722] Key type asymmetric registered [ 3.431817] Asymmetric key parser 'x509' registered [ 3.437456] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.441583] io scheduler mq-deadline registered [ 3.444902] io scheduler kyber registered [ 3.447783] io scheduler bfq registered [ 3.451879] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.461765] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.496466] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.522340] ACPI: Power Button [PWRF] [ 3.529962] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.539206] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.560651] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.590059] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.619196] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.624286] Non-volatile memory driver v1.3 [ 3.626299] Linux agpgart interface v0.103 [ 3.660809] virtio_blk virtio1: [vda] 134016 512-byte logical blocks (68.6 MB/65.4 MiB) [ 3.664626] vda: detected capacity change from 0 to 68616192 [ 3.695994] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.701480] vdb: detected capacity change from 0 to 1073741824 [ 3.713379] libphy: Fixed MDIO Bus: probed [ 3.724402] usbcore: registered new interface driver usbserial_generic [ 3.729369] usbserial: USB Serial support registered for generic [ 3.733971] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.743380] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.745361] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.748500] mousedev: PS/2 mouse device common for all mice [ 3.754038] rtc_cmos 00:05: RTC can wake from S4 [ 3.759288] rtc_cmos 00:05: registered as rtc0 [ 3.761692] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.763214] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.773756] intel_pstate: CPU model not supported [ 3.777403] hid: raw HID events driver (C) Jiri Kosina [ 3.780442] usbcore: registered new interface driver usbhid [ 3.783330] usbhid: USB HID core driver [ 3.785193] drop_monitor: Initializing network drop monitor service [ 3.789236] Initializing XFRM netlink socket [ 3.791998] NET: Registered protocol family 10 [ 3.793195] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.798557] Segment Routing with IPv6 [ 3.802958] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.813650] NET: Registered protocol family 17 [ 3.819505] mpls_gso: MPLS GSO support [ 3.832250] RAS: Correctable Errors collector initialized. [ 3.837553] AVX version of gcm_enc/dec engaged. [ 3.842394] AES CTR mode by8 optimization enabled [ 3.934343] sched_clock: Marking stable (3934261418, 0)->(4974511094, -1040249676) [ 3.938510] registered taskstats version 1 [ 3.940837] Loading compiled-in X.509 certificates [ 3.943515] zswap: loaded using pool lzo/zbud [ 3.971535] Key type big_key registered [ 3.983484] Key type encrypted registered [ 3.984726] ima: No TPM chip found, activating TPM-bypass! [ 3.986395] ima: Allocated hash algorithm: sha1 [ 3.987844] ima: No architecture policies found [ 3.989730] evm: Initialising EVM extended attributes: [ 3.991495] evm: security.selinux [ 3.992532] evm: security.ima [ 3.993568] evm: security.capability [ 3.994882] evm: HMAC attrs: 0x1 [ 3.997807] rtc_cmos 00:05: setting system clock to 2026-04-30 18:48:44 UTC (1777574924) [ 4.005642] debug: unmapping init [mem 0xffffffffa9203000-0xffffffffa93fffff] [ 4.009478] debug: unmapping init [mem 0xffffffffa7f82000-0xffffffffa8258fff] [ 4.017292] Write protecting the kernel read-only data: 28672k [ 4.021886] debug: unmapping init [mem 0xffffffffa6603000-0xffffffffa67fffff] [ 4.026681] debug: unmapping init [mem 0xffffffffa6f14000-0xffffffffa6ffffff] [ 4.112478] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 4.175582] systemd[1]: Detected virtualization kvm. [ 4.181376] systemd[1]: Detected architecture x86-64. [ 4.192574] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 4.283283] systemd[1]: No hostname configured. [ 4.285534] systemd[1]: Set hostname to . [ 4.287916] random: systemd: uninitialized urandom read (16 bytes read) [ 4.290838] systemd[1]: Initializing machine ID from random generator. [ 4.996954] random: systemd: uninitialized urandom read (16 bytes read) [ 5.001689] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 5.023028] random: systemd: uninitialized urandom read (16 bytes read) [ 5.026033] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 5.029818] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Paths. Starting Apply Kernel Variables... Starting Journal Service... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 6.666882] device-mapper: uevent: version 1.0.3 [ 6.670439] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 8.090531] virtio_net virtio0 ens2: renamed from eth0 [ 8.247923] random: fast init done [ 8.559361] scsi host0: ata_piix [ 8.657091] scsi host1: ata_piix [ 8.660928] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 8.665677] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 14.820369] random: crng init done [ 15.335801] random: 7 urandom warning(s) missed due to ratelimiting [ 18.155432] dracut-initqueue[580]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 20.779887] 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 Initrd Default Target. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 23.891500] printk: systemd: 26 output lines suppressed due to ratelimiting [ 25.094536] SELinux: Disabled at runtime. [ 25.229448] 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) [ 25.251680] systemd[1]: Detected virtualization kvm. [ 25.253682] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 27.755706] systemd[1]: initrd-switch-root.service: Succeeded. [ 27.763291] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 27.787307] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 27.804580] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 27.813662] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 27.837299] systemd[1]: Starting Journal Service... Starting Journal Service... [ 27.878949] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Stopped target Switch Root. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting udev Coldplug all Devices... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd Root File System. Starting Remount Root and Kernel File Systems... Activating swap /dev/disk/by-label/SWAP... Mounting Kernel Debug File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Apply Kernel Variables... [ 28.156374] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Stopped target Initrd File Systems. Mounting Huge Pages File System... Mounting POSIX Message Queue File System... [ OK ] Created slice system-getty.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... Starting Create Static Device Nodes in /dev... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 29.797670] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 31.460085] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 31.546992] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 32.374926] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 32.455811] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 37.955659] Key type dns_resolver registered [ *** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit)[ 38.929765] NFS: Registering the id_resolver key type [ 38.936951] Key type id_resolver registered [ 38.941221] Key type id_legacy registered [ ***] A start job is running for Configur…only root support (11s / no limit) [ **] A start job is running for Configur…only root support (12s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started irqbalance daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Login Service. [ 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 Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg419-client login: [ 52.894015] hrtimer: interrupt took 15004104 ns [ 110.502234] libcfs: loading out-of-tree module taints kernel. [ 110.657579] Key type ._llcrypt registered [ 110.659908] Key type .llcrypt registered [ 111.278703] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 111.293748] alg: No test for adler32 (adler32-zlib) [ 112.736263] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 113.656966] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 115.487323] Key type lgssc registered [ 117.022235] Lustre: Echo OBD driver; http://www.lustre.org/ [ 288.019475] Lustre: Mounted lustre-client [ 294.269364] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 313.829735] Lustre: lustre-OST0000-osc-ffff8b141ab98000: disconnect after 24s idle [ 318.030910] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing check_logdir /tmp/testlogs/ [ 323.383742] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing yml_node [ 328.499169] Lustre: DEBUG MARKER: Client: 2.17.52.53 [ 331.145457] Lustre: DEBUG MARKER: MDS: 2.17.52.53 [ 333.682643] Lustre: DEBUG MARKER: OSS: 2.17.52.53 [ 335.710898] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Apr 30 14:54:14 EDT 2026 [ 354.822853] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 356.670916] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 359.767846] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 370.091289] Lustre: Unmounted lustre-client [ 493.705572] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 497.973477] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 520.388635] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 557.242889] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 14:57:56 (1777575476) [ 559.866373] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 562.670443] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 14:58:00 (1777575480) [ 597.729933] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 602.140378] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 620.677420] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 621.034850] Lustre: Mounted lustre-client [ 625.504448] LustreError: 14426:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b140684f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 625.722807] Lustre: Unmounted lustre-client [ 655.868481] Key type lgssc unregistered [ 656.540701] LNet: 14835:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 656.572124] LNetError: 14835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 656.610712] LNet: Removed LNI 192.168.204.19@tcp [ 658.276271] Key type .llcrypt unregistered [ 658.279408] Key type ._llcrypt unregistered [ 679.351226] Key type ._llcrypt registered [ 679.353577] Key type .llcrypt registered [ 680.481814] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 14:59:59 (1777575599) [ 683.044148] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 683.119723] alg: No test for adler32 (adler32-zlib) [ 684.253523] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 684.565905] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 686.351269] Key type lgssc registered [ 688.209438] Lustre: Echo OBD driver; http://www.lustre.org/ [ 769.057507] Lustre: Mounted lustre-client [ 857.013435] LustreError: 18165:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1406923000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 857.072806] Lustre: Unmounted lustre-client [ 887.774162] Key type lgssc unregistered [ 888.127895] LNet: 18630:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 888.141803] LNetError: 18630:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 888.168980] LNet: Removed LNI 192.168.204.19@tcp [ 888.940502] Key type .llcrypt unregistered [ 888.945529] Key type ._llcrypt unregistered [ 900.382200] Key type ._llcrypt registered [ 900.387789] Key type .llcrypt registered [ 902.328632] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 15:03:40 (1777575820) [ 905.176771] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 905.194663] alg: No test for adler32 (adler32-zlib) [ 906.334759] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 906.668532] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 908.391696] Key type lgssc registered [ 909.811957] Lustre: Echo OBD driver; http://www.lustre.org/ [ 960.271692] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 965.125104] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 987.235704] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 990.122747] Lustre: Mounted lustre-client [ 1005.879055] LustreError: 21742:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1404f92000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1006.010054] Lustre: Unmounted lustre-client [ 1030.688359] Key type lgssc unregistered [ 1030.996390] LNet: 22144:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1031.003746] LNetError: 22144:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1031.022328] LNet: Removed LNI 192.168.204.19@tcp [ 1031.732115] Key type .llcrypt unregistered [ 1031.739561] Key type ._llcrypt unregistered [ 1041.649798] Key type ._llcrypt registered [ 1041.654389] Key type .llcrypt registered [ 1043.375629] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 15:06:01 (1777575961) [ 1046.171222] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1046.311635] alg: No test for adler32 (adler32-zlib) [ 1047.519543] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 1047.830180] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 1049.503309] Key type lgssc registered [ 1051.376867] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1103.769125] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1107.732488] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1129.070347] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1131.642968] Lustre: Mounted lustre-client [ 1137.607039] LustreError: 24843:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b141abeb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1137.715711] Lustre: Unmounted lustre-client [ 1174.085726] Key type lgssc unregistered [ 1174.356433] LNet: 25248:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1174.366941] LNetError: 25248:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1174.408089] LNet: Removed LNI 192.168.204.19@tcp [ 1174.972401] Key type .llcrypt unregistered [ 1174.977224] Key type ._llcrypt unregistered [ 1189.234161] Key type ._llcrypt registered [ 1189.237378] Key type .llcrypt registered [ 1190.430416] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 15:08:29 (1777576109) [ 1193.639966] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1193.658298] alg: No test for adler32 (adler32-zlib) [ 1194.735997] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 1194.930598] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 1196.599242] Key type lgssc registered [ 1197.829923] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1243.840969] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1248.333071] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1268.424733] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1270.368704] Lustre: Mounted lustre-client [ 1275.372155] Lustre: lustre-MDT0000-mdc-ffff8b141abec000: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1280.487031] Lustre: lustre-MDT0001-mdc-ffff8b141abec000: Connection to lustre-MDT0001 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1287.153850] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1290.719214] Lustre: 26209:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777576195/real 1777576195] req@00000000c6ee37b0 x1863923652367104/t0(0) o400->MGC192.168.204.119@tcp@192.168.204.119@tcp:26/25 lens 224/224 e 0 to 1 dl 1777576211 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1290.762566] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [ 1297.518988] Lustre: Unmounted lustre-client [ 1316.717615] Key type lgssc unregistered [ 1317.135247] LNet: 28816:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1317.147587] LNetError: 28816:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1317.170297] LNet: Removed LNI 192.168.204.19@tcp [ 1318.158792] Key type .llcrypt unregistered [ 1318.161683] Key type ._llcrypt unregistered [ 1334.755260] Key type ._llcrypt registered [ 1334.761345] Key type .llcrypt registered [ 1336.209559] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 15:10:55 (1777576255) [ 1338.844807] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1338.857448] alg: No test for adler32 (adler32-zlib) [ 1339.946834] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 1340.148985] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 1341.823266] Key type lgssc registered [ 1343.381638] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1396.384903] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1401.349606] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1420.691636] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1423.448467] Lustre: Mounted lustre-client [ 1433.592279] Lustre: lustre-OST0000-osc-ffff8b1402ba1000: Connection to lustre-OST0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1439.124131] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1449.424808] Lustre: Unmounted lustre-client [ 1477.847520] Key type lgssc unregistered [ 1478.178624] LNet: 32338:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1478.187523] LNetError: 32338:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1478.210293] LNet: Removed LNI 192.168.204.19@tcp [ 1478.984963] Key type .llcrypt unregistered [ 1478.991054] Key type ._llcrypt unregistered [ 1496.824445] Key type ._llcrypt registered [ 1496.827513] Key type .llcrypt registered [ 1498.237772] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 15:13:37 (1777576417) [ 1501.061522] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1501.084536] alg: No test for adler32 (adler32-zlib) [ 1502.235314] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 1502.464835] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 1504.184529] Key type lgssc registered [ 1505.510104] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1553.837955] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1558.265760] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1578.248037] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1581.130406] Lustre: Mounted lustre-client [ 1584.692925] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1588.004404] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1600.055393] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-04-3015h15m18s [ 1602.171931] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1606.628668] Lustre: lustre-MDT0000-mdc-ffff8b1419654000: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1620.234964] LustreError: 36041:0:(lmv_obd.c:1446:lmv_statfs()) lustre-MDT0000-mdc-ffff8b1419654000: can't stat MDS #0: rc = -19 [ 1622.055185] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1630.201305] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [ 1630.230204] Lustre: Evicted from MGS (at 192.168.204.119@tcp) after server handle changed from 0xab5e6cc20d32a0e2 to 0xab5e6cc20d32a3a5 [ 1630.244911] Lustre: MGC192.168.204.119@tcp: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 1631.270522] LustreError: lustre-MDT0000-mdc-ffff8b1419654000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1631.290498] Lustre: lustre-MDT0000-mdc-ffff8b1419654000: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 1637.091173] Lustre: DEBUG MARKER: Wait for df (36041) ... [ 1639.221317] Lustre: DEBUG MARKER: done [ 1641.405943] LustreError: 36655:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1419654000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1641.537144] Lustre: Unmounted lustre-client [ 1668.152402] Key type lgssc unregistered [ 1668.395296] LNet: 37058:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1668.421168] LNetError: 37058:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1668.452878] LNet: Removed LNI 192.168.204.19@tcp [ 1669.180948] Key type .llcrypt unregistered [ 1669.187362] Key type ._llcrypt unregistered [ 1702.205206] Key type ._llcrypt registered [ 1702.207747] Key type .llcrypt registered [ 1703.616557] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 15:17:02 (1777576622) [ 1705.686651] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1705.733895] alg: No test for adler32 (adler32-zlib) [ 1706.861168] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 1707.044574] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 1708.738980] Key type lgssc registered [ 1709.957310] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1760.496303] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1765.551669] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1786.567241] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1789.641471] Lustre: Mounted lustre-client [ 1794.938778] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-04-3015h18m33s [ 1796.600490] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1804.958578] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1807.985541] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1828.319342] Lustre: 41108:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777576728/real 1777576728] req@00000000d9bb670b x1863924189240064/t0(0) o101->lustre-MDT0000-mdc-ffff8b14048c5000@192.168.204.119@tcp:12/10 lens 576/1152 e 0 to 1 dl 1777576748 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1828.367455] Lustre: lustre-MDT0000-mdc-ffff8b14048c5000: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1828.419625] Lustre: lustre-MDT0000-mdc-ffff8b14048c5000: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 1849.873794] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1852.771513] Lustre: DEBUG MARKER: done [ 1856.798144] LustreError: 41591:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14048c5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1856.881995] Lustre: Unmounted lustre-client [ 1887.390806] Key type lgssc unregistered [ 1887.757230] LNet: 41995:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1887.783821] LNetError: 41995:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1887.808404] LNet: Removed LNI 192.168.204.19@tcp [ 1888.979478] Key type .llcrypt unregistered [ 1888.981479] Key type ._llcrypt unregistered [ 1925.245266] Key type ._llcrypt registered [ 1925.247525] Key type .llcrypt registered [ 1926.661768] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 15:20:45 (1777576845) [ 1928.461150] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1931.251943] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 15:20:49 (1777576849) [ 1935.631265] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1935.675639] alg: No test for adler32 (adler32-zlib) [ 1936.844922] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 1937.190102] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 1938.959671] Key type lgssc registered [ 1941.032645] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1973.616920] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 15:21:32 (1777576892) [ 2007.756602] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2014.099173] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2037.595720] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2040.524779] Lustre: Mounted lustre-client [ 2045.341195] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2050.189812] LustreError: 46343:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1410148000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2050.293983] Lustre: Unmounted lustre-client [ 2069.936883] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2121.115453] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2125.909592] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2126.789644] Lustre: Mounted lustre-client [ 2131.458953] LustreError: 47597:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14130ee800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2131.598544] Lustre: Unmounted lustre-client [ 2198.203917] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2202.993975] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2204.170748] Lustre: Mounted lustre-client [ 2208.824125] LustreError: 48712:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1413025000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2208.925977] Lustre: Unmounted lustre-client [ 2235.953392] Lustre: DEBUG MARKER: files compared the same [ 2259.631521] Key type lgssc unregistered [ 2259.906844] LNet: 49419:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2259.915357] LNetError: 49419:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2259.933158] LNet: Removed LNI 192.168.204.19@tcp [ 2260.721939] Key type .llcrypt unregistered [ 2260.728645] Key type ._llcrypt unregistered [ 2277.584644] Key type ._llcrypt registered [ 2277.588546] Key type .llcrypt registered [ 2278.923469] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 15:26:37 (1777577197) [ 2281.697128] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2281.730215] alg: No test for adler32 (adler32-zlib) [ 2282.801166] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 2283.100083] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 2284.855222] Key type lgssc registered [ 2286.296616] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2341.779804] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2346.022455] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2366.789092] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2368.660942] Lustre: Mounted lustre-client [ 2373.518490] LustreError: 52508:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b141393a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2373.588811] Lustre: Unmounted lustre-client [ 2403.760569] Key type lgssc unregistered [ 2404.259646] LNet: 52912:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2404.273107] LNetError: 52912:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2404.314473] LNet: Removed LNI 192.168.204.19@tcp [ 2405.196465] Key type .llcrypt unregistered [ 2405.198411] Key type ._llcrypt unregistered [ 2425.761676] Key type ._llcrypt registered [ 2425.766496] Key type .llcrypt registered [ 2427.741200] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 15:29:05 (1777577345) [ 2430.146656] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2430.199517] alg: No test for adler32 (adler32-zlib) [ 2431.516290] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 2431.831623] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 2433.463187] Key type lgssc registered [ 2434.582195] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2519.923989] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2553.583338] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2557.862625] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2587.201389] Key type lgssc unregistered [ 2587.459554] LNet: 56320:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2587.477215] LNetError: 56320:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2587.510866] LNet: Removed LNI 192.168.204.19@tcp [ 2588.225428] Key type .llcrypt unregistered [ 2588.229938] Key type ._llcrypt unregistered [ 2605.698796] Key type ._llcrypt registered [ 2605.708463] Key type .llcrypt registered [ 2607.045772] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 15:32:05 (1777577525) [ 2611.033875] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2611.123721] alg: No test for adler32 (adler32-zlib) [ 2612.334238] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 2612.577818] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 2614.287170] Key type lgssc registered [ 2615.773492] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2698.598630] Lustre: Mounted lustre-client [ 2705.414365] LustreError: 58809:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14044df000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2705.554526] Lustre: Unmounted lustre-client [ 2744.599328] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 15:34:23 (1777577663) [ 2872.862994] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2890.094782] Lustre: Mounted lustre-client [ 2897.500954] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2897.515794] LustreError: 62776:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8b1407870800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2897.546958] Lustre: 57307:0:(llite_lib.c:4153:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.119@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2907.873272] Lustre: Unmounted lustre-client [ 2953.657739] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 15:37:52 (1777577872) [ 2967.375329] Key type lgssc unregistered [ 2967.640336] LNet: 63992:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2967.652981] LNetError: 63992:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2967.675910] LNet: Removed LNI 192.168.204.19@tcp [ 2968.477213] Key type .llcrypt unregistered [ 2968.478837] Key type ._llcrypt unregistered [ 2981.852500] Key type ._llcrypt registered [ 2981.858278] Key type .llcrypt registered [ 2982.273498] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2982.296201] alg: No test for adler32 (adler32-zlib) [ 2983.387822] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 2983.627346] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 2985.320381] Key type lgssc registered [ 2986.463785] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3033.798242] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3037.527773] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3057.136082] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3059.886232] Lustre: Mounted lustre-client [ 3063.777698] LustreError: 66517:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1405988000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3063.905304] Lustre: Unmounted lustre-client [ 3100.430558] Key type lgssc unregistered [ 3100.750910] LNet: 66922:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3100.763849] LNetError: 66922:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3100.793821] LNet: Removed LNI 192.168.204.19@tcp [ 3101.628130] Key type .llcrypt unregistered [ 3101.634960] Key type ._llcrypt unregistered [ 3111.894796] Key type ._llcrypt registered [ 3111.897693] Key type .llcrypt registered [ 3112.319633] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3112.335616] alg: No test for adler32 (adler32-zlib) [ 3113.530987] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 3113.859143] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 3115.575222] Key type lgssc registered [ 3116.683488] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3230.107460] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3234.557641] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3254.702811] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3256.460067] Lustre: Mounted lustre-client [ 3259.374486] LustreError: 69862:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1404f97000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3259.478891] Lustre: Unmounted lustre-client [ 3286.049544] Key type lgssc unregistered [ 3286.335656] LNet: 70268:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3286.345396] LNetError: 70268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3286.359061] LNet: Removed LNI 192.168.204.19@tcp [ 3287.027258] Key type .llcrypt unregistered [ 3287.034286] Key type ._llcrypt unregistered [ 3304.578961] Key type ._llcrypt registered [ 3304.587724] Key type .llcrypt registered [ 3306.370864] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 15:43:44 (1777578224) [ 3309.526520] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3309.590158] alg: No test for adler32 (adler32-zlib) [ 3310.799969] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 3311.106842] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 3312.895306] Key type lgssc registered [ 3314.745570] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3372.485647] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3378.219571] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3401.228030] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3404.532206] Lustre: Mounted lustre-client [ 3413.968678] LustreError: 73390:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14135b3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3414.091018] Lustre: Unmounted lustre-client [ 3414.498199] Lustre: Mounted lustre-client [ 3417.451978] LustreError: 73463:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1402ba6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3417.592905] Lustre: Unmounted lustre-client [ 3458.001939] Key type lgssc unregistered [ 3458.321206] LNet: 73870:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3458.329038] LNetError: 73870:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3458.346894] LNet: Removed LNI 192.168.204.19@tcp [ 3459.071438] Key type .llcrypt unregistered [ 3459.073356] Key type ._llcrypt unregistered [ 3473.952973] Key type ._llcrypt registered [ 3473.961792] Key type .llcrypt registered [ 3474.498457] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3474.521939] alg: No test for adler32 (adler32-zlib) [ 3475.702580] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 3476.006892] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 3477.719485] Key type lgssc registered [ 3479.181864] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3532.789534] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3538.273775] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3560.329497] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3562.209409] Lustre: Mounted lustre-client [ 3570.182318] LustreError: 76427:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1402ba6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3570.276354] Lustre: Unmounted lustre-client [ 3598.693859] Key type lgssc unregistered [ 3599.045820] LNet: 76829:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3599.055623] LNetError: 76829:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3599.086228] LNet: Removed LNI 192.168.204.19@tcp [ 3600.120884] Key type .llcrypt unregistered [ 3600.124448] Key type ._llcrypt unregistered [ 3626.423671] Key type ._llcrypt registered [ 3626.430940] Key type .llcrypt registered [ 3628.602824] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 15:49:06 (1777578546) [ 3632.647756] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3632.681114] alg: No test for adler32 (adler32-zlib) [ 3634.149041] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 3634.703365] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 3636.471193] Key type lgssc registered [ 3638.412839] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3691.242433] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3696.004027] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3718.580976] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3721.322940] Lustre: Mounted lustre-client [ 3728.951708] Lustre: lustre: root_squash is set to 0:0 [ 3734.147133] Lustre: lustre: nosquash_nids is cleared [ 3741.301808] Lustre: lustre: root_squash is set to 500:500 [ 3753.081316] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.19@tcp 192.168.0.[2,10]@tcp [ 3765.300983] Lustre: lustre: nosquash_nids set to 192.168.204.19/24@tcp [ 3768.758919] LustreError: 80299:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1410148000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3768.851971] Lustre: Unmounted lustre-client [ 3794.677272] Key type lgssc unregistered [ 3795.014217] LNet: 80702:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3795.029069] LNetError: 80702:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3795.048840] LNet: Removed LNI 192.168.204.19@tcp [ 3796.131463] Key type .llcrypt unregistered [ 3796.135749] Key type ._llcrypt unregistered [ 3815.889373] Key type ._llcrypt registered [ 3815.892821] Key type .llcrypt registered [ 3817.596750] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 15:52:16 (1777578736) [ 3820.974863] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3823.248198] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 15:52:21 (1777578741) [ 3825.917604] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3825.962453] alg: No test for adler32 (adler32-zlib) [ 3827.139702] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 3827.428120] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 3829.143298] Key type lgssc registered [ 3830.362896] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3884.793520] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3889.213916] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3912.282000] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3913.892881] Lustre: lustre: root_squash is set to 500:500 [ 3913.922158] Lustre: lustre: nosquash_nids set to 192.168.204.19/24@tcp [ 3915.085889] Lustre: Mounted lustre-client [ 3925.279770] LustreError: 84175:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14130e9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3925.390298] Lustre: Unmounted lustre-client [ 3956.927434] Key type lgssc unregistered [ 3957.245311] LNet: 84578:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3957.267745] LNetError: 84578:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3957.292958] LNet: Removed LNI 192.168.204.19@tcp [ 3958.289498] Key type .llcrypt unregistered [ 3958.294081] Key type ._llcrypt unregistered [ 3976.645516] Key type ._llcrypt registered [ 3976.648555] Key type .llcrypt registered [ 3978.033230] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3979.888783] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 15:54:58 (1777578898) [ 4001.260891] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4001.367090] alg: No test for adler32 (adler32-zlib) [ 4002.722089] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 4003.071318] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 4004.863271] Key type lgssc registered [ 4006.918523] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4092.680649] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4098.187021] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4122.002787] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4198.769368] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4203.369606] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4223.931710] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4235.893637] Lustre: Mounted lustre-client [ 4273.720969] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8b141393a800.ost_server_uuid 50 [ 4275.510414] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8b141393a800.ost_server_uuid in IDLE state after 0 sec [ 4276.087107] Lustre: Mounted lustre-client [ 4280.479644] LustreError: 91484:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1418018800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4280.644701] Lustre: Unmounted lustre-client [ 4282.884357] LustreError: 91504:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b141393a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4282.901299] LustreError: 91504:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 4283.006492] Lustre: Unmounted lustre-client [ 4332.426208] Key type lgssc unregistered [ 4332.693194] LNet: 92058:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4332.706307] LNetError: 92058:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4332.728266] LNet: Removed LNI 192.168.204.19@tcp [ 4333.668104] Key type .llcrypt unregistered [ 4333.670919] Key type ._llcrypt unregistered [ 4372.265884] Key type ._llcrypt registered [ 4372.269542] Key type .llcrypt registered [ 4373.733862] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 16:01:32 (1777579292) [ 4393.675847] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4393.832801] alg: No test for adler32 (adler32-zlib) [ 4395.259952] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 4395.661505] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 4397.359190] Key type lgssc registered [ 4399.059570] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4486.533748] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4491.379638] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4514.048269] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4515.850984] Lustre: Mounted lustre-client [ 4537.247233] Lustre: 93436:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777579441/real 1777579441] req@00000000b9ee7ec1 x1863927008859264/t0(0) o400->lustre-OST0000-osc-ffff8b14030eb800@192.168.204.119@tcp:28/4 lens 224/224 e 0 to 1 dl 1777579457 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4537.292555] Lustre: lustre-OST0000-osc-ffff8b14030eb800: Connection to lustre-OST0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4541.983167] Lustre: 93436:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777579446/real 1777579446] req@00000000db4d67c8 x1863927008859776/t0(0) o400->lustre-OST0000-osc-ffff8b14030eb800@192.168.204.119@tcp:28/4 lens 224/224 e 0 to 1 dl 1777579462 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4546.528542] Lustre: 93437:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777579451/real 1777579451] req@00000000593593da x1863927008860288/t0(0) o400->lustre-OST0000-osc-ffff8b14030eb800@192.168.204.119@tcp:28/4 lens 224/224 e 0 to 1 dl 1777579467 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4547.154943] Lustre: lustre-OST0000-osc-ffff8b14030eb800: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 4551.666369] Lustre: lustre-MDT0000-mdc-ffff8b14030eb800: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4552.671247] Lustre: 93437:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777579456/real 1777579456] req@000000001e135afe x1863927008860800/t0(0) o400->lustre-OST0000-osc-ffff8b14030eb800@192.168.204.119@tcp:28/4 lens 224/224 e 0 to 1 dl 1777579472 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4567.839255] Lustre: 93437:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777579472/real 1777579472] req@00000000fb6f184d x1863927008863104/t0(0) o400->MGC192.168.204.119@tcp@192.168.204.119@tcp:26/25 lens 224/224 e 0 to 1 dl 1777579488 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4567.876411] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [ 4578.297252] Lustre: Evicted from MGS (at 192.168.204.119@tcp) after server handle changed from 0xc601c37e0a0aacc7 to 0xc601c37e0a0aae5d [ 4578.308528] Lustre: MGC192.168.204.119@tcp: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 4584.778801] Lustre: lustre-MDT0000-mdc-ffff8b14030eb800: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 4590.693349] LustreError: 97252:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14030eb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4590.784352] Lustre: Unmounted lustre-client [ 4635.149189] Key type lgssc unregistered [ 4635.523916] LNet: 97657:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4635.533245] LNetError: 97657:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4635.572680] LNet: Removed LNI 192.168.204.19@tcp [ 4636.214187] Key type .llcrypt unregistered [ 4636.217251] Key type ._llcrypt unregistered [ 4651.691321] Key type ._llcrypt registered [ 4651.694916] Key type .llcrypt registered [ 4653.690496] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 16:06:11 (1777579571) [ 4671.110570] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4671.133315] alg: No test for adler32 (adler32-zlib) [ 4672.115850] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 4672.289881] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 4673.919180] Key type lgssc registered [ 4675.069174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4711.790320] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4820.936882] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4828.626427] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4855.589938] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4858.987810] Lustre: Mounted lustre-client [ 4861.291543] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4863.481753] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 16:09:42 (1777579782) [ 5143.793472] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5154.171121] Lustre: Unmounted lustre-client [ 5291.801595] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5296.235994] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5320.426220] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5385.747821] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 16:18:24 (1777580304) [ 5483.076036] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5487.846856] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5512.969428] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5513.627374] Lustre: Mounted lustre-client [ 5519.545799] LustreError: 115862:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1403dd4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5519.656118] Lustre: Unmounted lustre-client [ 5560.982474] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 16:21:20 (1777580480) [ 5664.480450] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5669.088665] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5690.765610] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5691.357792] Lustre: Mounted lustre-client [ 5696.467353] LustreError: 119911:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1413cbc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5696.619096] Lustre: Unmounted lustre-client [ 5733.332202] Key type lgssc unregistered [ 5733.672543] LNet: 120315:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5733.684313] LNetError: 120315:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5733.706266] LNet: Removed LNI 192.168.204.19@tcp [ 5734.603934] Key type .llcrypt unregistered [ 5734.606248] Key type ._llcrypt unregistered [ 5754.164060] Key type ._llcrypt registered [ 5754.166295] Key type .llcrypt registered [ 5755.570262] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 16:24:34 (1777580674) [ 5758.628054] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5758.655464] alg: No test for adler32 (adler32-zlib) [ 5759.813582] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 5760.108112] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 5761.807716] Key type lgssc registered [ 5763.429688] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5812.823229] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5817.094955] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5840.644534] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5843.453469] Lustre: Mounted lustre-client [ 5856.888055] LustreError: 123417:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14048c0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5857.008597] Lustre: Unmounted lustre-client [ 5888.570563] Key type lgssc unregistered [ 5888.872972] LNet: 123820:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5888.883118] LNetError: 123820:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5888.897199] LNet: Removed LNI 192.168.204.19@tcp [ 5889.694179] Key type .llcrypt unregistered [ 5889.710338] Key type ._llcrypt unregistered [ 5906.664954] Key type ._llcrypt registered [ 5906.668760] Key type .llcrypt registered [ 5908.405503] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 16:27:06 (1777580826) [ 5911.063038] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5911.077823] alg: No test for adler32 (adler32-zlib) [ 5912.155735] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 5912.357324] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 5914.015151] Key type lgssc registered [ 5915.455506] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5966.657187] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5971.279931] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5994.347629] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5997.126756] Lustre: Mounted lustre-client [ 6002.197330] Lustre: lustre-OST0000-osc-ffff8b1413026000: Connection to lustre-OST0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6022.435501] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8b1413026000.ost_server_uuid 50 [ 6024.757761] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6036.778578] LustreError: 127353:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1413026000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6036.878256] Lustre: Unmounted lustre-client [ 6062.410298] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 16:29:41 (1777580981) [ 6105.413885] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6111.338678] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6138.154953] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6165.363889] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6166.437987] Lustre: Mounted lustre-client [ 6171.626830] Lustre: lustre-OST0000-osc-ffff8b1412405800: Connection to lustre-OST0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6198.770357] LustreError: 130010:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1412405800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6198.894712] Lustre: Unmounted lustre-client [ 6252.611216] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 16:32:51 (1777581171) [ 6287.141270] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6291.054757] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6311.278859] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6332.671354] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6333.664600] Lustre: Mounted lustre-client [ 6339.067834] Lustre: lustre-OST0000-osc-ffff8b1410148000: Connection to lustre-OST0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6356.685964] LustreError: 132770:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1410148000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6356.697882] LustreError: 132770:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 6356.862072] Lustre: Unmounted lustre-client [ 6410.883534] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 16:35:29 (1777581329) [ 6521.075759] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6526.139089] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6552.902499] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6633.965457] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6638.446942] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6662.404511] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6696.482413] Lustre: Mounted lustre-client [ 6741.130271] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6744.272455] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 6747.199820] LustreError: 139390:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1412405000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6747.232924] LustreError: 139390:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 6747.336931] Lustre: Unmounted lustre-client [ 6781.673313] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 16:41:40 (1777581700) [ 6818.296539] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6822.488734] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6845.386524] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6882.165219] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6926.614263] Lustre: Mounted lustre-client [ 6970.915651] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6973.535506] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6987.201855] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6997.586498] Lustre: Unmounted lustre-client [ 7060.263387] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 16:46:19 (1777581979) [ 7091.481386] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7096.286417] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7118.008846] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7118.706074] Lustre: Mounted lustre-client [ 7139.155387] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7141.333828] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7160.360793] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8b141014b800.ost_server_uuid 50 [ 7162.407453] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8b141014b800.ost_server_uuid in IDLE state after 0 sec [ 7166.065446] LustreError: 146403:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b141014b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7166.193179] Lustre: Unmounted lustre-client [ 7166.549960] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7166.561161] Lustre: Skipped 3 previous similar messages [ 7166.667819] Lustre: Mounted lustre-client [ 7167.809036] LustreError: 146457:0:(sec.c:413:import_sec_validate_get()) import 000000006573da58 (NEW) with no sec [ 7234.805875] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 16:49:13 (1777582153) [ 7267.654433] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7272.545737] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7291.835383] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7312.795675] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7313.557706] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7313.739616] Lustre: Mounted lustre-client [ 7328.319363] LustreError: 149314:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14052c2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7328.330563] LustreError: 149314:0:(lov_obd.c:792:lov_cleanup()) Skipped 2 previous similar messages [ 7328.457349] Lustre: Unmounted lustre-client [ 7328.459342] Lustre: Skipped 1 previous similar message [ 7361.192279] Key type lgssc unregistered [ 7361.544984] LNet: 149762:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7361.551601] LNetError: 149762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7361.577487] LNet: Removed LNI 192.168.204.19@tcp [ 7362.214303] Key type .llcrypt unregistered [ 7362.216661] Key type ._llcrypt unregistered [ 7377.116497] Key type ._llcrypt registered [ 7377.119448] Key type .llcrypt registered [ 7378.307534] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 16:51:37 (1777582297) [ 7379.281747] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7379.292938] alg: No test for adler32 (adler32-zlib) [ 7380.397682] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 7380.654378] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 7382.343198] Key type lgssc registered [ 7383.500319] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7434.788412] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7439.101212] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7459.497959] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7481.008053] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7482.804291] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7484.003346] Lustre: Mounted lustre-client [ 7487.179957] LustreError: lustre-MDT0001-mdc-ffff8b1405919000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7487.201858] Lustre: lustre-MDT0001-mdc-ffff8b1405919000: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 7492.951672] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7495.064122] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7518.756345] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7522.279658] LustreError: 153981:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1405919000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7522.414844] Lustre: Unmounted lustre-client [ 7552.733360] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 16:54:31 (1777582471) [ 7654.754822] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7659.436863] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7683.470639] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7684.106131] Lustre: Mounted lustre-client [ 7711.798803] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7714.126326] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7726.587846] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7736.948634] Lustre: Unmounted lustre-client [ 7789.739464] Key type lgssc unregistered [ 7790.021476] LNet: 159125:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7790.041844] LNetError: 159125:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7790.087991] LNet: Removed LNI 192.168.204.19@tcp [ 7790.835938] Key type .llcrypt unregistered [ 7790.842973] Key type ._llcrypt unregistered [ 7828.546284] Key type ._llcrypt registered [ 7828.547850] Key type .llcrypt registered [ 7830.264569] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 16:59:08 (1777582748) [ 7832.984623] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7833.111805] alg: No test for adler32 (adler32-zlib) [ 7834.204801] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 7834.585368] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 7836.367208] Key type lgssc registered [ 7838.303576] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7884.799631] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7888.839563] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7908.620319] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7911.290737] Lustre: Mounted lustre-client [ 7962.392769] LustreError: 162406:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14030ed000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7962.536967] Lustre: Unmounted lustre-client [ 8000.673077] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8001.476027] Lustre: Mounted lustre-client [ 8038.011373] LustreError: 163067:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14048c1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8038.115390] Lustre: Unmounted lustre-client [ 8068.112373] Key type lgssc unregistered [ 8068.528524] LNet: 163475:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8068.536710] LNetError: 163475:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8068.562026] LNet: Removed LNI 192.168.204.19@tcp [ 8069.473151] Key type .llcrypt unregistered [ 8069.476181] Key type ._llcrypt unregistered [ 8089.848212] Key type ._llcrypt registered [ 8089.852846] Key type .llcrypt registered [ 8092.120426] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 17:03:30 (1777583010) [ 8095.345459] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8095.379297] alg: No test for adler32 (adler32-zlib) [ 8096.629756] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 8096.923596] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 8098.687521] Key type lgssc registered [ 8100.445612] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8151.334057] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8154.874586] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8178.089141] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8180.990607] Lustre: Mounted lustre-client [ 8198.412165] LustreError: 166736:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1407bba000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8198.486883] Lustre: Unmounted lustre-client [ 8228.642089] Key type lgssc unregistered [ 8229.104156] LNet: 167141:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8229.110149] LNetError: 167141:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8229.151366] LNet: Removed LNI 192.168.204.19@tcp [ 8230.215978] Key type .llcrypt unregistered [ 8230.217968] Key type ._llcrypt unregistered [ 8245.084737] Key type ._llcrypt registered [ 8245.086590] Key type .llcrypt registered [ 8245.613429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8245.629825] alg: No test for adler32 (adler32-zlib) [ 8246.796981] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 8247.126680] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 8248.831475] Key type lgssc registered [ 8250.431424] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8310.581698] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8314.882431] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8334.938099] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8336.697173] Lustre: Mounted lustre-client [ 8344.677196] LustreError: 169721:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b141841a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8344.821436] Lustre: Unmounted lustre-client [ 8372.917587] Key type lgssc unregistered [ 8373.210806] LNet: 170124:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8373.230230] LNetError: 170124:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8373.260215] LNet: Removed LNI 192.168.204.19@tcp [ 8374.063563] Key type .llcrypt unregistered [ 8374.071072] Key type ._llcrypt unregistered [ 8391.396235] Key type ._llcrypt registered [ 8391.404981] Key type .llcrypt registered [ 8393.140735] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 17:08:31 (1777583311) [ 8395.817231] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8395.837797] alg: No test for adler32 (adler32-zlib) [ 8397.013919] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 8397.309226] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 8399.067482] Key type lgssc registered [ 8400.258440] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8452.239847] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8456.106877] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8475.385936] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8478.134444] Lustre: Mounted lustre-client [ 8497.107085] LustreError: 173387:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14048c1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8497.198159] Lustre: Unmounted lustre-client [ 8534.726714] Key type lgssc unregistered [ 8534.942162] LNet: 173793:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8534.947165] LNetError: 173793:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8534.981201] LNet: Removed LNI 192.168.204.19@tcp [ 8535.864172] Key type .llcrypt unregistered [ 8535.867917] Key type ._llcrypt unregistered [ 8548.079231] Key type ._llcrypt registered [ 8548.085682] Key type .llcrypt registered [ 8548.737402] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8548.751281] alg: No test for adler32 (adler32-zlib) [ 8549.947262] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 8550.192793] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 8551.919555] Key type lgssc registered [ 8553.801424] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8603.016509] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8606.628683] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8627.331184] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8629.248447] Lustre: Mounted lustre-client [ 8637.529729] LustreError: 176365:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1402f68000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8637.658743] Lustre: Unmounted lustre-client [ 8673.884285] Key type lgssc unregistered [ 8674.123284] LNet: 176770:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8674.128208] LNetError: 176770:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8674.141696] LNet: Removed LNI 192.168.204.19@tcp [ 8674.664333] Key type .llcrypt unregistered [ 8674.666531] Key type ._llcrypt unregistered [ 8690.984674] Key type ._llcrypt registered [ 8690.988105] Key type .llcrypt registered [ 8692.381569] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 17:13:31 (1777583611) [ 8721.316421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8721.334408] alg: No test for adler32 (adler32-zlib) [ 8722.470043] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 8722.747676] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 8724.463230] Key type lgssc registered [ 8726.241803] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8817.378528] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8822.091416] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8847.511277] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8897.116711] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 17:16:56 (1777583816) [ 8928.648753] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8932.187218] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8950.694324] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8953.774134] Lustre: Mounted lustre-client [ 8959.099560] LustreError: 183286:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1410bb4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8959.288183] Lustre: Unmounted lustre-client [ 8991.023788] Key type lgssc unregistered [ 8991.304185] LNet: 183691:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8991.319306] LNetError: 183691:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8991.357668] LNet: Removed LNI 192.168.204.19@tcp [ 8992.358432] Key type .llcrypt unregistered [ 8992.360132] Key type ._llcrypt unregistered [ 9008.468612] Key type ._llcrypt registered [ 9008.470150] Key type .llcrypt registered [ 9009.848820] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9011.536596] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 17:18:50 (1777583930) [ 9029.863592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9029.935615] alg: No test for adler32 (adler32-zlib) [ 9031.079600] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 9031.369977] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 9033.135961] Key type lgssc registered [ 9034.357608] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9149.023660] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9154.371754] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9177.802980] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 9196.979716] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 9198.933765] Lustre: Mounted lustre-client [ 9220.308866] LustreError: 189235:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1403625000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 9220.466207] Lustre: Unmounted lustre-client [ 9350.939321] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9355.490585] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9378.270951] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9433.366970] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 17:25:52 (1777584352) [ 9435.805586] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9438.219807] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 17:25:56 (1777584356) [ 9497.560819] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9505.317643] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9554.044126] Key type lgssc unregistered [ 9554.417218] LNet: 195424:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9554.428727] LNetError: 195424:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9554.479194] LNet: Removed LNI 192.168.204.19@tcp [ 9555.467742] Key type .llcrypt unregistered [ 9555.470956] Key type ._llcrypt unregistered [ 9576.480116] Key type ._llcrypt registered [ 9576.484805] Key type .llcrypt registered [ 9578.388793] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 17:28:16 (1777584496) [ 9642.935840] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9642.953029] alg: No test for adler32 (adler32-zlib) [ 9644.244642] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 9644.559828] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 9646.239294] Key type lgssc registered [ 9647.682357] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9695.832182] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9700.321565] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9733.922289] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9771.507688] Key type lgssc unregistered [ 9771.913596] LNet: 199074:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9771.926851] LNetError: 199074:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9771.961901] LNet: Removed LNI 192.168.204.19@tcp [ 9772.718498] Key type .llcrypt unregistered [ 9772.722235] Key type ._llcrypt unregistered [ 9788.671735] Key type ._llcrypt registered [ 9788.678454] Key type .llcrypt registered [ 9790.350373] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 17:31:48 (1777584708) [ 9792.757593] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9792.788481] alg: No test for adler32 (adler32-zlib) [ 9794.039977] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [ 9794.334351] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [ 9796.095127] Key type lgssc registered [ 9797.487033] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9850.321491] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9854.601343] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9880.802303] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9883.803525] Lustre: Mounted lustre-client [ 9898.988662] Lustre: lustre-MDT0000-mdc-ffff8b141393d800: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9909.245860] Lustre: lustre-MDT0001-mdc-ffff8b141393d800: Connection to lustre-MDT0001 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9920.289786] Lustre: 200065:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777584824/real 1777584824] req@00000000bcf91f54 x1863932669149824/t0(0) o400->MGC192.168.204.119@tcp@192.168.204.119@tcp:26/25 lens 224/224 e 0 to 1 dl 1777584840 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9920.330117] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [ 9944.877276] Lustre: Evicted from MGS (at 192.168.204.119@tcp) after server handle changed from 0xfe5a0b9c2fb7d6e9 to 0xfe5a0b9c2fb7f3ad [ 9944.899687] Lustre: MGC192.168.204.119@tcp: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 9960.448366] LustreError: lustre-MDT0000-mdc-ffff8b141393d800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9960.484882] Lustre: lustre-MDT0000-mdc-ffff8b141393d800: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [ 9964.409770] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9966.167501] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9971.265099] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9973.202333] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9978.269728] LustreError: 203487:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b141393d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9978.396898] Lustre: Unmounted lustre-client [10017.861725] Key type lgssc unregistered [10018.171477] LNet: 203891:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10018.189246] LNetError: 203891:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10018.217651] LNet: Removed LNI 192.168.204.19@tcp [10019.045235] Key type .llcrypt unregistered [10019.048648] Key type ._llcrypt unregistered [10038.716411] Key type ._llcrypt registered [10038.719357] Key type .llcrypt registered [10040.341905] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 17:35:58 (1777584958) [10043.365195] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10043.416283] alg: No test for adler32 (adler32-zlib) [10044.744267] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [10045.107148] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [10046.881412] Key type lgssc registered [10048.541584] Lustre: Echo OBD driver; http://www.lustre.org/ [10105.763734] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10110.533175] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10170.150051] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10174.976858] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10214.766119] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10239.175265] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [10297.690698] Key type lgssc unregistered [10298.075782] LNet: 209017:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10298.092958] LNetError: 209017:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10298.114375] LNet: Removed LNI 192.168.204.19@tcp [10299.141779] Key type .llcrypt unregistered [10299.143554] Key type ._llcrypt unregistered [10348.349806] Key type ._llcrypt registered [10348.357334] Key type .llcrypt registered [10350.230693] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 17:41:08 (1777585268) [10397.485643] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10397.598759] alg: No test for adler32 (adler32-zlib) [10398.966866] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [10399.296562] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [10401.063179] Key type lgssc registered [10402.604504] Lustre: Echo OBD driver; http://www.lustre.org/ [10500.307058] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10504.981494] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10530.575786] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10579.569906] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 17:44:58 (1777585498) [10588.638150] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 17:45:07 (1777585507) [10627.098704] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10630.869289] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10652.367497] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10654.094407] Lustre: Mounted lustre-client [10659.847886] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10662.619971] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10664.590199] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10667.272894] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10674.672628] Lustre: lustre-MDT0000-mdc-ffff8b1418418800: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [10691.039212] Lustre: 210914:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777585595/real 1777585595] req@0000000034616155 x1863933303465728/t0(0) o400->MGC192.168.204.119@tcp@192.168.204.119@tcp:26/25 lens 224/224 e 0 to 1 dl 1777585611 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10691.074415] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [10691.115524] Lustre: Evicted from MGS (at 192.168.204.119@tcp) after server handle changed from 0x783ae1b44456203a to 0x783ae1b4445621ad [10691.140049] Lustre: MGC192.168.204.119@tcp: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [10702.646289] Lustre: lustre-MDT0000-mdc-ffff8b1418418800: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [10710.659911] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10712.956109] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10716.874563] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10719.726798] Lustre: lustre-MDT0000-mdc-ffff8b1418418800: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [10736.095147] Lustre: 210914:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777585640/real 1777585640] req@00000000cc03bf35 x1863933303474688/t0(0) o400->MGC192.168.204.119@tcp@192.168.204.119@tcp:26/25 lens 224/224 e 0 to 1 dl 1777585656 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10736.121089] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [10746.359517] Lustre: Evicted from MGS (at 192.168.204.119@tcp) after server handle changed from 0x783ae1b4445621ad to 0x783ae1b4445624bd [10746.386416] Lustre: MGC192.168.204.119@tcp: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [10755.383133] Lustre: lustre-MDT0000-mdc-ffff8b1418418800: Connection restored to 192.168.204.119@tcp (at 192.168.204.119@tcp) [10763.969796] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10766.410443] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10771.064740] LustreError: 219180:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1418418800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10771.224963] Lustre: Unmounted lustre-client [10844.851896] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10848.868592] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10870.048374] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10870.781101] Lustre: Mounted lustre-client [10873.090428] LustreError: 220794:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14036e2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10873.226475] Lustre: Unmounted lustre-client [10904.261563] Key type lgssc unregistered [10904.612953] LNet: 221198:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10904.625712] LNetError: 221198:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10904.680727] LNet: Removed LNI 192.168.204.19@tcp [10905.485165] Key type .llcrypt unregistered [10905.488760] Key type ._llcrypt unregistered [10924.292487] Key type ._llcrypt registered [10924.296561] Key type .llcrypt registered [10925.722277] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 17:50:44 (1777585844) [10931.021597] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10931.080649] alg: No test for adler32 (adler32-zlib) [10932.265101] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [10932.540091] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [10934.248176] Key type lgssc registered [10935.773323] Lustre: Echo OBD driver; http://www.lustre.org/ [10992.894891] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10997.426760] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11018.793785] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11021.394068] Lustre: Mounted lustre-client [11027.936850] LustreError: 224373:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1402f6c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11028.053712] Lustre: Unmounted lustre-client [11088.458228] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11091.882479] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11108.215792] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11114.065356] Lustre: Mounted lustre-client [11123.090620] LustreError: 225964:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14047b4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11123.167927] Lustre: Unmounted lustre-client [11184.674329] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11188.270478] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11205.812346] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11211.830122] Lustre: Mounted lustre-client [11213.455217] LustreError: 227574:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1412403800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11213.569195] Lustre: Unmounted lustre-client [11237.954934] Key type lgssc unregistered [11238.163968] LNet: 227977:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11238.169274] LNetError: 227977:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11238.186569] LNet: Removed LNI 192.168.204.19@tcp [11238.749529] Key type .llcrypt unregistered [11238.751835] Key type ._llcrypt unregistered [11251.046563] Key type ._llcrypt registered [11251.048234] Key type .llcrypt registered [11252.134861] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 17:56:11 (1777586171) [11254.934190] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11254.981185] alg: No test for adler32 (adler32-zlib) [11256.042503] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [11256.297136] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [11257.975217] Key type lgssc registered [11259.012728] Lustre: Echo OBD driver; http://www.lustre.org/ [11294.919714] Key type lgssc unregistered [11295.093654] LNet: 230297:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11295.101561] LNetError: 230297:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11295.112637] LNet: Removed LNI 192.168.204.19@tcp [11295.623264] Key type .llcrypt unregistered [11295.627218] Key type ._llcrypt unregistered [11315.968604] Key type ._llcrypt registered [11315.988245] Key type .llcrypt registered [11316.293868] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11316.315128] alg: No test for adler32 (adler32-zlib) [11317.298495] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [11317.505224] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [11319.175224] Key type lgssc registered [11320.181720] Lustre: Echo OBD driver; http://www.lustre.org/ [11380.791677] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11383.594958] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11399.380666] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11440.814563] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11442.113435] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 17:59:21 (1777586361) [11463.695317] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11465.965061] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11478.670473] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11493.912835] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [11495.381272] Lustre: Mounted lustre-client [11500.522678] Lustre: lustre-OST0001-osc-ffff8b1413f77000: Connection to lustre-OST0001 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [11505.686483] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11516.004757] Lustre: Unmounted lustre-client [11545.226953] Key type lgssc unregistered [11545.426763] LNet: 237200:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11545.437438] LNetError: 237200:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11545.459827] LNet: Removed LNI 192.168.204.19@tcp [11545.916309] Key type .llcrypt unregistered [11545.919655] Key type ._llcrypt unregistered [11567.630684] Key type ._llcrypt registered [11567.632456] Key type .llcrypt registered [11568.648894] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 18:01:28 (1777586488) [11577.497136] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11577.564040] alg: No test for adler32 (adler32-zlib) [11578.562778] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [11578.747819] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [11580.399194] Key type lgssc registered [11581.289716] Lustre: Echo OBD driver; http://www.lustre.org/ [11614.161082] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11616.725581] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11633.337919] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 18:02:32 (1777586552) [11651.501614] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11653.643474] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11664.512491] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11672.085778] Lustre: Mounted lustre-client [11679.119643] LustreError: 242186:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1413f72800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11679.169306] Lustre: Unmounted lustre-client [11743.026853] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11744.626525] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11776.717069] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11787.265247] Lustre: Mounted lustre-client [11787.957115] LustreError: 244230:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1402ba0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11788.006466] Lustre: Unmounted lustre-client [11807.031952] Key type lgssc unregistered [11807.156669] LNet: 244633:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11807.163330] LNetError: 244633:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11807.172512] LNet: Removed LNI 192.168.204.19@tcp [11807.486193] Key type .llcrypt unregistered [11807.487855] Key type ._llcrypt unregistered [11819.713365] Key type ._llcrypt registered [11819.716561] Key type .llcrypt registered [11819.912828] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11819.921089] alg: No test for adler32 (adler32-zlib) [11820.817847] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [11820.917063] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [11822.519257] Key type lgssc registered [11823.046908] Lustre: Echo OBD driver; http://www.lustre.org/ [11858.735176] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11860.616535] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11871.050435] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11896.704240] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11897.475157] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 18:06:57 (1777586817) [11910.898252] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11912.493058] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11920.494391] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11927.037054] Lustre: Mounted lustre-client [11927.999067] LustreError: 250661:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1404f97000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11928.043368] Lustre: Unmounted lustre-client [11947.063116] Key type lgssc unregistered [11947.206881] LNet: 251063:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11947.210844] LNetError: 251063:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11947.221362] LNet: Removed LNI 192.168.204.19@tcp [11947.524094] Key type .llcrypt unregistered [11947.525358] Key type ._llcrypt unregistered [11954.293990] Key type ._llcrypt registered [11954.295727] Key type .llcrypt registered [11954.948619] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11955.795672] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 18:07:55 (1777586875) [11960.096252] Key type .llcrypt unregistered [11960.098946] Key type ._llcrypt unregistered [11963.565208] Key type ._llcrypt registered [11963.567153] Key type .llcrypt registered [11963.764701] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11963.775182] alg: No test for adler32 (adler32-zlib) [11964.662282] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [11964.761896] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [11966.359310] Key type lgssc registered [11966.883222] Lustre: Echo OBD driver; http://www.lustre.org/ [11988.482354] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11999.752819] Lustre: Mounted lustre-client [12000.572763] LustreError: 254074:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b14048c0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12000.618279] Lustre: Unmounted lustre-client [12019.690397] Key type lgssc unregistered [12019.830593] LNet: 254477:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12019.835502] LNetError: 254477:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12019.845661] LNet: Removed LNI 192.168.204.19@tcp [12020.127298] Key type .llcrypt unregistered [12020.129081] Key type ._llcrypt unregistered [12026.319192] Key type ._llcrypt registered [12026.320435] Key type .llcrypt registered [12026.879310] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 18:09:06 (1777586946) [12027.846857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12027.856995] alg: No test for adler32 (adler32-zlib) [12028.748746] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [12028.853465] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [12030.447204] Key type lgssc registered [12030.893087] Lustre: Echo OBD driver; http://www.lustre.org/ [12092.776458] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12104.908993] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12106.449436] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12107.652250] Lustre: Mounted lustre-client [12108.244554] LustreError: 257513:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1404e95000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12108.279367] Lustre: Unmounted lustre-client [12126.696927] Key type lgssc unregistered [12126.848820] LNet: 257915:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12126.851742] LNetError: 257915:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12126.860700] LNet: Removed LNI 192.168.204.19@tcp [12127.147929] Key type .llcrypt unregistered [12127.149868] Key type ._llcrypt unregistered [12133.484433] Key type ._llcrypt registered [12133.485639] Key type .llcrypt registered [12134.056327] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 18:10:53 (1777587053) [12134.951817] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12134.987093] alg: No test for adler32 (adler32-zlib) [12135.867536] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [12135.975994] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [12137.575204] Key type lgssc registered [12138.089275] Lustre: Echo OBD driver; http://www.lustre.org/ [12160.627288] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12162.158656] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12169.726758] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12176.380640] Lustre: Mounted lustre-client [12181.482205] Lustre: lustre-MDT0000-mdc-ffff8b1404e96800: Connection to lustre-MDT0000 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [12184.309592] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12184.321334] LustreError: 260974:0:(file.c:6097:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12184.463537] LustreError: 260993:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1404e96800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12184.471236] LustreError: MGC192.168.204.119@tcp: Connection to MGS (at 192.168.204.119@tcp) was lost; in progress operations using this service will fail [12184.508459] Lustre: Unmounted lustre-client [12197.329267] Key type lgssc unregistered [12197.470954] LNet: 261387:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12197.475143] LNetError: 261387:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12197.484556] LNet: Removed LNI 192.168.204.19@tcp [12197.778355] Key type .llcrypt unregistered [12197.780081] Key type ._llcrypt unregistered [12204.640594] Key type ._llcrypt registered [12204.642555] Key type .llcrypt registered [12205.381461] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 18:12:05 (1777587125) [12206.259994] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12206.325991] alg: No test for adler32 (adler32-zlib) [12207.225957] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [12207.329650] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [12208.951665] Key type lgssc registered [12209.542337] Lustre: Echo OBD driver; http://www.lustre.org/ [12233.351391] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12235.000695] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12244.338545] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12251.152269] Lustre: Mounted lustre-client [12256.227364] Lustre: lustre-MDT0001-mdc-ffff8b1405a31000: Connection to lustre-MDT0001 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [12259.163560] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12259.714085] LustreError: 264475:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1405a31000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12259.748841] Lustre: Unmounted lustre-client [12271.386266] Key type lgssc unregistered [12271.521687] LNet: 264868:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12271.526792] LNetError: 264868:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12271.541214] LNet: Removed LNI 192.168.204.19@tcp [12271.822378] Key type .llcrypt unregistered [12271.824991] Key type ._llcrypt unregistered [12278.073652] Key type ._llcrypt registered [12278.075289] Key type .llcrypt registered [12278.688411] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 18:13:18 (1777587198) [12285.717614] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12285.731547] alg: No test for adler32 (adler32-zlib) [12286.604695] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [12286.708726] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [12288.319154] Key type lgssc registered [12288.724371] Lustre: Echo OBD driver; http://www.lustre.org/ [12336.530867] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12337.791640] Lustre: Mounted lustre-client [12357.095212] Lustre: lustre-MDT0001-mdc-ffff8b1413027000: Connection to lustre-MDT0001 (at 192.168.204.119@tcp) was lost; in progress operations using this service will wait for recovery to complete [12362.596708] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12372.867791] Lustre: Unmounted lustre-client [12392.123144] Key type lgssc unregistered [12392.290844] LNet: 270605:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12392.296696] LNetError: 270605:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12392.310697] LNet: Removed LNI 192.168.204.19@tcp [12392.701978] Key type .llcrypt unregistered [12392.703718] Key type ._llcrypt unregistered [12399.951425] Key type ._llcrypt registered [12399.953209] Key type .llcrypt registered [12400.680629] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 18:15:20 (1777587320) [12401.498732] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12402.331227] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 18:15:22 (1777587322) [12403.157733] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12403.925634] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 18:15:23 (1777587323) [12404.653193] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12405.416403] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 18:15:25 (1777587325) [12406.145739] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12406.922117] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 18:15:26 (1777587326) [12407.724157] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12408.568716] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 18:15:28 (1777587328) [12412.844593] Key type .llcrypt unregistered [12412.846461] Key type ._llcrypt unregistered [12415.823441] Key type ._llcrypt registered [12415.825445] Key type .llcrypt registered [12416.033834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12416.041983] alg: No test for adler32 (adler32-zlib) [12416.968400] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [12417.098549] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [12418.711163] Key type lgssc registered [12419.403616] Lustre: Echo OBD driver; http://www.lustre.org/ [12456.209406] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12458.031377] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12468.011147] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12474.340467] Lustre: Mounted lustre-client [12475.138174] LustreError: 276187:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1402ba4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12475.186176] Lustre: Unmounted lustre-client [12500.014602] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 18:16:59 (1777587419) [12512.804249] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12514.219228] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12535.360056] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12551.160548] Lustre: Mounted lustre-client [12551.601874] LustreError: 278293:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1412755000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12551.636612] Lustre: Unmounted lustre-client [12590.176303] LNet: 1 local NIs in recovery (showing 1): 192.168.204.19@tcp [12592.140985] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 18:18:31 (1777587511) [13214.863279] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13218.246823] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13251.635151] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13335.439958] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 18:30:54 (1777588254) [13343.909333] Key type lgssc unregistered [13344.146902] LNet: 283840:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13344.160843] LNetError: 283840:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13344.190520] LNet: Removed LNI 192.168.204.19@tcp [13344.723349] Key type .llcrypt unregistered [13344.728912] Key type ._llcrypt unregistered [13459.752399] Key type ._llcrypt registered [13459.758798] Key type .llcrypt registered [13460.198536] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13460.235353] alg: No test for adler32 (adler32-zlib) [13461.297512] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [13461.469227] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [13463.135235] Key type lgssc registered [13464.332786] Lustre: Echo OBD driver; http://www.lustre.org/ [13541.749981] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13544.514264] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13562.786296] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13599.031896] Key type lgssc unregistered [13599.258922] LNet: 287441:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13599.269861] LNetError: 287441:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13599.289647] LNet: Removed LNI 192.168.204.19@tcp [13599.811707] Key type .llcrypt unregistered [13599.820305] Key type ._llcrypt unregistered [13634.056702] Key type ._llcrypt registered [13634.059220] Key type .llcrypt registered [13635.240821] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 18:35:54 (1777588554) [13653.142318] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13653.160961] alg: No test for adler32 (adler32-zlib) [13654.169543] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [13654.380697] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [13656.039922] Key type lgssc registered [13657.131709] Lustre: Echo OBD driver; http://www.lustre.org/ [13699.454276] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 18:36:58 (1777588618) [13710.435182] Key type lgssc unregistered [13710.703940] LNet: 290995:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13710.716603] LNetError: 290995:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13710.738151] LNet: Removed LNI 192.168.204.19@tcp [13711.332366] Key type .llcrypt unregistered [13711.335686] Key type ._llcrypt unregistered [13721.853823] Key type ._llcrypt registered [13721.860586] Key type .llcrypt registered [13722.298717] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13722.311235] alg: No test for adler32 (adler32-zlib) [13723.442344] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [13723.724878] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [13725.447484] Key type lgssc registered [13726.659695] Lustre: Echo OBD driver; http://www.lustre.org/ [13773.239434] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13776.753900] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13794.893813] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14017.928377] LNet: Added LNI 192.168.204.19@tcp50 [8/256/0/180] [14019.838730] LNet: Removed LNI 192.168.204.19@tcp [14021.666289] Lustre: 295296:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8b1412755000: config has no valid NIDs, force dynamic NIDs [14022.865219] Lustre: Mounted lustre-client [14022.943578] LustreError: 295305:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1412755000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14023.039269] Lustre: Unmounted lustre-client [14025.225714] Key type lgssc unregistered [14025.484597] LNet: 295555:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14025.490322] LNetError: 295555:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14025.500927] LNet: Removed LNI 192.168.204.19@tcp50 [14025.938801] Key type .llcrypt unregistered [14025.941123] Key type ._llcrypt unregistered [14034.707974] Key type ._llcrypt registered [14034.714985] Key type .llcrypt registered [14035.093981] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14035.107949] alg: No test for adler32 (adler32-zlib) [14036.107941] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [14036.338824] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [14038.048404] Key type lgssc registered [14039.022488] Lustre: Echo OBD driver; http://www.lustre.org/ [14074.549394] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14077.568679] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14083.210950] LNet: Added LNI 192.168.204.19@tcp50 [8/256/0/180] [14083.868482] LNet: Removed LNI 192.168.204.19@tcp [14085.094385] Lustre: 298184:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8b1404f92800: config has no valid NIDs, force dynamic NIDs [14086.261359] Lustre: Mounted lustre-client [14086.609965] LustreError: 298214:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1404f92800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14086.695694] Lustre: Unmounted lustre-client [14114.206267] Key type lgssc unregistered [14114.468818] LNet: 299051:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14114.475541] LNetError: 299051:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14114.496770] LNet: Removed LNI 192.168.204.19@tcp50 [14114.910374] Key type .llcrypt unregistered [14114.912520] Key type ._llcrypt unregistered [14122.982469] Key type ._llcrypt registered [14122.984902] Key type .llcrypt registered [14124.099475] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 18:44:03 (1777589043) [14137.461648] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14137.475066] alg: No test for adler32 (adler32-zlib) [14138.459970] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [14138.671956] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [14140.343372] Key type lgssc registered [14141.301053] Lustre: Echo OBD driver; http://www.lustre.org/ [14199.752651] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14202.264925] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14215.764102] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14240.304188] Key type lgssc unregistered [14240.466762] LNet: 303704:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14240.471033] LNetError: 303704:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14240.485121] LNet: Removed LNI 192.168.204.19@tcp [14240.930561] Key type .llcrypt unregistered [14240.933377] Key type ._llcrypt unregistered [14247.622314] Key type ._llcrypt registered [14247.624349] Key type .llcrypt registered [14248.496368] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 18:46:08 (1777589168) [14249.903637] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14249.920591] alg: No test for adler32 (adler32-zlib) [14250.900409] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [14251.050472] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [14252.696750] Key type lgssc registered [14253.657359] Lustre: Echo OBD driver; http://www.lustre.org/ [14283.750203] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14286.187351] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14298.402318] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14300.790803] Lustre: Mounted lustre-client [14340.612301] Lustre: Mounted fs15246-client [14349.431077] LustreError: 307838:0:(lov_obd.c:792:lov_cleanup()) fs15246-clilov-ffff8b1404e92800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14349.467789] Lustre: Unmounted fs15246-client [14367.722196] LustreError: 308056:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8b1413cb8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14367.788681] Lustre: Unmounted lustre-client [14388.865301] Key type lgssc unregistered [14389.059856] LNet: 308458:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14389.065814] LNetError: 308458:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14389.080660] LNet: Removed LNI 192.168.204.19@tcp [14389.492421] Key type .llcrypt unregistered [14389.494529] Key type ._llcrypt unregistered [14395.802879] Key type ._llcrypt registered [14395.805527] Key type .llcrypt registered [14396.794753] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 18:48:36 (1777589316) [14398.027891] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14398.038563] alg: No test for adler32 (adler32-zlib) [14399.023645] Lustre: Lustre: Build Version: 2.17.52_53_gcd13cf3 [14399.169450] LNet: Added LNI 192.168.204.19@tcp [8/256/0/180] [14400.791273] Key type lgssc registered [14401.609544] Lustre: Echo OBD driver; http://www.lustre.org/ [14484.788877] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14487.262498] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14499.789774] Lustre: DEBUG MARKER: oleg419-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14559.335947] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14223 sec ========= 18:51:19 (1777589479) [14560.153095] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 18:51:19 (1777589479) === [14561.907523] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 18:51:21 (1777589481) === [14580.050548] Key type lgssc unregistered [14580.239032] LNet: 317615:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14580.245124] LNetError: 317615:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14580.252848] LNet: Removed LNI 192.168.204.19@tcp [14580.591530] Key type .llcrypt unregistered [14580.594667] Key type ._llcrypt unregistered