[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-10.fc44 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 564704191 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.980 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002322] x2apic enabled [ 0.003006] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22982479f67, max_idle_ns: 440795221274 ns [ 0.007035] Calibrating delay loop (skipped) preset value.. 4799.96 BogoMIPS (lpj=2399980) [ 0.008009] pid_max: default: 32768 minimum: 301 [ 0.009139] LSM: Security Framework initializing [ 0.010046] Yama: becoming mindful. [ 0.011047] SELinux: Initializing. [ 0.012077] *** VALIDATE selinux *** [ 0.023453] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028512] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029407] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030165] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031153] *** VALIDATE tmpfs *** [ 0.033500] *** VALIDATE proc *** [ 0.035133] *** VALIDATE cgroup *** [ 0.036012] *** VALIDATE cgroup2 *** [ 0.037507] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038180] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040028] Spectre V2 : User space: Vulnerable [ 0.041009] Speculative Store Bypass: Vulnerable [ 0.044796] debug: unmapping init [mem 0xffffffff9be59000-0xffffffff9be60fff] [ 0.047221] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.049428] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.050026] ... version: 2 [ 0.051017] ... bit width: 48 [ 0.052012] ... generic registers: 4 [ 0.053012] ... value mask: 0000ffffffffffff [ 0.054022] ... max period: 00007fffffffffff [ 0.055018] ... fixed-purpose events: 3 [ 0.056010] ... event mask: 000000070000000f [ 0.057554] rcu: Hierarchical SRCU implementation. [ 0.059799] smp: Bringing up secondary CPUs ... [ 0.060899] x86: Booting SMP configuration: [ 0.061031] .... node #0, CPUs: #1 #2 #3 [ 0.064551] smp: Brought up 1 node, 4 CPUs [ 0.066019] smpboot: Max logical packages: 1 [ 0.067021] smpboot: Total of 4 processors activated (19199.84 BogoMIPS) [ 0.163337] node 0 deferred pages initialised in 93ms [ 0.166119] devtmpfs: initialized [ 0.167433] x86/mm: Memory block size: 128MB [ 0.170391] gcov: version magic: 0x41383552 [ 0.172299] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.173108] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.174314] pinctrl core: initialized pinctrl subsystem [ 0.175234] [ 0.175687] ************************************************************* [ 0.176011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.177016] ** ** [ 0.178014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.179014] ** ** [ 0.180013] ** This means that this kernel is built to expose internal ** [ 0.181012] ** IOMMU data structures, which may compromise security on ** [ 0.182015] ** your system. ** [ 0.183012] ** ** [ 0.184010] ** If you see this message and you are not debugging the ** [ 0.185009] ** kernel, report this immediately to your vendor! ** [ 0.186009] ** ** [ 0.187008] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.188012] ************************************************************* [ 0.189572] NET: Registered protocol family 16 [ 0.190316] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.191078] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.192055] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.193337] cpuidle: using governor menu [ 0.196031] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.199504] PCI: Using configuration type 1 for base access [ 0.202322] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.213096] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.216026] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.221028] cryptd: max_cpu_qlen set to 1000 [ 0.224471] ACPI: Added _OSI(Module Device) [ 0.225010] ACPI: Added _OSI(Processor Device) [ 0.226019] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.227018] ACPI: Added _OSI(Processor Aggregator Device) [ 0.233652] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.239638] ACPI: Interpreter enabled [ 0.240051] ACPI: PM: (supports S0 S3 S4 S5) [ 0.241012] ACPI: Using IOAPIC for interrupt routing [ 0.243169] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.249414] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.262950] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.266039] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.269020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.273108] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.280049] acpiphp: Slot [2] registered [ 0.281144] acpiphp: Slot [5] registered [ 0.283328] acpiphp: Slot [6] registered [ 0.285189] acpiphp: Slot [3] registered [ 0.286093] acpiphp: Slot [4] registered [ 0.288278] acpiphp: Slot [7] registered [ 0.290130] acpiphp: Slot [8] registered [ 0.292322] acpiphp: Slot [9] registered [ 0.293153] acpiphp: Slot [10] registered [ 0.295138] acpiphp: Slot [11] registered [ 0.297123] acpiphp: Slot [12] registered [ 0.299154] acpiphp: Slot [13] registered [ 0.300081] acpiphp: Slot [14] registered [ 0.302109] acpiphp: Slot [15] registered [ 0.304189] acpiphp: Slot [16] registered [ 0.305139] acpiphp: Slot [17] registered [ 0.307122] acpiphp: Slot [18] registered [ 0.309108] acpiphp: Slot [19] registered [ 0.311150] acpiphp: Slot [20] registered [ 0.313110] acpiphp: Slot [21] registered [ 0.315369] acpiphp: Slot [22] registered [ 0.317104] acpiphp: Slot [23] registered [ 0.318299] acpiphp: Slot [24] registered [ 0.320161] acpiphp: Slot [25] registered [ 0.322123] acpiphp: Slot [26] registered [ 0.324098] acpiphp: Slot [27] registered [ 0.325134] acpiphp: Slot [28] registered [ 0.327135] acpiphp: Slot [29] registered [ 0.328115] acpiphp: Slot [30] registered [ 0.330102] acpiphp: Slot [31] registered [ 0.332098] PCI host bridge to bus 0000:00 [ 0.334053] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.336024] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.339030] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.341036] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.344034] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.347042] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.348166] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.352220] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.355368] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.364018] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.368408] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.372027] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.374017] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.376017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.379567] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.383178] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.386044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.389821] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.394013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.404017] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.410016] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.419000] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.441022] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.459016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.520024] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.532444] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.562039] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.588218] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.670028] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.710000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.715521] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.718435] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.721369] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.724243] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.730036] iommu: Default domain type: Passthrough [ 0.731534] SCSI subsystem initialized [ 0.733224] ACPI: bus type USB registered [ 0.735178] usbcore: registered new interface driver usbfs [ 0.737125] usbcore: registered new interface driver hub [ 0.739290] usbcore: registered new device driver usb [ 0.741192] pps_core: LinuxPPS API ver. 1 registered [ 0.743019] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.748093] PTP clock support registered [ 0.751013] EDAC MC: Ver: 3.0.0 [ 0.752464] PCI: Using ACPI for IRQ routing [ 0.753616] NetLabel: Initializing [ 0.754012] NetLabel: domain hash size = 128 [ 0.755011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.756152] NetLabel: unlabeled traffic allowed by default [ 0.758224] vgaarb: loaded [ 0.760536] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.763021] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.769014] clocksource: Switched to clocksource kvm-clock [ 0.907751] VFS: Disk quotas dquot_6.6.0 [ 0.910252] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.914524] *** VALIDATE ramfs *** [ 0.916854] *** VALIDATE hugetlbfs *** [ 0.919984] pnp: PnP ACPI init [ 0.923152] pnp: PnP ACPI: found 6 devices [ 0.950192] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.954218] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.957126] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.959891] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.962953] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.966417] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.970269] NET: Registered protocol family 2 [ 0.973320] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.980705] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.985567] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.991992] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.995544] TCP: Hash tables configured (established 65536 bind 65536) [ 0.999105] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 1.002989] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.006201] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.009903] NET: Registered protocol family 1 [ 1.013487] RPC: Registered named UNIX socket transport module. [ 1.016152] RPC: Registered udp transport module. [ 1.018881] RPC: Registered tcp transport module. [ 1.021027] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.024290] NET: Registered protocol family 44 [ 1.027034] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.029703] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.032339] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.034982] PCI: CLS 0 bytes, default 64 [ 1.037456] Unpacking initramfs... [ 2.736676] debug: unmapping init [mem 0xffff90c0fcc64000-0xffff90c0fffcffff] [ 2.745314] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.747572] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.752073] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22982479f67, max_idle_ns: 440795221274 ns [ 3.340820] Initialise system trusted keyrings [ 3.343080] Key type blacklist registered [ 3.346227] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.362281] zbud: loaded [ 3.366598] *** VALIDATE nfs *** [ 3.368076] *** VALIDATE nfs4 *** [ 3.370230] pstore: using deflate compression [ 3.372968] Platform Keyring initialized [ 3.493654] NET: Registered protocol family 38 [ 3.495337] Key type asymmetric registered [ 3.496608] Asymmetric key parser 'x509' registered [ 3.497942] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.500426] io scheduler mq-deadline registered [ 3.502569] io scheduler kyber registered [ 3.505197] io scheduler bfq registered [ 3.507415] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.511625] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.516163] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.519385] ACPI: Power Button [PWRF] [ 3.524253] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.533076] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.558249] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.590789] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.622551] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.629574] Non-volatile memory driver v1.3 [ 3.632161] Linux agpgart interface v0.103 [ 3.665462] virtio_blk virtio1: [vda] 134776 512-byte logical blocks (69.0 MB/65.8 MiB) [ 3.671091] vda: detected capacity change from 0 to 69005312 [ 3.697626] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.701552] vdb: detected capacity change from 0 to 1073741824 [ 3.717697] libphy: Fixed MDIO Bus: probed [ 3.729552] usbcore: registered new interface driver usbserial_generic [ 3.732232] usbserial: USB Serial support registered for generic [ 3.736214] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.741397] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.744320] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.747394] mousedev: PS/2 mouse device common for all mice [ 3.751569] rtc_cmos 00:05: RTC can wake from S4 [ 3.755682] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.758622] rtc_cmos 00:05: registered as rtc0 [ 3.762207] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.765275] intel_pstate: CPU model not supported [ 3.769254] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.773127] hid: raw HID events driver (C) Jiri Kosina [ 3.775860] usbcore: registered new interface driver usbhid [ 3.777103] usbhid: USB HID core driver [ 3.777493] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.778630] drop_monitor: Initializing network drop monitor service [ 3.782940] Initializing XFRM netlink socket [ 3.784177] NET: Registered protocol family 10 [ 3.786955] Segment Routing with IPv6 [ 3.789540] NET: Registered protocol family 17 [ 3.791649] mpls_gso: MPLS GSO support [ 3.798634] RAS: Correctable Errors collector initialized. [ 3.801512] AVX version of gcm_enc/dec engaged. [ 3.804943] AES CTR mode by8 optimization enabled [ 3.926429] sched_clock: Marking stable (3926225956, 0)->(5009303212, -1083077256) [ 3.931590] registered taskstats version 1 [ 3.933875] Loading compiled-in X.509 certificates [ 3.935678] zswap: loaded using pool lzo/zbud [ 3.979119] Key type big_key registered [ 3.993157] Key type encrypted registered [ 3.995593] ima: No TPM chip found, activating TPM-bypass! [ 3.997996] ima: Allocated hash algorithm: sha1 [ 4.000168] ima: No architecture policies found [ 4.002200] evm: Initialising EVM extended attributes: [ 4.004270] evm: security.selinux [ 4.005982] evm: security.ima [ 4.007318] evm: security.capability [ 4.009300] evm: HMAC attrs: 0x1 [ 4.012426] rtc_cmos 00:05: setting system clock to 2026-05-25 07:09:42 UTC (1779692982) [ 4.018423] debug: unmapping init [mem 0xffffffff9ce03000-0xffffffff9cffffff] [ 4.022820] debug: unmapping init [mem 0xffffffff9bb82000-0xffffffff9be58fff] [ 4.033112] Write protecting the kernel read-only data: 28672k [ 4.036622] debug: unmapping init [mem 0xffffffff9a203000-0xffffffff9a3fffff] [ 4.039178] debug: unmapping init [mem 0xffffffff9ab14000-0xffffffff9abfffff] [ 4.085267] 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.095218] systemd[1]: Detected virtualization kvm. [ 4.097099] systemd[1]: Detected architecture x86-64. [ 4.101241] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 4.130517] systemd[1]: No hostname configured. [ 4.132864] systemd[1]: Set hostname to . [ 4.135162] random: systemd: uninitialized urandom read (16 bytes read) [ 4.138354] systemd[1]: Initializing machine ID from random generator. [ 4.206455] random: ln: uninitialized urandom read (6 bytes read) [ 4.341412] random: systemd: uninitialized urandom read (16 bytes read) [ 4.345129] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 4.350667] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 4.357363] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Swap. [ OK ] Reached target Timers. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 5.212610] device-mapper: uevent: version 1.0.3 [ 5.216601] 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. [ 6.100530] virtio_net virtio0 ens2: renamed from eth0 [ 6.307673] scsi host0: ata_piix [ 6.364120] scsi host1: ata_piix [ 6.422194] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 6.424456] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 7.926031] random: fast init done [ 10.113368] dracut-initqueue[579]: RTNETLINK answers: File exists [ 10.514228] random: crng init done [ 10.517201] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 11.763812] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. Stopping udev Kernel Device Manager... [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 13.247604] printk: systemd: 26 output lines suppressed due to ratelimiting [ 14.044385] SELinux: Disabled at runtime. [ 14.216629] 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) [ 14.229043] systemd[1]: Detected virtualization kvm. [ 14.232186] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 16.114278] systemd[1]: initrd-switch-root.service: Succeeded. [ 16.119960] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 16.132583] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 16.139931] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 16.144996] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 16.156517] systemd[1]: Starting Journal Service... Starting Journal Service... [ 16.170275] systemd[1]: Activating swap /dev/disk/by-label/SWAP... Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on initctl Compatibility Named Pipe. [ 16.280469] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice User and Session Slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target Slices. [ OK ] Listening on Process Core Dump Socket. Mounting POSIX Message Queue 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. Starting Remount Root and Kernel File Systems... [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting Kernel Debug File System... [ OK ] Reached target RPC Port Mapper. Mounting Huge Pages File System... Starting Apply Kernel Variables... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Started udev Coldplug all Devices. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 18.152111] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 19.768281] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 19.861804] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 20.480428] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 20.767429] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit)[ 24.743206] Key type dns_resolver registered [** ] 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 (10s / no limit)[ 26.382352] NFS: Registering the id_resolver key type [ 26.391138] Key type id_resolver registered [ 26.398460] Key type id_legacy registered [ *** ] A start job is running for Configur…only root support (10s / 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 RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ 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 ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. Starting Login Service... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started irqbalance daemon. Starting Network Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ 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... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg157-client login: [ 105.439517] hrtimer: interrupt took 10505883 ns [ 139.821365] libcfs: loading out-of-tree module taints kernel. [ 139.888305] Key type ._llcrypt registered [ 139.897985] Key type .llcrypt registered [ 141.151218] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 141.190704] alg: No test for adler32 (adler32-zlib) [ 143.037025] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 144.323119] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 146.183237] Key type lgssc registered [ 148.975640] Lustre: Echo OBD driver; http://www.lustre.org/ [ 371.183363] Lustre: Mounted lustre-client [ 378.255714] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 396.768413] Lustre: lustre-OST0000-osc-ffff90c145f5c000: disconnect after 23s idle [ 396.981574] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing check_logdir /tmp/testlogs/ [ 405.461584] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing yml_node [ 413.260305] Lustre: DEBUG MARKER: Client: 2.17.53.24 [ 417.414547] Lustre: DEBUG MARKER: MDS: 2.17.53.24 [ 421.294911] Lustre: DEBUG MARKER: OSS: 2.17.53.24 [ 423.694595] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon May 25 03:16:40 EDT 2026 [ 453.269190] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 455.998778] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 461.694276] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 472.087314] Lustre: Unmounted lustre-client [ 633.929148] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 640.414382] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 675.589555] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 733.988662] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 03:21:50 (1779693710) [ 737.378616] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 740.119953] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 03:21:56 (1779693716) [ 783.649121] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 790.788420] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 819.796484] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 820.912065] Lustre: Mounted lustre-client [ 827.078109] LustreError: 14470:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c148cc7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 827.189383] Lustre: Unmounted lustre-client [ 862.484837] Key type lgssc unregistered [ 862.806047] LNet: 14880:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 862.825779] LNetError: 14880:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 862.848446] LNet: Removed LNI 192.168.201.57@tcp [ 863.859166] Key type .llcrypt unregistered [ 863.867317] Key type ._llcrypt unregistered [ 890.022205] Key type ._llcrypt registered [ 890.025711] Key type .llcrypt registered [ 891.618683] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 03:24:28 (1779693868) [ 894.131626] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 894.351155] alg: No test for adler32 (adler32-zlib) [ 895.792045] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 896.277722] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 898.223690] Key type lgssc registered [ 901.309481] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1010.354048] Lustre: Mounted lustre-client [ 1109.538759] LustreError: 18234:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c142d2e000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 1109.622174] Lustre: Unmounted lustre-client [ 1148.113419] Key type lgssc unregistered [ 1148.521308] LNet: 18700:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1148.532649] LNetError: 18700:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1148.556514] LNet: Removed LNI 192.168.201.57@tcp [ 1149.808798] Key type .llcrypt unregistered [ 1149.813279] Key type ._llcrypt unregistered [ 1166.391132] Key type ._llcrypt registered [ 1166.393394] Key type .llcrypt registered [ 1168.709347] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 03:29:04 (1779694144) [ 1172.241427] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1172.302064] alg: No test for adler32 (adler32-zlib) [ 1173.617466] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 1173.847268] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 1175.551445] Key type lgssc registered [ 1177.499814] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1249.027375] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1255.042478] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1282.896067] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1290.368295] Lustre: Mounted lustre-client [ 1307.621728] LustreError: 21817:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1500a5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1307.816076] Lustre: Unmounted lustre-client [ 1359.613297] Key type lgssc unregistered [ 1360.134075] LNet: 22224:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1360.157967] LNetError: 22224:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1360.186178] LNet: Removed LNI 192.168.201.57@tcp [ 1361.186456] Key type .llcrypt unregistered [ 1361.193305] Key type ._llcrypt unregistered [ 1377.629533] Key type ._llcrypt registered [ 1377.633605] Key type .llcrypt registered [ 1379.889501] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 03:32:35 (1779694355) [ 1383.336612] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1383.446568] alg: No test for adler32 (adler32-zlib) [ 1384.716167] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 1385.220189] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 1387.071180] Key type lgssc registered [ 1389.120126] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1456.645522] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1462.144467] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1489.657686] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1497.194369] Lustre: Mounted lustre-client [ 1505.773867] LustreError: 24930:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c142d6d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1505.973319] Lustre: Unmounted lustre-client [ 1542.369895] Key type lgssc unregistered [ 1542.619731] LNet: 25336:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1542.634687] LNetError: 25336:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1542.669139] LNet: Removed LNI 192.168.201.57@tcp [ 1543.823748] Key type .llcrypt unregistered [ 1543.827181] Key type ._llcrypt unregistered [ 1567.184796] Key type ._llcrypt registered [ 1567.187723] Key type .llcrypt registered [ 1568.985099] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 03:35:45 (1779694545) [ 1572.833484] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1572.885847] alg: No test for adler32 (adler32-zlib) [ 1574.113820] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 1574.553318] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 1576.343418] Key type lgssc registered [ 1578.163256] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1648.204671] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1654.718876] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1684.542247] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1687.522520] Lustre: Mounted lustre-client [ 1697.776255] Lustre: lustre-MDT0000-mdc-ffff90c1504c9000: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1708.020190] Lustre: lustre-MDT0001-mdc-ffff90c1504c9000: Connection to lustre-MDT0001 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1715.400615] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1719.135437] Lustre: 26296:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779694681/real 1779694681] req@000000006081092e x1866144995612672/t0(0) o400->MGC192.168.201.157@tcp@192.168.201.157@tcp:26/25 lens 224/224 e 0 to 1 dl 1779694697 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1719.185774] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [ 1725.757690] Lustre: Unmounted lustre-client [ 1744.011096] Key type lgssc unregistered [ 1744.403136] LNet: 28907:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1744.411914] LNetError: 28907:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1744.460921] LNet: Removed LNI 192.168.201.57@tcp [ 1745.602934] Key type .llcrypt unregistered [ 1745.614817] Key type ._llcrypt unregistered [ 1767.738764] Key type ._llcrypt registered [ 1767.742343] Key type .llcrypt registered [ 1769.681875] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 03:39:06 (1779694746) [ 1773.047469] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1773.122088] alg: No test for adler32 (adler32-zlib) [ 1774.479346] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 1775.001663] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 1776.776697] Key type lgssc registered [ 1778.746674] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1837.780785] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1842.775451] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1867.157740] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1869.173806] Lustre: Mounted lustre-client [ 1879.559232] Lustre: lustre-OST0000-osc-ffff90c147968000: Connection to lustre-OST0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1885.788084] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1896.128399] Lustre: Unmounted lustre-client [ 1927.284315] Key type lgssc unregistered [ 1927.682952] LNet: 32439:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1927.694354] LNetError: 32439:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1927.710819] LNet: Removed LNI 192.168.201.57@tcp [ 1928.450464] Key type .llcrypt unregistered [ 1928.457980] Key type ._llcrypt unregistered [ 1948.633086] Key type ._llcrypt registered [ 1948.643735] Key type .llcrypt registered [ 1950.495612] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 03:42:06 (1779694926) [ 1954.245575] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1954.305514] alg: No test for adler32 (adler32-zlib) [ 1955.789455] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 1956.163780] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 1957.928267] Key type lgssc registered [ 1959.971278] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2025.805063] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2031.842693] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2057.762437] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2065.015323] Lustre: Mounted lustre-client [ 2069.076574] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 2074.276216] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 2086.463726] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-05-25 3h44m22s [ 2089.392181] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 2095.592065] Lustre: lustre-MDT0000-mdc-ffff90c148cc4800: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2100.803117] LustreError: 36147:0:(lmv_obd.c:1450:lmv_statfs()) lustre-MDT0000-mdc-ffff90c148cc4800: can't stat MDS #0: rc = -19 [ 2102.983649] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 2114.049380] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [ 2114.070901] Lustre: Evicted from MGS (at 192.168.201.157@tcp) after server handle changed from 0x78f210676353f3de to 0x78f210676353f781 [ 2114.096938] Lustre: MGC192.168.201.157@tcp: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 2115.132416] LustreError: lustre-MDT0000-mdc-ffff90c148cc4800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 2115.163590] Lustre: lustre-MDT0000-mdc-ffff90c148cc4800: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 2123.655983] Lustre: DEBUG MARKER: Wait for df (36147) ... [ 2126.173496] Lustre: DEBUG MARKER: done [ 2129.440051] LustreError: 36761:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c148cc4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2129.530105] Lustre: Unmounted lustre-client [ 2162.848744] Key type lgssc unregistered [ 2163.163496] LNet: 37165:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2163.174298] LNetError: 37165:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2163.199129] LNet: Removed LNI 192.168.201.57@tcp [ 2164.169988] Key type .llcrypt unregistered [ 2164.171702] Key type ._llcrypt unregistered [ 2205.480522] Key type ._llcrypt registered [ 2205.485670] Key type .llcrypt registered [ 2207.557358] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 03:46:23 (1779695183) [ 2211.263756] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2211.413126] alg: No test for adler32 (adler32-zlib) [ 2212.517490] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 2212.784442] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 2214.423604] Key type lgssc registered [ 2215.677639] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2284.656765] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2291.084122] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2321.322277] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2324.769788] Lustre: Mounted lustre-client [ 2330.525599] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-05-25 3h48m27s [ 2333.189118] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 2341.920475] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 2345.993047] Lustre: DEBUG MARKER: Creating a test file and stat it [ 2366.431436] Lustre: 41227:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779695324/real 1779695324] req@00000000bad71b57 x1866145664605312/t0(0) o101->lustre-MDT0000-mdc-ffff90c14796d800@192.168.201.157@tcp:12/10 lens 576/1152 e 0 to 1 dl 1779695344 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 2366.485902] Lustre: lustre-MDT0000-mdc-ffff90c14796d800: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2366.535073] Lustre: lustre-MDT0000-mdc-ffff90c14796d800: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 2388.313655] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 2392.864414] Lustre: DEBUG MARKER: done [ 2398.213534] LustreError: 41711:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14796d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2398.284921] Lustre: Unmounted lustre-client [ 2442.083930] Key type lgssc unregistered [ 2442.375307] LNet: 42115:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2442.386717] LNetError: 42115:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2442.405441] LNet: Removed LNI 192.168.201.57@tcp [ 2443.260636] Key type .llcrypt unregistered [ 2443.264755] Key type ._llcrypt unregistered [ 2483.565852] Key type ._llcrypt registered [ 2483.571962] Key type .llcrypt registered [ 2485.761090] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 03:51:01 (1779695461) [ 2488.101190] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2490.795938] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 03:51:07 (1779695467) [ 2496.584860] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2496.654560] alg: No test for adler32 (adler32-zlib) [ 2498.063237] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 2498.429131] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 2500.272790] Key type lgssc registered [ 2502.222112] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2538.447942] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 03:51:55 (1779695515) [ 2580.847206] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2587.283151] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2611.712526] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2613.595978] Lustre: Mounted lustre-client [ 2617.986455] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2623.563492] LustreError: 46466:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1607fd000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2623.756104] Lustre: Unmounted lustre-client [ 2646.076890] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2696.273422] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2702.287954] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2703.405458] Lustre: Mounted lustre-client [ 2708.849544] LustreError: 47723:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c146b61800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2708.976704] Lustre: Unmounted lustre-client [ 2788.960863] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2795.575750] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2796.677421] Lustre: Mounted lustre-client [ 2802.311142] LustreError: 48843:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c15863c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2802.446175] Lustre: Unmounted lustre-client [ 2829.570768] Lustre: DEBUG MARKER: files compared the same [ 2857.315748] Key type lgssc unregistered [ 2857.660634] LNet: 49552:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2857.671065] LNetError: 49552:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2857.701968] LNet: Removed LNI 192.168.201.57@tcp [ 2858.873761] Key type .llcrypt unregistered [ 2858.882240] Key type ._llcrypt unregistered [ 2880.136503] Key type ._llcrypt registered [ 2880.139914] Key type .llcrypt registered [ 2882.013710] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 03:57:38 (1779695858) [ 2885.937985] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2885.996092] alg: No test for adler32 (adler32-zlib) [ 2887.109238] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 2887.480179] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 2889.255201] Key type lgssc registered [ 2890.934606] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2956.829350] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2962.394451] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2986.465910] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2998.870793] Lustre: Mounted lustre-client [ 3004.063735] LustreError: 52650:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1607fb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3004.296367] Lustre: Unmounted lustre-client [ 3043.939967] Key type lgssc unregistered [ 3044.392462] LNet: 53055:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3044.419711] LNetError: 53055:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3044.449116] LNet: Removed LNI 192.168.201.57@tcp [ 3045.652556] Key type .llcrypt unregistered [ 3045.662134] Key type ._llcrypt unregistered [ 3075.156413] Key type ._llcrypt registered [ 3075.159514] Key type .llcrypt registered [ 3076.797624] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 04:00:53 (1779696053) [ 3080.692674] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3080.738530] alg: No test for adler32 (adler32-zlib) [ 3081.874593] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 3082.215078] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 3084.031186] Key type lgssc registered [ 3086.567595] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3191.806933] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3241.039264] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3246.657169] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3283.099705] Key type lgssc unregistered [ 3283.486837] LNet: 56482:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3283.497636] LNetError: 56482:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3283.516884] LNet: Removed LNI 192.168.201.57@tcp [ 3284.407472] Key type .llcrypt unregistered [ 3284.422863] Key type ._llcrypt unregistered [ 3307.487331] Key type ._llcrypt registered [ 3307.490733] Key type .llcrypt registered [ 3309.636323] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 04:04:45 (1779696285) [ 3314.491392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3314.590156] alg: No test for adler32 (adler32-zlib) [ 3315.920873] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 3316.455312] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 3318.299179] Key type lgssc registered [ 3320.261249] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3431.577943] Lustre: Mounted lustre-client [ 3441.768933] LustreError: 58980:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c147539800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3441.866714] Lustre: Unmounted lustre-client [ 3494.154913] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 04:07:50 (1779696470) [ 3686.338904] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3712.824195] Lustre: Mounted lustre-client [ 3722.003410] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3722.042305] Lustre: 57471:0:(llite_lib.c:4187:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.157@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3732.413039] Lustre: Unmounted lustre-client [ 3802.778627] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 04:12:58 (1779696778) [ 3824.093400] Key type lgssc unregistered [ 3824.498398] LNet: 64168:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3824.511048] LNetError: 64168:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3824.537568] LNet: Removed LNI 192.168.201.57@tcp [ 3825.850965] Key type .llcrypt unregistered [ 3825.854734] Key type ._llcrypt unregistered [ 3843.891243] Key type ._llcrypt registered [ 3843.893344] Key type .llcrypt registered [ 3844.846616] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3844.879237] alg: No test for adler32 (adler32-zlib) [ 3846.419287] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 3847.015118] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 3848.935196] Key type lgssc registered [ 3852.093766] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3925.359910] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3930.900371] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3957.307518] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3963.954872] Lustre: Mounted lustre-client [ 3969.539337] LustreError: 66693:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1500a1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3969.714713] Lustre: Unmounted lustre-client [ 4007.704045] Key type lgssc unregistered [ 4008.215543] LNet: 67098:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4008.230358] LNetError: 67098:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4008.255946] LNet: Removed LNI 192.168.201.57@tcp [ 4009.282132] Key type .llcrypt unregistered [ 4009.285772] Key type ._llcrypt unregistered [ 4026.705836] Key type ._llcrypt registered [ 4026.714880] Key type .llcrypt registered [ 4027.651908] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4027.680029] alg: No test for adler32 (adler32-zlib) [ 4028.896924] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 4029.265716] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 4031.074727] Key type lgssc registered [ 4032.530497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4186.015693] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4191.388174] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4220.364449] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4222.256819] Lustre: Mounted lustre-client [ 4226.502466] LustreError: 70064:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c145f59000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4226.590954] Lustre: Unmounted lustre-client [ 4259.727501] Key type lgssc unregistered [ 4260.144735] LNet: 70469:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4260.154367] LNetError: 70469:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4261.228831] LNet: Removed LNI 192.168.201.57@tcp [ 4262.060495] Key type .llcrypt unregistered [ 4262.067327] Key type ._llcrypt unregistered [ 4280.174435] Key type ._llcrypt registered [ 4280.178152] Key type .llcrypt registered [ 4282.137069] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 04:20:58 (1779697258) [ 4285.486576] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4285.514531] alg: No test for adler32 (adler32-zlib) [ 4286.836497] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 4287.246255] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 4288.977891] Key type lgssc registered [ 4291.475295] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4359.901886] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4367.230033] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4393.668887] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4396.787872] Lustre: Mounted lustre-client [ 4401.931546] LustreError: 73602:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c150638800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4402.000466] Lustre: Unmounted lustre-client [ 4402.397347] Lustre: Mounted lustre-client [ 4408.178079] LustreError: 73675:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c15863c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4408.273166] Lustre: Unmounted lustre-client [ 4441.257993] Key type lgssc unregistered [ 4441.573278] LNet: 74082:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4441.599287] LNetError: 74082:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4441.628709] LNet: Removed LNI 192.168.201.57@tcp [ 4442.513420] Key type .llcrypt unregistered [ 4442.519840] Key type ._llcrypt unregistered [ 4457.988549] Key type ._llcrypt registered [ 4457.997591] Key type .llcrypt registered [ 4458.702661] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4458.727870] alg: No test for adler32 (adler32-zlib) [ 4459.993882] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 4460.413366] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 4462.159639] Key type lgssc registered [ 4464.279916] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4532.916054] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4538.111945] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4562.281794] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4573.238086] Lustre: Mounted lustre-client [ 4578.628061] LustreError: 76628:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c160581000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4578.763890] Lustre: Unmounted lustre-client [ 4620.339611] Key type lgssc unregistered [ 4620.719743] LNet: 77035:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4620.756697] LNetError: 77035:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4621.806391] LNet: Removed LNI 192.168.201.57@tcp [ 4623.267208] Key type .llcrypt unregistered [ 4623.270804] Key type ._llcrypt unregistered [ 4646.418887] Key type ._llcrypt registered [ 4646.420438] Key type .llcrypt registered [ 4647.903906] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 04:27:04 (1779697624) [ 4652.398748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4652.424143] alg: No test for adler32 (adler32-zlib) [ 4653.957694] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 4654.589887] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 4656.763169] Key type lgssc registered [ 4659.542988] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4724.156214] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4729.052725] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4754.168797] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4766.297327] Lustre: Mounted lustre-client [ 4781.125829] Lustre: lustre: root_squash is set to 0:0 [ 4781.175826] Lustre: lustre: nosquash_nids is cleared [ 4786.793669] Lustre: lustre: root_squash is set to 500:500 [ 4795.459459] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.57@tcp 192.168.0.[2,10]@tcp [ 4804.133633] Lustre: lustre: nosquash_nids set to 192.168.201.57/24@tcp [ 4808.716671] LustreError: 80483:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c146a1b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4808.824864] Lustre: Unmounted lustre-client [ 4847.680446] Key type lgssc unregistered [ 4848.076595] LNet: 80887:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4848.090031] LNetError: 80887:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4848.112478] LNet: Removed LNI 192.168.201.57@tcp [ 4848.973275] Key type .llcrypt unregistered [ 4848.975666] Key type ._llcrypt unregistered [ 4871.955663] Key type ._llcrypt registered [ 4871.959636] Key type .llcrypt registered [ 4873.510214] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 04:30:50 (1779697850) [ 4876.900810] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4879.226807] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 04:30:55 (1779697855) [ 4882.238197] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4882.366889] alg: No test for adler32 (adler32-zlib) [ 4883.632762] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 4883.884481] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 4885.615253] Key type lgssc registered [ 4887.395613] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4952.081783] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4958.825828] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4986.343366] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4988.477937] Lustre: lustre: root_squash is set to 500:500 [ 4988.562860] Lustre: lustre: nosquash_nids set to 192.168.201.57/24@tcp [ 4989.613127] Lustre: Mounted lustre-client [ 4997.535076] LustreError: 84359:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1500a1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4997.681698] Lustre: Unmounted lustre-client [ 5039.174806] Key type lgssc unregistered [ 5039.667890] LNet: 84764:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5039.675673] LNetError: 84764:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5039.727062] LNet: Removed LNI 192.168.201.57@tcp [ 5040.842744] Key type .llcrypt unregistered [ 5040.850940] Key type ._llcrypt unregistered [ 5063.287377] Key type ._llcrypt registered [ 5063.294538] Key type .llcrypt registered [ 5065.356787] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 5067.948964] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 04:34:04 (1779698044) [ 5092.128914] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5092.181737] alg: No test for adler32 (adler32-zlib) [ 5093.480295] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 5093.985813] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 5095.815409] Key type lgssc registered [ 5097.281884] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5204.888078] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5210.668397] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5238.019917] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5320.389443] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5326.723613] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5350.273869] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5367.432245] Lustre: Mounted lustre-client [ 5409.663927] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff90c147ced800.ost_server_uuid 50 [ 5411.910454] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff90c147ced800.ost_server_uuid in IDLE state after 0 sec [ 5412.744601] Lustre: Mounted lustre-client [ 5417.548616] LustreError: 91680:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1500a5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5417.693660] Lustre: Unmounted lustre-client [ 5420.605865] LustreError: 91700:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c147ced800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5420.639926] LustreError: 91700:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 5420.757210] Lustre: Unmounted lustre-client [ 5484.186810] Key type lgssc unregistered [ 5484.539190] LNet: 92256:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5484.553637] LNetError: 92256:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5484.581371] LNet: Removed LNI 192.168.201.57@tcp [ 5485.550293] Key type .llcrypt unregistered [ 5485.553053] Key type ._llcrypt unregistered [ 5530.373870] Key type ._llcrypt registered [ 5530.377190] Key type .llcrypt registered [ 5533.629778] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 04:41:48 (1779698508) [ 5563.324720] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5563.416577] alg: No test for adler32 (adler32-zlib) [ 5564.929047] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 5565.429145] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 5567.279814] Key type lgssc registered [ 5569.805791] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5678.753240] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5685.605888] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5715.932176] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5717.911818] Lustre: Mounted lustre-client [ 5739.487230] Lustre: 93621:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779698701/real 1779698701] req@00000000cbb615b7 x1866149179430016/t0(0) o400->lustre-OST0000-osc-ffff90c161262000@192.168.201.157@tcp:28/4 lens 224/224 e 0 to 1 dl 1779698717 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5739.522543] Lustre: lustre-OST0000-osc-ffff90c161262000: Connection to lustre-OST0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5743.647433] Lustre: 93622:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779698706/real 1779698706] req@000000005e9cba81 x1866149179430528/t0(0) o400->lustre-OST0000-osc-ffff90c161262000@192.168.201.157@tcp:28/4 lens 224/224 e 0 to 1 dl 1779698722 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5748.831140] Lustre: 93622:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779698711/real 1779698711] req@0000000063466c5c x1866149179431040/t0(0) o400->lustre-OST0000-osc-ffff90c161262000@192.168.201.157@tcp:28/4 lens 224/224 e 0 to 1 dl 1779698727 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5749.817951] Lustre: lustre-OST0000-osc-ffff90c161262000: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 5754.019145] Lustre: 93622:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779698716/real 1779698716] req@000000005508e0d3 x1866149179431552/t0(0) o400->lustre-OST0000-osc-ffff90c161262000@192.168.201.157@tcp:28/4 lens 224/224 e 0 to 1 dl 1779698732 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5759.997495] Lustre: lustre-MDT0000-mdc-ffff90c161262000: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5776.351405] Lustre: 93622:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779698738/real 1779698738] req@000000009cac93cc x1866149179434240/t0(0) o400->MGC192.168.201.157@tcp@192.168.201.157@tcp:26/25 lens 224/224 e 0 to 1 dl 1779698754 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5776.424488] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [ 5785.583055] Lustre: Evicted from MGS (at 192.168.201.157@tcp) after server handle changed from 0x3093bb8c01b77826 to 0x3093bb8c01b77ab8 [ 5785.595384] Lustre: MGC192.168.201.157@tcp: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 5790.366120] Lustre: lustre-MDT0000-mdc-ffff90c161262000: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 5798.297750] LustreError: 97440:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c161262000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5798.427928] Lustre: Unmounted lustre-client [ 5840.659414] Key type lgssc unregistered [ 5840.943259] LNet: 97846:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5840.958639] LNetError: 97846:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5840.992661] LNet: Removed LNI 192.168.201.57@tcp [ 5841.902337] Key type .llcrypt unregistered [ 5841.908114] Key type ._llcrypt unregistered [ 5863.739561] Key type ._llcrypt registered [ 5863.747901] Key type .llcrypt registered [ 5865.360295] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 04:47:22 (1779698842) [ 5882.354285] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5882.406676] alg: No test for adler32 (adler32-zlib) [ 5883.832598] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 5884.232734] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 5885.999592] Key type lgssc registered [ 5888.214658] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5939.268606] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6073.636325] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6079.761081] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6111.642938] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6113.597912] Lustre: Mounted lustre-client [ 6116.715890] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 6119.234903] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 04:51:35 (1779699095) [ 6456.934940] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6467.316552] Lustre: Unmounted lustre-client [ 6641.548310] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6649.577485] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6689.603840] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6753.614323] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:02:10 (1779699730) [ 6892.520602] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6898.660527] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6930.729409] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6931.789854] Lustre: Mounted lustre-client [ 6940.163588] LustreError: 116093:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c142d6c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6940.274766] Lustre: Unmounted lustre-client [ 6979.197419] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:05:55 (1779699955) [ 7113.728291] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7120.135163] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7152.132913] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7153.364827] Lustre: Mounted lustre-client [ 7161.323364] LustreError: 120146:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c160580000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7161.441064] Lustre: Unmounted lustre-client [ 7197.562335] Key type lgssc unregistered [ 7197.882552] LNet: 120551:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7197.889435] LNetError: 120551:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7197.910835] LNet: Removed LNI 192.168.201.57@tcp [ 7198.600986] Key type .llcrypt unregistered [ 7198.605920] Key type ._llcrypt unregistered [ 7222.833459] Key type ._llcrypt registered [ 7222.836256] Key type .llcrypt registered [ 7225.154491] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 05:10:01 (1779700201) [ 7229.289043] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7229.315936] alg: No test for adler32 (adler32-zlib) [ 7230.545894] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 7230.921990] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 7232.727190] Key type lgssc registered [ 7234.168618] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7302.394164] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7307.783266] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7338.200575] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7341.338303] Lustre: Mounted lustre-client [ 7356.552566] LustreError: 123658:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c146a1a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7356.687592] Lustre: Unmounted lustre-client [ 7392.202410] Key type lgssc unregistered [ 7392.712202] LNet: 124062:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7392.727562] LNetError: 124062:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7392.775620] LNet: Removed LNI 192.168.201.57@tcp [ 7394.011768] Key type .llcrypt unregistered [ 7394.029157] Key type ._llcrypt unregistered [ 7421.462935] Key type ._llcrypt registered [ 7421.472173] Key type .llcrypt registered [ 7424.139888] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 05:13:19 (1779700399) [ 7429.008776] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7429.064625] alg: No test for adler32 (adler32-zlib) [ 7430.428794] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 7430.660264] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 7432.375254] Key type lgssc registered [ 7434.880245] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7505.100569] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7511.687958] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7541.712888] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7543.999431] Lustre: Mounted lustre-client [ 7554.042593] Lustre: lustre-OST0000-osc-ffff90c14578f800: Connection to lustre-OST0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7567.073549] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff90c14578f800.ost_server_uuid 50 [ 7570.055967] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 7582.704626] LustreError: 127609:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14578f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7582.835185] Lustre: Unmounted lustre-client [ 7610.459240] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 05:16:26 (1779700586) [ 7653.907701] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7660.705962] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7692.880606] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7725.732190] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7726.966219] Lustre: Mounted lustre-client [ 7732.217019] Lustre: lustre-OST0000-osc-ffff90c1500a1800: Connection to lustre-OST0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7768.125242] LustreError: 130267:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1500a1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7768.257450] Lustre: Unmounted lustre-client [ 7832.240836] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 05:20:08 (1779700808) [ 7883.286655] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7889.049665] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7917.986233] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7947.608538] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7948.704953] Lustre: Mounted lustre-client [ 7953.912179] Lustre: lustre-OST0000-osc-ffff90c14581c000: Connection to lustre-OST0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7973.588971] LustreError: 133036:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14581c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7973.609668] LustreError: 133036:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 7973.734247] Lustre: Unmounted lustre-client [ 8040.342493] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 05:23:36 (1779701016) [ 8186.162403] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8192.920169] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8223.624262] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8319.575691] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8325.414830] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8352.851921] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8392.829751] Lustre: Mounted lustre-client [ 8440.137694] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8441.993186] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8444.891403] LustreError: 139655:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14465f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8444.900976] LustreError: 139655:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 8445.016408] Lustre: Unmounted lustre-client [ 8485.737805] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 05:31:02 (1779701462) [ 8529.358736] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8535.485666] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8563.255755] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8612.668632] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 8654.873547] Lustre: Mounted lustre-client [ 8708.201917] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 8711.517649] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8729.373438] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8739.744206] Lustre: Unmounted lustre-client [ 8814.980145] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 05:36:31 (1779701791) [ 8857.911275] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8862.938913] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8890.054813] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8890.962718] Lustre: Mounted lustre-client [ 8917.655781] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 8920.142841] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8937.624026] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff90c145819000.ost_server_uuid 50 [ 8939.725208] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff90c145819000.ost_server_uuid in IDLE state after 0 sec [ 8944.136165] LustreError: 146678:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c145819000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8944.258994] Lustre: Unmounted lustre-client [ 8944.770633] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 8944.784438] Lustre: Skipped 3 previous similar messages [ 8944.886604] Lustre: Mounted lustre-client [ 8946.486650] LustreError: 146734:0:(sec.c:413:import_sec_validate_get()) import 000000008d7fce39 (NEW) with no sec [ 9023.016585] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 05:39:58 (1779701998) [ 9067.920612] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9075.185567] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9105.580052] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9135.070162] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 9135.692471] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 9136.014182] Lustre: Mounted lustre-client [ 9152.168662] LustreError: 149592:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c150bdd000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9152.179861] LustreError: 149592:0:(lov_obd.c:792:lov_cleanup()) Skipped 2 previous similar messages [ 9152.313608] Lustre: Unmounted lustre-client [ 9152.322020] Lustre: Skipped 1 previous similar message [ 9215.290954] Key type lgssc unregistered [ 9215.612374] LNet: 150044:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9215.621031] LNetError: 150044:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9215.640768] LNet: Removed LNI 192.168.201.57@tcp [ 9216.841984] Key type .llcrypt unregistered [ 9216.844986] Key type ._llcrypt unregistered [ 9243.357612] Key type ._llcrypt registered [ 9243.360398] Key type .llcrypt registered [ 9245.245272] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 05:43:41 (1779702221) [ 9247.247432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9247.325505] alg: No test for adler32 (adler32-zlib) [ 9248.735708] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 9249.165035] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 9251.001179] Key type lgssc registered [ 9252.815248] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9324.923888] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9330.565788] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9360.695443] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9392.634384] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 9393.608940] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 9394.848795] Lustre: Mounted lustre-client [ 9402.950242] LustreError: lustre-MDT0001-mdc-ffff90c142d69800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 9402.991381] Lustre: lustre-MDT0001-mdc-ffff90c142d69800: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [ 9409.418780] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9412.398682] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9443.375190] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 9451.131344] LustreError: 154285:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c142d69800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9451.310217] Lustre: Unmounted lustre-client [ 9490.072275] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 05:47:46 (1779702466) [ 9639.618291] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9644.920466] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9679.520856] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9680.631236] Lustre: Mounted lustre-client [ 9720.699464] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 9722.986529] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 9739.076127] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9749.458242] Lustre: Unmounted lustre-client [ 9805.293286] Key type lgssc unregistered [ 9805.988967] LNet: 159438:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9806.022202] LNetError: 159438:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9806.072365] LNet: Removed LNI 192.168.201.57@tcp [ 9807.922616] Key type .llcrypt unregistered [ 9807.927595] Key type ._llcrypt unregistered [ 9864.656405] Key type ._llcrypt registered [ 9864.661313] Key type .llcrypt registered [ 9866.815301] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 05:54:02 (1779702842) [ 9871.036991] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9871.104290] alg: No test for adler32 (adler32-zlib) [ 9872.457506] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [ 9872.830529] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [ 9874.631171] Key type lgssc registered [ 9876.288329] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9948.644869] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9953.716202] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9985.153195] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9988.780096] Lustre: Mounted lustre-client [10045.959588] LustreError: 162718:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c161140000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10046.144626] Lustre: Unmounted lustre-client [10101.439932] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10102.481169] Lustre: Mounted lustre-client [10142.299385] LustreError: 163371:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14790c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10142.511410] Lustre: Unmounted lustre-client [10188.885854] Key type lgssc unregistered [10189.309426] LNet: 163781:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10189.321727] LNetError: 163781:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10189.349719] LNet: Removed LNI 192.168.201.57@tcp [10190.709677] Key type .llcrypt unregistered [10190.716368] Key type ._llcrypt unregistered [10224.547586] Key type ._llcrypt registered [10224.550953] Key type .llcrypt registered [10226.706111] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 06:00:02 (1779703202) [10230.704380] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10230.723947] alg: No test for adler32 (adler32-zlib) [10231.829616] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [10232.204095] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [10234.177083] Key type lgssc registered [10235.609541] Lustre: Echo OBD driver; http://www.lustre.org/ [10310.478234] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10316.571688] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10347.796833] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10349.989182] Lustre: Mounted lustre-client [10379.001640] LustreError: 167064:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c147fe5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10379.155699] Lustre: Unmounted lustre-client [10414.388557] Key type lgssc unregistered [10414.742094] LNet: 167469:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10414.754207] LNetError: 167469:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10414.775976] LNet: Removed LNI 192.168.201.57@tcp [10415.730883] Key type .llcrypt unregistered [10415.732526] Key type ._llcrypt unregistered [10432.271742] Key type ._llcrypt registered [10432.278668] Key type .llcrypt registered [10433.098523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10433.128887] alg: No test for adler32 (adler32-zlib) [10434.569064] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [10435.069244] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [10436.887657] Key type lgssc registered [10438.806720] Lustre: Echo OBD driver; http://www.lustre.org/ [10505.882103] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10512.188921] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10541.817754] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10544.354128] Lustre: Mounted lustre-client [10556.389533] LustreError: 170041:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14581a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10556.510655] Lustre: Unmounted lustre-client [10590.960753] Key type lgssc unregistered [10591.381735] LNet: 170446:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10591.392728] LNetError: 170446:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10591.416505] LNet: Removed LNI 192.168.201.57@tcp [10592.548471] Key type .llcrypt unregistered [10592.552093] Key type ._llcrypt unregistered [10616.493367] Key type ._llcrypt registered [10616.502396] Key type .llcrypt registered [10618.848835] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 06:06:34 (1779703594) [10622.857065] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10622.879618] alg: No test for adler32 (adler32-zlib) [10624.207448] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [10624.642218] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [10626.552483] Key type lgssc registered [10628.785696] Lustre: Echo OBD driver; http://www.lustre.org/ [10699.524432] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10706.141632] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10733.378983] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10736.381719] Lustre: Mounted lustre-client [10764.302579] LustreError: 173714:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c149c79000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10764.441739] Lustre: Unmounted lustre-client [10807.720670] Key type lgssc unregistered [10808.117892] LNet: 174119:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10808.128681] LNetError: 174119:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10808.157262] LNet: Removed LNI 192.168.201.57@tcp [10809.499497] Key type .llcrypt unregistered [10809.513295] Key type ._llcrypt unregistered [10827.941361] Key type ._llcrypt registered [10827.948459] Key type .llcrypt registered [10828.817684] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10828.841545] alg: No test for adler32 (adler32-zlib) [10830.092808] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [10830.476604] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [10832.215308] Key type lgssc registered [10833.962396] Lustre: Echo OBD driver; http://www.lustre.org/ [10910.416641] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10917.015623] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10944.073144] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10946.266726] Lustre: Mounted lustre-client [10956.351928] LustreError: 176699:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c147fe2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10956.438312] Lustre: Unmounted lustre-client [10999.341736] Key type lgssc unregistered [10999.737286] LNet: 177104:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10999.758873] LNetError: 177104:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10999.784936] LNet: Removed LNI 192.168.201.57@tcp [11000.820110] Key type .llcrypt unregistered [11000.822738] Key type ._llcrypt unregistered [11024.943253] Key type ._llcrypt registered [11024.947227] Key type .llcrypt registered [11026.608972] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 06:13:23 (1779704003) [11059.652060] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11059.884941] alg: No test for adler32 (adler32-zlib) [11061.219935] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [11061.552518] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [11063.359268] Key type lgssc registered [11064.429534] Lustre: Echo OBD driver; http://www.lustre.org/ [11192.971703] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11199.065519] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11229.449901] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11293.681483] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 06:17:50 (1779704270) [11344.650788] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11349.657119] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11378.394453] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11381.867310] Lustre: Mounted lustre-client [11390.978258] LustreError: 183637:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c142d6f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11391.098156] Lustre: Unmounted lustre-client [11424.542919] Key type lgssc unregistered [11425.021913] LNet: 184042:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11425.046340] LNetError: 184042:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11425.087667] LNet: Removed LNI 192.168.201.57@tcp [11426.388922] Key type .llcrypt unregistered [11426.399122] Key type ._llcrypt unregistered [11455.681382] Key type ._llcrypt registered [11455.691697] Key type .llcrypt registered [11458.365345] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [11461.156206] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 06:20:37 (1779704437) [11490.261190] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11490.332487] alg: No test for adler32 (adler32-zlib) [11491.549112] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [11491.929676] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [11493.671213] Key type lgssc registered [11495.596565] Lustre: Echo OBD driver; http://www.lustre.org/ [11636.916608] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11643.387686] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11676.341742] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [11702.815053] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [11705.878457] Lustre: Mounted lustre-client [11742.007261] LustreError: 189597:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c150b97000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [11742.152552] Lustre: Unmounted lustre-client [11938.755237] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11945.307608] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11977.604706] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12034.311324] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 06:30:10 (1779705010) [12036.553864] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [12039.374742] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 06:30:15 (1779705015) [12172.049764] Key type lgssc unregistered [12172.383964] LNet: 195312:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12172.387655] LNetError: 195312:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12172.400064] LNet: Removed LNI 192.168.201.57@tcp [12173.283566] Key type .llcrypt unregistered [12173.287533] Key type ._llcrypt unregistered [12196.909765] Key type ._llcrypt registered [12196.911615] Key type .llcrypt registered [12198.901908] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 06:32:55 (1779705175) [12258.550965] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12258.583261] alg: No test for adler32 (adler32-zlib) [12259.863254] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [12260.141831] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [12261.879619] Key type lgssc registered [12263.770708] Lustre: Echo OBD driver; http://www.lustre.org/ [12330.261051] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12335.968541] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12378.697897] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12426.239255] Key type lgssc unregistered [12426.785845] LNet: 198970:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12426.801117] LNetError: 198970:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12426.821351] LNet: Removed LNI 192.168.201.57@tcp [12427.954510] Key type .llcrypt unregistered [12427.957253] Key type ._llcrypt unregistered [12453.847152] Key type ._llcrypt registered [12453.857811] Key type .llcrypt registered [12455.834507] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 06:37:12 (1779705432) [12459.730225] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12459.922614] alg: No test for adler32 (adler32-zlib) [12461.153626] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [12461.529329] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [12463.391325] Key type lgssc registered [12465.291225] Lustre: Echo OBD driver; http://www.lustre.org/ [12533.976411] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12540.772368] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12570.351784] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12573.815802] Lustre: Mounted lustre-client [12583.930716] Lustre: lustre-MDT0000-mdc-ffff90c1500a2800: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [12594.160768] Lustre: lustre-MDT0001-mdc-ffff90c1500a2800: Connection to lustre-MDT0001 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [12605.407820] Lustre: 199963:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779705567/real 1779705567] req@00000000f6fda198 x1866156410486784/t0(0) o400->MGC192.168.201.157@tcp@192.168.201.157@tcp:26/25 lens 224/224 e 0 to 1 dl 1779705583 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [12605.455982] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [12630.057409] Lustre: Evicted from MGS (at 192.168.201.157@tcp) after server handle changed from 0x67b95bc0c7c0004d to 0x67b95bc0c7c01991 [12630.089546] Lustre: MGC192.168.201.157@tcp: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [12664.321626] LustreError: lustre-MDT0000-mdc-ffff90c1500a2800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [12664.365490] Lustre: lustre-MDT0000-mdc-ffff90c1500a2800: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [12674.958764] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12678.002757] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12684.154919] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12687.520975] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [12691.696642] LustreError: 203389:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1500a2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12691.851543] Lustre: Unmounted lustre-client [12726.792895] Key type lgssc unregistered [12727.265593] LNet: 203793:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12727.281279] LNetError: 203793:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12727.300344] LNet: Removed LNI 192.168.201.57@tcp [12728.198662] Key type .llcrypt unregistered [12728.200809] Key type ._llcrypt unregistered [12752.278529] Key type ._llcrypt registered [12752.282939] Key type .llcrypt registered [12754.160764] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 06:42:10 (1779705730) [12758.274896] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12758.509995] alg: No test for adler32 (adler32-zlib) [12759.773707] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [12760.058403] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [12761.759214] Key type lgssc registered [12763.890570] Lustre: Echo OBD driver; http://www.lustre.org/ [12831.098746] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12838.551631] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12918.759193] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12924.797950] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12975.072274] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13005.362474] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [13062.463700] Key type lgssc unregistered [13062.833658] LNet: 208927:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13062.851944] LNetError: 208927:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [13062.890962] LNet: Removed LNI 192.168.201.57@tcp [13064.078268] Key type .llcrypt unregistered [13064.081888] Key type ._llcrypt unregistered [13117.781135] Key type ._llcrypt registered [13117.790536] Key type .llcrypt registered [13119.685462] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 06:48:16 (1779706096) [13174.375751] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13174.448195] alg: No test for adler32 (adler32-zlib) [13175.793955] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [13176.150285] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [13177.983579] Key type lgssc registered [13179.993790] Lustre: Echo OBD driver; http://www.lustre.org/ [13305.021708] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13310.599603] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13341.042579] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13395.953764] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 06:52:52 (1779706372) [13407.668342] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 06:53:04 (1779706384) [13457.885346] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13464.590315] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13497.803407] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13500.130650] Lustre: Mounted lustre-client [13507.852970] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [13512.055941] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [13514.733695] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [13517.420607] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [13520.890903] Lustre: lustre-MDT0000-mdc-ffff90c160586000: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [13537.247137] Lustre: 210829:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779706499/real 1779706499] req@00000000d2c8b3c2 x1866157160146816/t0(0) o400->MGC192.168.201.157@tcp@192.168.201.157@tcp:26/25 lens 224/224 e 0 to 1 dl 1779706515 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [13537.303203] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [13547.555619] Lustre: Evicted from MGS (at 192.168.201.157@tcp) after server handle changed from 0x83269790ecc92442 to 0x83269790ecc925b5 [13547.570689] Lustre: MGC192.168.201.157@tcp: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [13553.788834] Lustre: lustre-MDT0000-mdc-ffff90c160586000: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [13566.013952] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13568.957955] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [13573.338450] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [13578.224879] Lustre: lustre-MDT0000-mdc-ffff90c160586000: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [13594.592175] Lustre: 210828:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1779706556/real 1779706556] req@00000000e05e4913 x1866157160156672/t0(0) o400->MGC192.168.201.157@tcp@192.168.201.157@tcp:26/25 lens 224/224 e 0 to 1 dl 1779706572 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [13594.627248] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [13604.865744] Lustre: Evicted from MGS (at 192.168.201.157@tcp) after server handle changed from 0x83269790ecc925b5 to 0x83269790ecc928c5 [13604.880350] Lustre: MGC192.168.201.157@tcp: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [13610.677820] Lustre: lustre-MDT0000-mdc-ffff90c160586000: Connection restored to 192.168.201.157@tcp (at 192.168.201.157@tcp) [13624.697211] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13627.212557] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [13633.576610] LustreError: 219102:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c160586000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13633.706078] Lustre: Unmounted lustre-client [13726.553626] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13733.157310] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13763.116383] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13764.304657] Lustre: Mounted lustre-client [13768.027919] LustreError: 220722:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c15863b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13768.195441] Lustre: Unmounted lustre-client [13806.061670] Key type lgssc unregistered [13806.589420] LNet: 221125:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13806.608686] LNetError: 221125:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [13806.643925] LNet: Removed LNI 192.168.201.57@tcp [13808.013530] Key type .llcrypt unregistered [13808.017420] Key type ._llcrypt unregistered [13832.348050] Key type ._llcrypt registered [13832.351895] Key type .llcrypt registered [13834.491929] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 07:00:10 (1779706810) [13840.540266] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13840.575441] alg: No test for adler32 (adler32-zlib) [13841.917841] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [13842.333370] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [13844.095189] Key type lgssc registered [13846.702062] Lustre: Echo OBD driver; http://www.lustre.org/ [13919.267388] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13925.538267] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13954.321468] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13957.595760] Lustre: Mounted lustre-client [13966.474994] LustreError: 224318:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c146c69000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13966.636704] Lustre: Unmounted lustre-client [14063.152834] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14069.058664] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14098.035880] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14098.741381] Lustre: Mounted lustre-client [14109.529854] LustreError: 225919:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c145788000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14109.683288] Lustre: Unmounted lustre-client [14196.905053] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14202.064866] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14226.752184] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14237.808566] Lustre: Mounted lustre-client [14241.885029] LustreError: 227540:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1475dd000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14242.087438] Lustre: Unmounted lustre-client [14276.213469] Key type lgssc unregistered [14276.631909] LNet: 227945:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14276.642338] LNetError: 227945:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [14276.668204] LNet: Removed LNI 192.168.201.57@tcp [14277.675210] Key type .llcrypt unregistered [14277.677993] Key type ._llcrypt unregistered [14299.407863] Key type ._llcrypt registered [14299.415634] Key type .llcrypt registered [14301.298099] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 07:07:57 (1779707277) [14306.490028] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14306.530852] alg: No test for adler32 (adler32-zlib) [14307.841853] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [14308.326772] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [14310.183458] Key type lgssc registered [14312.114742] Lustre: Echo OBD driver; http://www.lustre.org/ [14377.331772] Key type lgssc unregistered [14377.865623] LNet: 230268:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14377.885634] LNetError: 230268:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [14377.929679] LNet: Removed LNI 192.168.201.57@tcp [14378.848127] Key type .llcrypt unregistered [14378.850131] Key type ._llcrypt unregistered [14415.881342] Key type ._llcrypt registered [14415.886813] Key type .llcrypt registered [14416.730966] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14416.774996] alg: No test for adler32 (adler32-zlib) [14417.890502] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [14418.160644] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [14419.871258] Key type lgssc registered [14421.967701] Lustre: Echo OBD driver; http://www.lustre.org/ [14538.579379] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14544.758124] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14578.665730] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14654.286517] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [14657.080251] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 07:13:53 (1779707633) [14702.250691] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14708.009026] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14736.520814] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14764.981845] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [14767.120490] Lustre: Mounted lustre-client [14772.212225] Lustre: lustre-OST0001-osc-ffff90c160584800: Connection to lustre-OST0001 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [14782.495407] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [14792.918629] Lustre: Unmounted lustre-client [14836.250456] Key type lgssc unregistered [14836.678377] LNet: 237192:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14836.696173] LNetError: 237192:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [14836.731699] LNet: Removed LNI 192.168.201.57@tcp [14838.127756] Key type .llcrypt unregistered [14838.136749] Key type ._llcrypt unregistered [14888.716158] Key type ._llcrypt registered [14888.722139] Key type .llcrypt registered [14891.834642] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 07:17:46 (1779707866) [14913.707277] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14913.774401] alg: No test for adler32 (adler32-zlib) [14915.207574] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [14915.633077] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [14917.447354] Key type lgssc registered [14919.600462] Lustre: Echo OBD driver; http://www.lustre.org/ [14988.837031] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14995.520469] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15026.781435] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 07:20:03 (1779708003) [15073.414526] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15079.031951] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15113.202678] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15115.605565] Lustre: Mounted lustre-client [15129.651810] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [15140.984375] Lustre: Unmounted lustre-client [15282.892934] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15289.669313] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15350.761235] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15351.858592] Lustre: Mounted lustre-client [15355.857291] LustreError: 244237:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c15051c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15356.058426] Lustre: Unmounted lustre-client [15390.300415] Key type lgssc unregistered [15390.752436] LNet: 244642:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15390.764914] LNetError: 244642:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [15390.812889] LNet: Removed LNI 192.168.201.57@tcp [15391.845728] Key type .llcrypt unregistered [15391.847781] Key type ._llcrypt unregistered [15436.929938] Key type ._llcrypt registered [15436.946265] Key type .llcrypt registered [15437.741819] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15437.759809] alg: No test for adler32 (adler32-zlib) [15439.186471] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [15439.731787] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [15441.647675] Key type lgssc registered [15443.933472] Lustre: Echo OBD driver; http://www.lustre.org/ [15573.878791] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15580.443298] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15611.178990] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15670.484714] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [15673.839537] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 07:30:49 (1779708649) [15730.645988] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15737.739547] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15769.073288] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15775.333610] Lustre: Mounted lustre-client [15781.510917] LustreError: 250716:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c146dbb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15781.627656] Lustre: Unmounted lustre-client [15818.231676] Key type lgssc unregistered [15818.665671] LNet: 251119:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15818.688334] LNetError: 251119:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [15818.724923] LNet: Removed LNI 192.168.201.57@tcp [15820.227435] Key type .llcrypt unregistered [15820.233812] Key type ._llcrypt unregistered [15846.621027] Key type ._llcrypt registered [15846.626348] Key type .llcrypt registered [15848.915879] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [15851.475723] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 07:33:47 (1779708827) [15864.384613] Key type .llcrypt unregistered [15864.388121] Key type ._llcrypt unregistered [15877.301764] Key type ._llcrypt registered [15877.307529] Key type .llcrypt registered [15878.407977] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15878.467779] alg: No test for adler32 (adler32-zlib) [15879.810756] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [15880.251827] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [15882.079496] Key type lgssc registered [15884.332191] Lustre: Echo OBD driver; http://www.lustre.org/ [15960.547606] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15981.991709] Lustre: Mounted lustre-client [15986.272554] LustreError: 254149:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1431ec800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15986.459692] Lustre: Unmounted lustre-client [16022.004734] Key type lgssc unregistered [16022.522098] LNet: 254553:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16022.547189] LNetError: 254553:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [16022.590602] LNet: Removed LNI 192.168.201.57@tcp [16023.760556] Key type .llcrypt unregistered [16023.767375] Key type ._llcrypt unregistered [16048.475568] Key type ._llcrypt registered [16048.482518] Key type .llcrypt registered [16050.552484] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 07:37:06 (1779709026) [16053.564679] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16053.766531] alg: No test for adler32 (adler32-zlib) [16055.105105] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [16055.607042] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [16057.735295] Key type lgssc registered [16060.140923] Lustre: Echo OBD driver; http://www.lustre.org/ [16161.592547] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [16212.451239] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [16219.114687] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [16221.005499] Lustre: Mounted lustre-client [16225.308856] LustreError: 257612:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1458c4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [16225.384986] Lustre: Unmounted lustre-client [16270.094382] Key type lgssc unregistered [16270.617833] LNet: 258020:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16270.632931] LNetError: 258020:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [16270.671753] LNet: Removed LNI 192.168.201.57@tcp [16271.875598] Key type .llcrypt unregistered [16271.880119] Key type ._llcrypt unregistered [16300.175655] Key type ._llcrypt registered [16300.181522] Key type .llcrypt registered [16302.360957] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 07:41:18 (1779709278) [16307.451909] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16307.517820] alg: No test for adler32 (adler32-zlib) [16309.185857] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [16309.758029] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [16311.800632] Key type lgssc registered [16313.607364] Lustre: Echo OBD driver; http://www.lustre.org/ [16395.241533] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [16402.066296] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [16433.253184] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [16436.331820] Lustre: Mounted lustre-client [16441.348551] Lustre: lustre-MDT0000-mdc-ffff90c16110c800: Connection to lustre-MDT0000 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [16445.456097] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [16445.506332] LustreError: 261098:0:(file.c:6098:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [16446.191752] LustreError: 261109:0:(file.c:6098:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [16446.218144] LustreError: 261109:0:(file.c:6098:ll_inode_revalidate_fini()) Skipped 3 previous similar messages [16446.382884] LustreError: 261117:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c16110c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [16446.408927] LustreError: MGC192.168.201.157@tcp: Connection to MGS (at 192.168.201.157@tcp) was lost; in progress operations using this service will fail [16446.565053] Lustre: Unmounted lustre-client [16476.505812] Key type lgssc unregistered [16477.049399] LNet: 261513:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16477.054890] LNetError: 261513:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [16478.118340] LNet: Removed LNI 192.168.201.57@tcp [16479.285482] Key type .llcrypt unregistered [16479.288609] Key type ._llcrypt unregistered [16504.519334] Key type ._llcrypt registered [16504.534602] Key type .llcrypt registered [16506.876632] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 07:44:42 (1779709482) [16511.263277] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16511.315270] alg: No test for adler32 (adler32-zlib) [16512.720194] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [16513.235889] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [16515.231186] Key type lgssc registered [16517.646931] Lustre: Echo OBD driver; http://www.lustre.org/ [16588.012548] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [16595.769967] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [16624.267227] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [16627.333187] Lustre: Mounted lustre-client [16632.302425] Lustre: lustre-MDT0001-mdc-ffff90c1475c2000: Connection to lustre-MDT0001 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [16636.414268] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [16640.754233] LustreError: 264614:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1475c2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [16640.920401] Lustre: Unmounted lustre-client [16669.149306] Key type lgssc unregistered [16669.496055] LNet: 265009:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16669.505345] LNetError: 265009:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [16669.534057] LNet: Removed LNI 192.168.201.57@tcp [16670.612065] Key type .llcrypt unregistered [16670.614851] Key type ._llcrypt unregistered [16694.190607] Key type ._llcrypt registered [16694.193177] Key type .llcrypt registered [16696.372241] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 07:47:52 (1779709672) [16723.742085] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16723.764966] alg: No test for adler32 (adler32-zlib) [16724.819395] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [16725.084189] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [16726.823489] Key type lgssc registered [16728.703942] Lustre: Echo OBD driver; http://www.lustre.org/ [16886.877533] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [16889.808060] Lustre: Mounted lustre-client [16943.107155] Lustre: lustre-MDT0001-mdc-ffff90c16034d800: Connection to lustre-MDT0001 (at 192.168.201.157@tcp) was lost; in progress operations using this service will wait for recovery to complete [16956.150897] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [16966.562897] Lustre: Unmounted lustre-client [17009.813133] Key type lgssc unregistered [17010.430684] LNet: 270784:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17010.465861] LNetError: 270784:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [17010.486906] LNet: Removed LNI 192.168.201.57@tcp [17012.277736] Key type .llcrypt unregistered [17012.280979] Key type ._llcrypt unregistered [17040.017516] Key type ._llcrypt registered [17040.022426] Key type .llcrypt registered [17042.038883] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 07:53:38 (1779710018) [17044.955706] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [17047.988265] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 07:53:43 (1779710023) [17051.619865] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [17054.691606] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 07:53:50 (1779710030) [17058.199381] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [17061.613979] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 07:53:57 (1779710037) [17064.890052] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [17068.047314] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 07:54:03 (1779710043) [17071.585857] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [17074.893712] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 07:54:11 (1779710051) [17087.963821] Key type .llcrypt unregistered [17087.965627] Key type ._llcrypt unregistered [17099.869594] Key type ._llcrypt registered [17099.872096] Key type .llcrypt registered [17100.802729] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [17100.821889] alg: No test for adler32 (adler32-zlib) [17102.769980] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [17103.278958] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [17105.271410] Key type lgssc registered [17108.332707] Lustre: Echo OBD driver; http://www.lustre.org/ [17212.065516] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [17218.034804] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [17246.571246] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [17249.499739] Lustre: Mounted lustre-client [17253.884144] LustreError: 276398:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c150aca000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [17253.998341] Lustre: Unmounted lustre-client [17300.583627] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 07:57:57 (1779710277) [17345.634580] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [17351.203420] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [17389.922760] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [17391.142899] Lustre: Mounted lustre-client [17394.574890] LustreError: 278518:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c1607f9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [17394.799830] Lustre: Unmounted lustre-client [17443.363369] LNet: 1 local NIs in recovery (showing 1): 192.168.201.57@tcp [17446.348887] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 08:00:22 (1779710422) [18135.389696] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [18141.595170] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [18184.791106] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [18328.638318] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 08:15:04 (1779711304) [18345.760279] Key type lgssc unregistered [18346.191678] LNet: 284097:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18346.209055] LNetError: 284097:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [18346.248737] LNet: Removed LNI 192.168.201.57@tcp [18347.402146] Key type .llcrypt unregistered [18347.406271] Key type ._llcrypt unregistered [18497.282461] Key type ._llcrypt registered [18497.286547] Key type .llcrypt registered [18498.240448] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [18498.265484] alg: No test for adler32 (adler32-zlib) [18499.759036] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [18500.308664] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [18502.279640] Key type lgssc registered [18504.439638] Lustre: Echo OBD driver; http://www.lustre.org/ [18622.458087] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [18629.044675] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [18658.028015] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [18700.318636] Key type lgssc unregistered [18700.931513] LNet: 287725:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18700.944213] LNetError: 287725:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [18700.985958] LNet: Removed LNI 192.168.201.57@tcp [18702.298812] Key type .llcrypt unregistered [18702.310922] Key type ._llcrypt unregistered [18746.359510] Key type ._llcrypt registered [18746.363408] Key type .llcrypt registered [18748.770436] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 08:22:04 (1779711724) [18780.082270] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [18780.156489] alg: No test for adler32 (adler32-zlib) [18781.546500] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [18782.194439] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [18784.055566] Key type lgssc registered [18785.836598] Lustre: Echo OBD driver; http://www.lustre.org/ [18863.698541] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 08:23:59 (1779711839) [18885.878532] Key type lgssc unregistered [18886.336949] LNet: 291291:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18886.350375] LNetError: 291291:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [18886.368077] LNet: Removed LNI 192.168.201.57@tcp [18887.475760] Key type .llcrypt unregistered [18887.479606] Key type ._llcrypt unregistered [18905.127555] Key type ._llcrypt registered [18905.133062] Key type .llcrypt registered [18905.915776] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [18905.961363] alg: No test for adler32 (adler32-zlib) [18907.557865] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [18908.124513] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [18910.031279] Key type lgssc registered [18912.080491] Lustre: Echo OBD driver; http://www.lustre.org/ [18986.502297] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [18992.378304] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [19020.869879] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [19393.511859] LNet: Added LNI 192.168.201.57@tcp50 [8/256/0/180] [19397.772848] LNet: Removed LNI 192.168.201.57@tcp [19400.500214] Lustre: 295641:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff90c14462b000: config has no valid NIDs, force dynamic NIDs [19401.754049] Lustre: Mounted lustre-client [19401.869709] LustreError: 295650:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c14462b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [19401.958454] Lustre: Unmounted lustre-client [19406.361252] Key type lgssc unregistered [19406.811299] LNet: 295900:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [19406.845963] LNetError: 295900:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [19406.877851] LNet: Removed LNI 192.168.201.57@tcp50 [19407.665402] Key type .llcrypt unregistered [19407.667322] Key type ._llcrypt unregistered [19433.749490] Key type ._llcrypt registered [19433.756977] Key type .llcrypt registered [19434.836975] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [19434.856725] alg: No test for adler32 (adler32-zlib) [19436.102571] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [19436.502898] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [19438.295226] Key type lgssc registered [19440.170143] Lustre: Echo OBD driver; http://www.lustre.org/ [19502.419972] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [19508.863641] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [19521.798222] LNet: Added LNI 192.168.201.57@tcp50 [8/256/0/180] [19523.158829] LNet: Removed LNI 192.168.201.57@tcp [19524.421300] Lustre: 298540:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff90c15863c800: config has no valid NIDs, force dynamic NIDs [19525.709189] Lustre: Mounted lustre-client [19526.381062] LustreError: 298570:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c15863c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [19526.560230] Lustre: Unmounted lustre-client [19573.640865] Key type lgssc unregistered [19574.098773] LNet: 299412:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [19574.110541] LNetError: 299412:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [19574.128730] LNet: Removed LNI 192.168.201.57@tcp50 [19575.088123] Key type .llcrypt unregistered [19575.095743] Key type ._llcrypt unregistered [19594.858371] Key type ._llcrypt registered [19594.862153] Key type .llcrypt registered [19597.521825] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 08:36:13 (1779712573) [19630.001694] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [19630.029957] alg: No test for adler32 (adler32-zlib) [19631.463963] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [19631.866101] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [19633.641240] Key type lgssc registered [19635.322913] Lustre: Echo OBD driver; http://www.lustre.org/ [19754.215458] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [19760.858618] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [19792.115606] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [19845.322893] Key type lgssc unregistered [19845.882963] LNet: 304090:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [19845.888755] LNetError: 304090:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [19845.905775] LNet: Removed LNI 192.168.201.57@tcp [19847.463971] Key type .llcrypt unregistered [19847.467139] Key type ._llcrypt unregistered [19865.433793] Key type ._llcrypt registered [19865.437609] Key type .llcrypt registered [19867.782191] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 08:40:43 (1779712843) [19872.394705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [19872.443377] alg: No test for adler32 (adler32-zlib) [19873.647843] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [19873.890216] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [19875.623220] Key type lgssc registered [19877.959818] Lustre: Echo OBD driver; http://www.lustre.org/ [19953.308230] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [19958.380524] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [19985.682119] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [19992.199717] Lustre: Mounted lustre-client [20071.958472] Lustre: Mounted fs15246-client [20094.201079] LustreError: 308248:0:(lov_obd.c:792:lov_cleanup()) fs15246-clilov-ffff90c145f5f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [20094.313299] Lustre: Unmounted fs15246-client [20129.128825] LustreError: 308467:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90c143093000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [20129.239888] Lustre: Unmounted lustre-client [20164.026673] Key type lgssc unregistered [20164.500138] LNet: 308871:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [20164.509676] LNetError: 308871:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [20164.530877] LNet: Removed LNI 192.168.201.57@tcp [20165.300602] Key type .llcrypt unregistered [20165.303299] Key type ._llcrypt unregistered [20179.605727] Key type ._llcrypt registered [20179.607981] Key type .llcrypt registered [20181.360846] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 08:45:57 (1779713157) [20183.897757] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [20183.931803] alg: No test for adler32 (adler32-zlib) [20185.143094] Lustre: Lustre: Build Version: 2.17.53_24_gacb3840 [20185.504881] LNet: Added LNI 192.168.201.57@tcp [8/256/0/180] [20187.281783] Key type lgssc registered [20188.915385] Lustre: Echo OBD driver; http://www.lustre.org/ [20373.337575] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [20378.856391] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [20408.413707] Lustre: DEBUG MARKER: oleg157-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [20545.903177] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 20120 sec ========= 08:52:02 (1779713522) [20548.469608] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 08:52:04 (1779713524) === [20553.654705] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 08:52:09 (1779713529) === [20606.558588] Key type lgssc unregistered [20607.049330] LNet: 318061:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [20607.065315] LNetError: 318061:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [20607.096968] LNet: Removed LNI 192.168.201.57@tcp [20608.162705] Key type .llcrypt unregistered [20608.169596] Key type ._llcrypt unregistered