[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-8.fc42 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 459482214 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2421 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE22BD 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 00227D (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2331 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE23C1 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE23F9 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe22bd-0xbffe2330] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22bc] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2331-0xbffe23c0] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe23c1-0xbffe23f8] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe23f9-0xbffe2420] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/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.001014] APIC: Switch to symmetric I/O mode setup [ 0.002376] x2apic enabled [ 0.003012] Switched APIC routing to physical x2apic. [ 0.004016] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007028] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009009] pid_max: default: 32768 minimum: 301 [ 0.010144] LSM: Security Framework initializing [ 0.011052] Yama: becoming mindful. [ 0.012036] SELinux: Initializing. [ 0.013074] *** VALIDATE selinux *** [ 0.022228] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026833] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028133] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030029] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032052] *** VALIDATE tmpfs *** [ 0.033560] *** VALIDATE proc *** [ 0.035273] *** VALIDATE cgroup *** [ 0.036012] *** VALIDATE cgroup2 *** [ 0.038162] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.039185] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040015] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041039] Spectre V2 : User space: Vulnerable [ 0.042013] Speculative Store Bypass: Vulnerable [ 0.045705] debug: unmapping init [mem 0xffffffff9ea59000-0xffffffff9ea60fff] [ 0.047224] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048817] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049029] ... version: 2 [ 0.050017] ... bit width: 48 [ 0.051016] ... generic registers: 4 [ 0.052016] ... value mask: 0000ffffffffffff [ 0.053018] ... max period: 00007fffffffffff [ 0.054019] ... fixed-purpose events: 3 [ 0.055015] ... event mask: 000000070000000f [ 0.057285] rcu: Hierarchical SRCU implementation. [ 0.059697] smp: Bringing up secondary CPUs ... [ 0.060685] x86: Booting SMP configuration: [ 0.061039] .... node #0, CPUs: #1 #2 #3 [ 0.067264] smp: Brought up 1 node, 4 CPUs [ 0.069028] smpboot: Max logical packages: 1 [ 0.070017] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.212434] node 0 deferred pages initialised in 140ms [ 0.217223] devtmpfs: initialized [ 0.220269] x86/mm: Memory block size: 128MB [ 0.223656] gcov: version magic: 0x41383552 [ 0.225483] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.226096] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.227430] pinctrl core: initialized pinctrl subsystem [ 0.228302] [ 0.229010] ************************************************************* [ 0.230020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.231027] ** ** [ 0.232027] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.233025] ** ** [ 0.234033] ** This means that this kernel is built to expose internal ** [ 0.235019] ** IOMMU data structures, which may compromise security on ** [ 0.236025] ** your system. ** [ 0.237017] ** ** [ 0.238022] ** If you see this message and you are not debugging the ** [ 0.239019] ** kernel, report this immediately to your vendor! ** [ 0.240027] ** ** [ 0.241021] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.242023] ************************************************************* [ 0.248225] NET: Registered protocol family 16 [ 0.249762] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.250093] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.251090] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.253489] cpuidle: using governor menu [ 0.255487] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.257127] PCI: Using configuration type 1 for base access [ 0.258141] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.277056] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.278038] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.281191] cryptd: max_cpu_qlen set to 1000 [ 0.284494] ACPI: Added _OSI(Module Device) [ 0.288023] ACPI: Added _OSI(Processor Device) [ 0.294030] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.295027] ACPI: Added _OSI(Processor Aggregator Device) [ 0.308775] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.325432] ACPI: Interpreter enabled [ 0.331094] ACPI: PM: (supports S0 S3 S4 S5) [ 0.333018] ACPI: Using IOAPIC for interrupt routing [ 0.334000] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.340936] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.366300] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.370117] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.375025] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.382119] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.401046] acpiphp: Slot [2] registered [ 0.407000] acpiphp: Slot [5] registered [ 0.408332] acpiphp: Slot [6] registered [ 0.410617] acpiphp: Slot [3] registered [ 0.412151] acpiphp: Slot [4] registered [ 0.420064] acpiphp: Slot [7] registered [ 0.421164] acpiphp: Slot [8] registered [ 0.428029] acpiphp: Slot [9] registered [ 0.433171] acpiphp: Slot [10] registered [ 0.437326] acpiphp: Slot [11] registered [ 0.440246] acpiphp: Slot [12] registered [ 0.441000] acpiphp: Slot [13] registered [ 0.441000] acpiphp: Slot [14] registered [ 0.448813] acpiphp: Slot [15] registered [ 0.452390] acpiphp: Slot [16] registered [ 0.455167] acpiphp: Slot [17] registered [ 0.460184] acpiphp: Slot [18] registered [ 0.464111] acpiphp: Slot [19] registered [ 0.469172] acpiphp: Slot [20] registered [ 0.473662] acpiphp: Slot [21] registered [ 0.478163] acpiphp: Slot [22] registered [ 0.479161] acpiphp: Slot [23] registered [ 0.480132] acpiphp: Slot [24] registered [ 0.481000] acpiphp: Slot [25] registered [ 0.482185] acpiphp: Slot [26] registered [ 0.485550] acpiphp: Slot [27] registered [ 0.490547] acpiphp: Slot [28] registered [ 0.495220] acpiphp: Slot [29] registered [ 0.498464] acpiphp: Slot [30] registered [ 0.502891] acpiphp: Slot [31] registered [ 0.507118] PCI host bridge to bus 0000:00 [ 0.509037] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.512053] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.516064] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.521217] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.524032] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.528044] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.531269] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.536623] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.549000] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.562019] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.567007] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.569036] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.574026] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.576017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.579084] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.581719] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.584049] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.586138] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.596017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.613020] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.624021] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.633889] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.641017] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.649019] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.680021] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.691093] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.699022] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.709019] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.730020] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.743000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.743000] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.743473] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.746413] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.748371] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.753204] iommu: Default domain type: Passthrough [ 0.757658] SCSI subsystem initialized [ 0.759271] ACPI: bus type USB registered [ 0.762258] usbcore: registered new interface driver usbfs [ 0.765195] usbcore: registered new interface driver hub [ 0.767130] usbcore: registered new device driver usb [ 0.769441] pps_core: LinuxPPS API ver. 1 registered [ 0.772019] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.777159] PTP clock support registered [ 0.780192] EDAC MC: Ver: 3.0.0 [ 0.781228] PCI: Using ACPI for IRQ routing [ 0.782000] NetLabel: Initializing [ 0.783013] NetLabel: domain hash size = 128 [ 0.785014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.787103] NetLabel: unlabeled traffic allowed by default [ 0.791181] vgaarb: loaded [ 0.793124] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.796015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.803305] clocksource: Switched to clocksource kvm-clock [ 0.954671] VFS: Disk quotas dquot_6.6.0 [ 0.956763] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.960070] *** VALIDATE ramfs *** [ 0.961788] *** VALIDATE hugetlbfs *** [ 0.963866] pnp: PnP ACPI init [ 0.967884] pnp: PnP ACPI: found 6 devices [ 0.987563] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.992411] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.998069] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.001895] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.006792] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.010175] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 1.013903] NET: Registered protocol family 2 [ 1.018249] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 1.026753] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 1.032805] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 1.041877] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 1.047498] TCP: Hash tables configured (established 65536 bind 65536) [ 1.052562] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 1.058040] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.063393] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.073892] NET: Registered protocol family 1 [ 1.077643] RPC: Registered named UNIX socket transport module. [ 1.080968] RPC: Registered udp transport module. [ 1.084249] RPC: Registered tcp transport module. [ 1.087141] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.091140] NET: Registered protocol family 44 [ 1.093947] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.097741] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.100705] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.105187] PCI: CLS 0 bytes, default 64 [ 1.106959] Unpacking initramfs... [ 4.040839] debug: unmapping init [mem 0xffff96983cc64000-0xffff96983ffcffff] [ 4.053099] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 4.061616] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 4.066518] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 5.972879] Initialise system trusted keyrings [ 5.981167] Key type blacklist registered [ 5.992172] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 6.026853] zbud: loaded [ 6.042805] *** VALIDATE nfs *** [ 6.050582] *** VALIDATE nfs4 *** [ 6.056495] pstore: using deflate compression [ 6.076347] Platform Keyring initialized [ 6.557945] NET: Registered protocol family 38 [ 6.560744] Key type asymmetric registered [ 6.562700] Asymmetric key parser 'x509' registered [ 6.565015] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 6.569451] io scheduler mq-deadline registered [ 6.571388] io scheduler kyber registered [ 6.574411] io scheduler bfq registered [ 6.577881] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 6.587691] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 6.594657] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.603484] ACPI: Power Button [PWRF] [ 6.614632] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 6.631074] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 6.671826] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 6.735690] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 6.810190] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 6.850519] Non-volatile memory driver v1.3 [ 6.856920] Linux agpgart interface v0.103 [ 7.021779] virtio_blk virtio1: [vda] 134712 512-byte logical blocks (69.0 MB/65.8 MiB) [ 7.025746] vda: detected capacity change from 0 to 68972544 [ 7.103826] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 7.119482] vdb: detected capacity change from 0 to 1073741824 [ 7.148978] libphy: Fixed MDIO Bus: probed [ 7.172097] usbcore: registered new interface driver usbserial_generic [ 7.181159] usbserial: USB Serial support registered for generic [ 7.191216] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 7.204792] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 7.206800] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 7.211152] mousedev: PS/2 mouse device common for all mice [ 7.217351] rtc_cmos 00:05: RTC can wake from S4 [ 7.229661] rtc_cmos 00:05: registered as rtc0 [ 7.236314] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 7.237112] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 7.247211] intel_pstate: CPU model not supported [ 7.268946] hpet1: lost 1 rtc interrupts [ 7.286423] hid: raw HID events driver (C) Jiri Kosina [ 7.298547] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 7.299477] usbcore: registered new interface driver usbhid [ 7.325317] usbhid: USB HID core driver [ 7.326874] drop_monitor: Initializing network drop monitor service [ 7.342163] Initializing XFRM netlink socket [ 7.348095] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 7.352156] NET: Registered protocol family 10 [ 7.365040] Segment Routing with IPv6 [ 7.393298] NET: Registered protocol family 17 [ 7.405708] mpls_gso: MPLS GSO support [ 7.416473] RAS: Correctable Errors collector initialized. [ 7.435637] AVX version of gcm_enc/dec engaged. [ 7.441883] AES CTR mode by8 optimization enabled [ 7.816352] sched_clock: Marking stable (7816318848, 0)->(8967606069, -1151287221) [ 7.827370] registered taskstats version 1 [ 7.851258] Loading compiled-in X.509 certificates [ 7.853457] zswap: loaded using pool lzo/zbud [ 7.996059] Key type big_key registered [ 8.049149] Key type encrypted registered [ 8.052325] ima: No TPM chip found, activating TPM-bypass! [ 8.055628] ima: Allocated hash algorithm: sha1 [ 8.058597] ima: No architecture policies found [ 8.061487] evm: Initialising EVM extended attributes: [ 8.065580] evm: security.selinux [ 8.067529] evm: security.ima [ 8.069334] evm: security.capability [ 8.071830] evm: HMAC attrs: 0x1 [ 8.079442] rtc_cmos 00:05: setting system clock to 2026-03-02 16:49:23 UTC (1772470163) [ 8.104730] debug: unmapping init [mem 0xffffffff9fa03000-0xffffffff9fbfffff] [ 8.114321] debug: unmapping init [mem 0xffffffff9e782000-0xffffffff9ea58fff] [ 8.135415] Write protecting the kernel read-only data: 28672k [ 8.142905] debug: unmapping init [mem 0xffffffff9ce03000-0xffffffff9cffffff] [ 8.153716] debug: unmapping init [mem 0xffffffff9d714000-0xffffffff9d7fffff] [ 8.343350] 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) [ 8.380967] systemd[1]: Detected virtualization kvm. [ 8.409630] systemd[1]: Detected architecture x86-64. [ 8.413480] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 8.518879] systemd[1]: No hostname configured. [ 8.533581] systemd[1]: Set hostname to . [ 8.545720] random: systemd: uninitialized urandom read (16 bytes read) [ 8.560965] systemd[1]: Initializing machine ID from random generator. [ 8.783346] random: ln: uninitialized urandom read (6 bytes read) [ 9.241985] random: systemd: uninitialized urandom read (16 bytes read) [ 9.262517] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 9.306866] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 9.340871] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Swap. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 11.445041] device-mapper: uevent: version 1.0.3 [ 11.452877] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 14.420292] random: fast init done Starting dracut initqueue hook... [ 14.554955] virtio_net virtio0 ens2: renamed from eth0 [ 14.942362] scsi host0: ata_piix [ 14.976872] scsi host1: ata_piix [ 14.988106] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 15.002215] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 20.590370] random: crng init done [ 20.592450] random: 7 urandom warning(s) missed due to ratelimiting [ 22.483830] dracut-initqueue[586]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 24.987819] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 27.669400] printk: systemd: 26 output lines suppressed due to ratelimiting [ 28.509525] SELinux: Disabled at runtime. [ 28.683507] 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) [ 28.712779] systemd[1]: Detected virtualization kvm. [ 28.718917] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 31.170663] systemd[1]: initrd-switch-root.service: Succeeded. [ 31.180237] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 31.224111] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 31.236946] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 31.256050] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 31.289345] systemd[1]: Starting Journal Service... Starting Journal Service... [ 31.318982] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice User and Session Slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Apply Kernel Variables... [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... Mounting Huge Pages File System... [ 31.971279] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting POSIX Message Queue File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 33.591388] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 35.149610] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 35.269777] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 36.409288] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 36.482745] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 41.080608] Key type dns_resolver registered [ *** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit)[ 42.143883] NFS: Registering the id_resolver key type [ 42.147876] Key type id_resolver registered [ 42.151649] Key type id_legacy registered [ ***] A start job is running for Configur…only root support (11s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. [ OK ] Reached target sshd-keygen.target. Starting Restore /run/initramfs on shutdown... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Network Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Login Service. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. [ 50.998014] hrtimer: interrupt took 3388728 ns 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 System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg221-client login: [ 117.574529] libcfs: loading out-of-tree module taints kernel. [ 117.938475] Key type ._llcrypt registered [ 117.941432] Key type .llcrypt registered [ 118.641152] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 118.666949] alg: No test for adler32 (adler32-zlib) [ 120.631964] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 122.082992] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 123.895294] Key type lgssc registered [ 125.982507] Lustre: Echo OBD driver; http://www.lustre.org/ [ 316.687745] Lustre: Mounted lustre-client [ 322.318238] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 342.497323] Lustre: lustre-OST0000-osc-ffff969882c06800: disconnect after 23s idle [ 343.431330] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing check_logdir /tmp/testlogs/ [ 349.288546] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing yml_node [ 354.586962] Lustre: DEBUG MARKER: Client: 2.17.50.194 [ 357.471950] Lustre: DEBUG MARKER: MDS: 2.17.50.194 [ 361.514698] Lustre: DEBUG MARKER: OSS: 2.17.50.194 [ 363.428665] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Mar 2 11:55:17 EST 2026 [ 383.043783] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 384.642651] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 388.434781] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 398.786185] Lustre: Unmounted lustre-client [ 528.356454] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 533.100765] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 557.605862] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 607.502157] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 11:59:21 (1772470761) [ 610.063956] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 611.823694] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 11:59:25 (1772470765) [ 650.831401] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 654.676592] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 681.386841] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 682.435517] Lustre: Mounted lustre-client [ 687.269804] LustreError: 14457:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 687.470767] Lustre: Unmounted lustre-client [ 723.022267] Key type lgssc unregistered [ 723.741153] LNet: 14880:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 723.773991] LNetError: 14880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 723.806437] LNet: Removed LNI 192.168.202.21@tcp [ 725.113171] Key type .llcrypt unregistered [ 725.116913] Key type ._llcrypt unregistered [ 745.932668] Key type ._llcrypt registered [ 745.941576] Key type .llcrypt registered [ 747.788128] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 12:01:41 (1772470901) [ 749.293536] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 749.501697] alg: No test for adler32 (adler32-zlib) [ 750.798590] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 751.166210] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 752.935609] Key type lgssc registered [ 754.395796] Lustre: Echo OBD driver; http://www.lustre.org/ [ 845.176215] Lustre: Mounted lustre-client [ 937.098701] LustreError: 18213:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883511000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 937.168817] Lustre: Unmounted lustre-client [ 968.637975] Key type lgssc unregistered [ 969.079800] LNet: 18678:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 969.094593] LNetError: 18678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 969.119108] LNet: Removed LNI 192.168.202.21@tcp [ 969.938861] Key type .llcrypt unregistered [ 969.941755] Key type ._llcrypt unregistered [ 982.796555] Key type ._llcrypt registered [ 982.799244] Key type .llcrypt registered [ 984.518086] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 12:05:37 (1772471137) [ 986.793654] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 986.844658] alg: No test for adler32 (adler32-zlib) [ 988.114533] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 988.429404] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 990.119160] Key type lgssc registered [ 991.815483] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1051.417394] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1057.153665] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1081.577672] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1084.684459] Lustre: Mounted lustre-client [ 1098.614704] LustreError: 21795:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883543000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1098.687195] Lustre: Unmounted lustre-client [ 1127.254201] Key type lgssc unregistered [ 1127.439731] LNet: 22199:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1127.445565] LNetError: 22199:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1127.472924] LNet: Removed LNI 192.168.202.21@tcp [ 1128.143041] Key type .llcrypt unregistered [ 1128.146776] Key type ._llcrypt unregistered [ 1139.540971] Key type ._llcrypt registered [ 1139.543755] Key type .llcrypt registered [ 1141.038996] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 12:08:14 (1772471294) [ 1144.207943] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1144.286082] alg: No test for adler32 (adler32-zlib) [ 1145.384712] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 1145.764348] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 1147.527165] Key type lgssc registered [ 1148.990455] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1210.292223] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1215.293740] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1237.880912] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1240.676388] Lustre: Mounted lustre-client [ 1250.268276] LustreError: 24916:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969882a83800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1250.414472] Lustre: Unmounted lustre-client [ 1282.627488] Key type lgssc unregistered [ 1283.131312] LNet: 25321:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1283.163627] LNetError: 25321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1283.205753] LNet: Removed LNI 192.168.202.21@tcp [ 1284.373221] Key type .llcrypt unregistered [ 1284.377289] Key type ._llcrypt unregistered [ 1302.888811] Key type ._llcrypt registered [ 1302.892483] Key type .llcrypt registered [ 1304.208497] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 12:10:58 (1772471458) [ 1308.160030] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1308.250764] alg: No test for adler32 (adler32-zlib) [ 1309.496864] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 1309.825748] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 1311.615238] Key type lgssc registered [ 1313.302749] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1376.478335] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1382.138371] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1406.610255] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1413.749131] Lustre: Mounted lustre-client [ 1423.851281] Lustre: lustre-MDT0000-mdc-ffff969882e7f000: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1434.090847] Lustre: lustre-MDT0001-mdc-ffff969882e7f000: Connection to lustre-MDT0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1445.343338] Lustre: 26281:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772471584/real 1772471584] req@0000000098345122 x1858571038890240/t0(0) o400->MGC192.168.202.121@tcp@192.168.202.121@tcp:26/25 lens 224/224 e 0 to 1 dl 1772471600 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1445.384387] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 1446.863476] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1457.247571] Lustre: Unmounted lustre-client [ 1471.853941] Key type lgssc unregistered [ 1472.087321] LNet: 28901:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1472.097638] LNetError: 28901:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1473.129250] LNet: Removed LNI 192.168.202.21@tcp [ 1474.045420] Key type .llcrypt unregistered [ 1474.054500] Key type ._llcrypt unregistered [ 1495.109869] Key type ._llcrypt registered [ 1495.113417] Key type .llcrypt registered [ 1496.311372] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 12:14:10 (1772471650) [ 1499.606802] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1499.632603] alg: No test for adler32 (adler32-zlib) [ 1500.933283] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 1501.231688] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 1503.015166] Key type lgssc registered [ 1504.335683] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1560.409110] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1564.764564] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1587.010722] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1589.200336] Lustre: Mounted lustre-client [ 1594.348779] Lustre: lustre-OST0000-osc-ffff9698834c7000: Connection to lustre-OST0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1602.763237] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1613.161667] Lustre: Unmounted lustre-client [ 1640.636593] Key type lgssc unregistered [ 1641.032879] LNet: 32434:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1641.041950] LNetError: 32434:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1642.088863] LNet: Removed LNI 192.168.202.21@tcp [ 1643.071364] Key type .llcrypt unregistered [ 1643.074302] Key type ._llcrypt unregistered [ 1660.177748] Key type ._llcrypt registered [ 1660.179403] Key type .llcrypt registered [ 1661.633171] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 12:16:55 (1772471815) [ 1664.799650] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1664.864593] alg: No test for adler32 (adler32-zlib) [ 1666.089182] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 1666.382254] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 1668.079259] Key type lgssc registered [ 1669.643877] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1731.678194] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1738.221874] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1758.821937] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1771.089899] Lustre: Mounted lustre-client [ 1774.766073] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1778.968470] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1790.484578] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-03-0212h19m04s [ 1794.208528] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1796.584896] Lustre: lustre-MDT0000-mdc-ffff969887050000: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1804.398819] LustreError: 36143:0:(lmv_obd.c:1434:lmv_statfs()) lustre-MDT0000-mdc-ffff969887050000: can't stat MDS #0: rc = -19 [ 1805.976885] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1814.008434] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 1814.039111] Lustre: Evicted from MGS (at 192.168.202.121@tcp) after server handle changed from 0x7a471aa0e48564ce to 0x7a471aa0e485686a [ 1814.067598] Lustre: MGC192.168.202.121@tcp: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 1815.096983] LustreError: lustre-MDT0000-mdc-ffff969887050000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1815.124596] Lustre: lustre-MDT0000-mdc-ffff969887050000: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 1822.894713] Lustre: DEBUG MARKER: Wait for df (36143) ... [ 1824.523443] Lustre: DEBUG MARKER: done [ 1827.587635] LustreError: 36761:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969887050000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1827.680047] Lustre: Unmounted lustre-client [ 1857.454859] Key type lgssc unregistered [ 1857.728771] LNet: 37165:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1857.736848] LNetError: 37165:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1857.762996] LNet: Removed LNI 192.168.202.21@tcp [ 1858.582839] Key type .llcrypt unregistered [ 1858.585467] Key type ._llcrypt unregistered [ 1892.791603] Key type ._llcrypt registered [ 1892.793210] Key type .llcrypt registered [ 1894.308880] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 12:20:48 (1772472048) [ 1896.768332] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1896.953263] alg: No test for adler32 (adler32-zlib) [ 1898.012946] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 1898.220503] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 1899.879356] Key type lgssc registered [ 1901.417491] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1955.126229] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1959.398256] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1981.479230] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1984.292609] Lustre: Mounted lustre-client [ 1989.069594] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-03-0212h22m23s [ 1990.943821] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1999.562473] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 2001.733667] Lustre: DEBUG MARKER: Creating a test file and stat it [ 2022.367900] Lustre: 41238:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772472157/real 1772472157] req@0000000015402107 x1858571655453440/t0(0) o101->lustre-MDT0000-mdc-ffff9698834c2800@192.168.202.121@tcp:12/10 lens 576/1152 e 0 to 1 dl 1772472177 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 2022.387882] Lustre: lustre-MDT0000-mdc-ffff9698834c2800: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2022.433643] Lustre: lustre-MDT0000-mdc-ffff9698834c2800: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 2044.434709] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 2047.851984] Lustre: DEBUG MARKER: done [ 2052.729234] LustreError: 41712:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698834c2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2052.850601] Lustre: Unmounted lustre-client [ 2081.727854] Key type lgssc unregistered [ 2082.032435] LNet: 42116:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2082.038515] LNetError: 42116:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2082.065856] LNet: Removed LNI 192.168.202.21@tcp [ 2082.974361] Key type .llcrypt unregistered [ 2082.977536] Key type ._llcrypt unregistered [ 2118.122377] Key type ._llcrypt registered [ 2118.125677] Key type .llcrypt registered [ 2119.571850] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 12:24:33 (1772472273) [ 2121.270820] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2123.053833] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 12:24:37 (1772472277) [ 2127.372102] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2127.455465] alg: No test for adler32 (adler32-zlib) [ 2128.576619] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 2128.784038] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 2130.505348] Key type lgssc registered [ 2132.203557] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2160.635850] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 12:25:14 (1772472314) [ 2196.395084] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2200.714458] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2218.354963] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2221.125454] Lustre: Mounted lustre-client [ 2224.379280] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2227.644576] LustreError: 46470:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969885195000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2227.802773] Lustre: Unmounted lustre-client [ 2244.445824] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2289.514597] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2293.737995] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2294.536308] Lustre: Mounted lustre-client [ 2299.430662] LustreError: 47730:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883c80000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2299.588536] Lustre: Unmounted lustre-client [ 2367.916928] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2372.253921] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2373.248659] Lustre: Mounted lustre-client [ 2377.054937] LustreError: 48853:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883002000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2377.170881] Lustre: Unmounted lustre-client [ 2399.328795] Lustre: DEBUG MARKER: files compared the same [ 2422.636472] Key type lgssc unregistered [ 2422.984268] LNet: 49562:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2422.997652] LNetError: 49562:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2423.016962] LNet: Removed LNI 192.168.202.21@tcp [ 2423.905162] Key type .llcrypt unregistered [ 2423.908951] Key type ._llcrypt unregistered [ 2440.922834] Key type ._llcrypt registered [ 2440.927754] Key type .llcrypt registered [ 2442.338257] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 12:29:56 (1772472596) [ 2445.132514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2445.163930] alg: No test for adler32 (adler32-zlib) [ 2446.279379] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 2446.487779] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 2448.191197] Key type lgssc registered [ 2449.806746] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2498.680651] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2503.619845] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2527.963415] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2529.659744] Lustre: Mounted lustre-client [ 2534.584405] LustreError: 52663:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969893653000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2534.703815] Lustre: Unmounted lustre-client [ 2571.918680] Key type lgssc unregistered [ 2572.179775] LNet: 53068:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2572.185884] LNetError: 53068:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2572.207535] LNet: Removed LNI 192.168.202.21@tcp [ 2572.871261] Key type .llcrypt unregistered [ 2572.873387] Key type ._llcrypt unregistered [ 2591.477667] Key type ._llcrypt registered [ 2591.484367] Key type .llcrypt registered [ 2593.130733] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 12:32:26 (1772472746) [ 2596.505724] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2596.527480] alg: No test for adler32 (adler32-zlib) [ 2597.752704] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 2598.080591] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 2599.839348] Key type lgssc registered [ 2601.688752] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2690.290139] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2728.608899] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2732.416734] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2779.958339] Key type lgssc unregistered [ 2780.159264] LNet: 56478:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2780.166889] LNetError: 56478:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2780.183806] LNet: Removed LNI 192.168.202.21@tcp [ 2780.857407] Key type .llcrypt unregistered [ 2780.860385] Key type ._llcrypt unregistered [ 2800.604160] Key type ._llcrypt registered [ 2800.610056] Key type .llcrypt registered [ 2802.573553] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 12:35:55 (1772472955) [ 2806.650679] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2806.710237] alg: No test for adler32 (adler32-zlib) [ 2807.920734] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 2808.221598] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 2809.983233] Key type lgssc registered [ 2811.699142] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2894.310829] Lustre: Mounted lustre-client [ 2901.516659] LustreError: 58980:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883545800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2901.607167] Lustre: Unmounted lustre-client [ 2940.878528] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 12:38:14 (1772473094) [ 3089.876643] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3106.534252] Lustre: Mounted lustre-client [ 3114.401182] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3114.410979] LustreError: 62956:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff969887017000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3114.454107] Lustre: 57463:0:(llite_lib.c:4187:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.121@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3124.805704] Lustre: Unmounted lustre-client [ 3174.055285] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 12:42:07 (1772473327) [ 3192.081577] Key type lgssc unregistered [ 3192.573168] LNet: 64168:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3192.609192] LNetError: 64168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3192.631699] LNet: Removed LNI 192.168.202.21@tcp [ 3193.590898] Key type .llcrypt unregistered [ 3193.595322] Key type ._llcrypt unregistered [ 3211.190746] Key type ._llcrypt registered [ 3211.205829] Key type .llcrypt registered [ 3211.719613] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3211.737238] alg: No test for adler32 (adler32-zlib) [ 3212.990530] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3213.285246] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3215.007228] Key type lgssc registered [ 3216.570285] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3269.594607] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3274.436738] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3295.909871] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3297.835860] Lustre: Mounted lustre-client [ 3302.523902] LustreError: 66698:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969887014800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3302.660926] Lustre: Unmounted lustre-client [ 3337.727196] Key type lgssc unregistered [ 3337.939321] LNet: 67103:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3337.944348] LNetError: 67103:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3337.956796] LNet: Removed LNI 192.168.202.21@tcp [ 3338.602455] Key type .llcrypt unregistered [ 3338.607500] Key type ._llcrypt unregistered [ 3348.452322] Key type ._llcrypt registered [ 3348.454367] Key type .llcrypt registered [ 3348.974964] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3349.016385] alg: No test for adler32 (adler32-zlib) [ 3350.109884] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3350.391899] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3352.111228] Key type lgssc registered [ 3353.834994] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3447.362269] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3450.474651] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3466.730871] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3478.030987] Lustre: Mounted lustre-client [ 3479.582773] LustreError: 70047:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698869d9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3479.646390] Lustre: Unmounted lustre-client [ 3504.156327] Key type lgssc unregistered [ 3504.346736] LNet: 70450:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3504.356289] LNetError: 70450:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3504.374160] LNet: Removed LNI 192.168.202.21@tcp [ 3504.819329] Key type .llcrypt unregistered [ 3504.821212] Key type ._llcrypt unregistered [ 3516.043386] Key type ._llcrypt registered [ 3516.048350] Key type .llcrypt registered [ 3516.991874] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 12:47:51 (1772473671) [ 3518.930115] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3519.037651] alg: No test for adler32 (adler32-zlib) [ 3520.050790] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3520.254535] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3521.887235] Key type lgssc registered [ 3522.749855] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3559.676836] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3562.348987] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3577.547558] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3589.685872] Lustre: Mounted lustre-client [ 3595.150056] LustreError: 73579:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698859ae000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3595.264500] Lustre: Unmounted lustre-client [ 3595.657109] Lustre: Mounted lustre-client [ 3597.242216] LustreError: 73657:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698869dd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3597.304455] Lustre: Unmounted lustre-client [ 3619.968442] Key type lgssc unregistered [ 3620.189543] LNet: 74060:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3620.195583] LNetError: 74060:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3620.219799] LNet: Removed LNI 192.168.202.21@tcp [ 3620.793813] Key type .llcrypt unregistered [ 3620.796295] Key type ._llcrypt unregistered [ 3631.074061] Key type ._llcrypt registered [ 3631.087976] Key type .llcrypt registered [ 3631.434549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3631.452118] alg: No test for adler32 (adler32-zlib) [ 3632.432693] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3632.618508] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3634.263690] Key type lgssc registered [ 3635.037825] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3670.576459] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3673.069441] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3687.157197] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3703.329636] Lustre: Mounted lustre-client [ 3706.593311] LustreError: 76607:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969882a85800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3706.653461] Lustre: Unmounted lustre-client [ 3729.704402] Key type lgssc unregistered [ 3729.900719] LNet: 77010:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3729.908373] LNetError: 77010:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3730.923815] LNet: Removed LNI 192.168.202.21@tcp [ 3731.414236] Key type .llcrypt unregistered [ 3731.416744] Key type ._llcrypt unregistered [ 3742.600667] Key type ._llcrypt registered [ 3742.602952] Key type .llcrypt registered [ 3743.697543] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 12:51:37 (1772473897) [ 3745.620855] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3745.660741] alg: No test for adler32 (adler32-zlib) [ 3746.730986] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3746.859847] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3748.479279] Key type lgssc registered [ 3749.193821] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3779.658173] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3782.315724] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3796.217826] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3797.559893] Lustre: Mounted lustre-client [ 3804.511857] Lustre: lustre: root_squash is set to 0:0 [ 3810.835422] Lustre: lustre: nosquash_nids is cleared [ 3810.848380] Lustre: lustre: root_squash is set to 500:500 [ 3819.799342] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.21@tcp 192.168.0.[2,10]@tcp [ 3829.785817] Lustre: lustre: nosquash_nids set to 192.168.202.21/24@tcp [ 3832.773589] LustreError: 80465:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969887018000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3832.848640] Lustre: Unmounted lustre-client [ 3856.074192] Key type lgssc unregistered [ 3856.257881] LNet: 80867:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3856.262943] LNetError: 80867:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3856.276254] LNet: Removed LNI 192.168.202.21@tcp [ 3856.757768] Key type .llcrypt unregistered [ 3856.759750] Key type ._llcrypt unregistered [ 3866.782313] Key type ._llcrypt registered [ 3866.783798] Key type .llcrypt registered [ 3867.564905] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 12:53:42 (1772474022) [ 3869.278988] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3870.525176] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 12:53:44 (1772474024) [ 3872.604658] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3872.666407] alg: No test for adler32 (adler32-zlib) [ 3873.652494] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3873.827008] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3875.479150] Key type lgssc registered [ 3876.375376] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3906.928481] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3909.204520] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3920.640233] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3920.985512] Lustre: lustre: root_squash is set to 500:500 [ 3921.010646] Lustre: lustre: nosquash_nids set to 192.168.202.21/24@tcp [ 3922.061683] Lustre: Mounted lustre-client [ 3929.295516] LustreError: 84332:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698834c2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3929.354197] Lustre: Unmounted lustre-client [ 3947.139531] Key type lgssc unregistered [ 3947.310584] LNet: 84734:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3947.314538] LNetError: 84734:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3947.336925] LNet: Removed LNI 192.168.202.21@tcp [ 3947.835963] Key type .llcrypt unregistered [ 3947.839223] Key type ._llcrypt unregistered [ 3957.334215] Key type ._llcrypt registered [ 3957.335628] Key type .llcrypt registered [ 3958.137543] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3959.265429] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 12:55:13 (1772474113) [ 3972.498919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3972.527221] alg: No test for adler32 (adler32-zlib) [ 3973.522754] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 3973.704647] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 3975.351499] Key type lgssc registered [ 3976.081597] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4028.692137] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4031.365772] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4046.572989] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4094.635327] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4097.417423] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4109.510161] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4117.581132] Lustre: Mounted lustre-client [ 4135.618050] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9698871b5800.ost_server_uuid 50 [ 4136.675581] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9698871b5800.ost_server_uuid in FULL state after 0 sec [ 4136.964672] Lustre: Mounted lustre-client [ 4139.182316] LustreError: 91632:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969886eb7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4139.251097] Lustre: Unmounted lustre-client [ 4140.277843] LustreError: 91653:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698871b5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4140.284848] LustreError: 91653:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4140.340978] Lustre: Unmounted lustre-client [ 4172.353202] Key type lgssc unregistered [ 4172.538125] LNet: 92205:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4172.541786] LNetError: 92205:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4173.606390] LNet: Removed LNI 192.168.202.21@tcp [ 4174.192141] Key type .llcrypt unregistered [ 4174.194346] Key type ._llcrypt unregistered [ 4194.457942] Key type ._llcrypt registered [ 4194.460703] Key type .llcrypt registered [ 4195.679245] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 12:59:09 (1772474349) [ 4208.062896] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4208.073811] alg: No test for adler32 (adler32-zlib) [ 4209.035682] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 4209.183099] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 4210.807219] Key type lgssc registered [ 4211.639769] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4264.702899] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4267.578208] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4282.247465] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4284.893825] Lustre: Mounted lustre-client [ 4305.380827] Lustre: lustre-OST0000-osc-ffff969883366800: Connection to lustre-OST0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4306.400876] Lustre: 93570:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772474445/real 1772474445] req@00000000640c9700 x1858574078711040/t0(0) o400->lustre-OST0000-osc-ffff969883366800@192.168.202.121@tcp:28/4 lens 224/224 e 0 to 1 dl 1772474461 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4310.105369] Lustre: lustre-OST0000-osc-ffff969883366800: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 4311.521288] Lustre: 93569:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772474450/real 1772474450] req@00000000453796e1 x1858574078711552/t0(0) o400->lustre-OST0000-osc-ffff969883366800@192.168.202.121@tcp:28/4 lens 224/224 e 0 to 1 dl 1772474466 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4315.615191] Lustre: 93570:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772474455/real 1772474455] req@00000000f588dae5 x1858574078712064/t0(0) o400->lustre-OST0000-osc-ffff969883366800@192.168.202.121@tcp:28/4 lens 224/224 e 0 to 1 dl 1772474471 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4315.627403] Lustre: lustre-MDT0000-mdc-ffff969883366800: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4327.910688] Lustre: 96653:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772474467/real 1772474467] req@0000000085bf7dea x1858574078713728/t0(0) o101->MGC192.168.202.121@tcp@192.168.202.121@tcp:26/25 lens 328/344 e 0 to 1 dl 1772474483 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4327.926112] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 4327.935297] Lustre: 96653:0:(mgc_request.c:1911:mgc_process_log()) MGC192.168.202.121@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 4327.951953] Lustre: Evicted from MGS (at 192.168.202.121@tcp) after server handle changed from 0xb4bf330edbf39f41 to 0xb4bf330edbf3a1fd [ 4327.960892] Lustre: MGC192.168.202.121@tcp: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 4333.138915] Lustre: lustre-MDT0000-mdc-ffff969883366800: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 4334.582634] LustreError: 97388:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883366800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4334.641766] Lustre: Unmounted lustre-client [ 4357.540079] Key type lgssc unregistered [ 4357.710807] LNet: 97790:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4357.715906] LNetError: 97790:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4357.729639] LNet: Removed LNI 192.168.202.21@tcp [ 4358.149166] Key type .llcrypt unregistered [ 4358.151874] Key type ._llcrypt unregistered [ 4369.599416] Key type ._llcrypt registered [ 4369.600592] Key type .llcrypt registered [ 4370.489412] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 13:02:04 (1772474524) [ 4384.073766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4384.097997] alg: No test for adler32 (adler32-zlib) [ 4385.065504] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 4385.228881] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 4386.863765] Key type lgssc registered [ 4387.600390] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4411.001630] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4476.698833] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4479.448691] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4494.004516] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4496.425955] Lustre: Mounted lustre-client [ 4497.610338] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4498.773900] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 13:04:13 (1772474653) [ 4636.021525] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4646.336452] Lustre: Unmounted lustre-client [ 4727.153607] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4729.419364] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4743.856622] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4773.442213] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:08:47 (1772474927) [ 4830.390564] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4832.683412] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4846.108228] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4851.717307] Lustre: Mounted lustre-client [ 4853.616325] LustreError: 115950:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4853.670284] Lustre: Unmounted lustre-client [ 4877.722708] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:10:32 (1772475032) [ 4930.581713] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4932.681985] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4944.807327] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4945.272610] Lustre: Mounted lustre-client [ 4947.171736] LustreError: 119991:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff96988701a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4947.226807] Lustre: Unmounted lustre-client [ 4967.658614] Key type lgssc unregistered [ 4967.805384] LNet: 120394:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4967.808527] LNetError: 120394:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4967.821728] LNet: Removed LNI 192.168.202.21@tcp [ 4968.167991] Key type .llcrypt unregistered [ 4968.170448] Key type ._llcrypt unregistered [ 4976.117669] Key type ._llcrypt registered [ 4976.120426] Key type .llcrypt registered [ 4976.965211] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 13:12:11 (1772475131) [ 4978.462847] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4978.562904] alg: No test for adler32 (adler32-zlib) [ 4979.474277] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 4979.591403] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 4981.207281] Key type lgssc registered [ 4981.748335] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5004.261950] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5006.322966] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5016.039384] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5021.695516] Lustre: Mounted lustre-client [ 5032.726776] LustreError: 123492:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969882e7b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5032.770024] Lustre: Unmounted lustre-client [ 5052.521343] Key type lgssc unregistered [ 5052.706599] LNet: 123894:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5052.709818] LNetError: 123894:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5052.719146] LNet: Removed LNI 192.168.202.21@tcp [ 5053.100544] Key type .llcrypt unregistered [ 5053.103146] Key type ._llcrypt unregistered [ 5060.760377] Key type ._llcrypt registered [ 5060.761658] Key type .llcrypt registered [ 5061.433392] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 13:13:36 (1772475216) [ 5062.613886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5062.621764] alg: No test for adler32 (adler32-zlib) [ 5063.526143] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 5063.633420] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 5065.247331] Key type lgssc registered [ 5065.908989] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5091.748530] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5093.724324] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5102.872449] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5109.241462] Lustre: Mounted lustre-client [ 5114.342530] Lustre: lustre-OST0000-osc-ffff969882a82800: Connection to lustre-OST0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5119.981739] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff969882a82800.ost_server_uuid 50 [ 5120.679773] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5130.044158] LustreError: 127430:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969882a82800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5130.075533] Lustre: Unmounted lustre-client [ 5142.952806] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 13:14:57 (1772475297) [ 5156.633516] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5158.441299] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5167.114515] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5177.652571] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5177.968618] Lustre: Mounted lustre-client [ 5183.461068] Lustre: lustre-OST0000-osc-ffff969883007800: Connection to lustre-OST0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5200.349212] LustreError: 130080:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883007800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5200.402695] Lustre: Unmounted lustre-client [ 5227.906972] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 13:16:22 (1772475382) [ 5241.849395] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5243.535218] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5252.994119] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5262.161649] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5262.485416] Lustre: Mounted lustre-client [ 5267.939511] Lustre: lustre-OST0000-osc-ffff9698834c6000: Connection to lustre-OST0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5279.883853] LustreError: 132829:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698834c6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5279.895708] LustreError: 132829:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 5279.946149] Lustre: Unmounted lustre-client [ 5306.625330] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 13:17:41 (1772475461) [ 5345.746951] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5347.239723] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5356.522334] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5391.457727] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5393.181192] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5401.588670] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5416.322517] Lustre: Mounted lustre-client [ 5447.094943] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5462.518682] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 14 sec [ 5463.528970] LustreError: 139511:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883360800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5463.535678] LustreError: 139511:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 5463.576481] Lustre: Unmounted lustre-client [ 5484.643867] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 13:20:39 (1772475639) [ 5497.563303] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5499.083846] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5506.824805] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5524.172908] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5540.705218] Lustre: Mounted lustre-client [ 5570.367917] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5571.187111] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5576.680926] Lustre: lustre-OST0001-osc-ffff969883513800: Connection to lustre-OST0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5588.000668] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5598.276801] Lustre: Unmounted lustre-client [ 5631.233603] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 13:23:06 (1772475786) [ 5645.294778] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5647.105704] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5655.125389] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5655.345197] Lustre: Mounted lustre-client [ 5664.856132] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5665.506938] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5673.973389] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9698913b9800.ost_server_uuid 50 [ 5674.676428] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9698913b9800.ost_server_uuid in FULL state after 0 sec [ 5675.512035] LustreError: 146502:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698913b9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5675.560116] Lustre: Unmounted lustre-client [ 5675.685365] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5675.689717] Lustre: Skipped 3 previous similar messages [ 5675.742373] Lustre: Mounted lustre-client [ 5676.276955] LustreError: 146565:0:(sec.c:410:import_sec_validate_get()) import 00000000574cd973 (NEW) with no sec [ 5714.283937] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 13:24:29 (1772475869) [ 5726.341812] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5727.864379] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5735.431185] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5742.650713] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5742.832936] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5742.911778] Lustre: Mounted lustre-client [ 5755.962961] LustreError: 149435:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969886f6d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5755.967232] LustreError: 149435:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 5756.008762] Lustre: Unmounted lustre-client [ 5756.010275] Lustre: Skipped 1 previous similar message [ 5781.726241] Key type lgssc unregistered [ 5781.861788] LNet: 149882:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5781.864425] LNetError: 149882:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5781.872597] LNet: Removed LNI 192.168.202.21@tcp [ 5782.127975] Key type .llcrypt unregistered [ 5782.129402] Key type ._llcrypt unregistered [ 5787.705058] Key type ._llcrypt registered [ 5787.706458] Key type .llcrypt registered [ 5788.205628] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 13:25:43 (1772475943) [ 5788.659972] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5788.691698] alg: No test for adler32 (adler32-zlib) [ 5789.565114] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 5789.657415] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 5791.247170] Key type lgssc registered [ 5791.675700] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5810.310536] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5811.567081] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5817.664748] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5823.962144] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5824.086330] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5829.614837] Lustre: Mounted lustre-client [ 5832.747081] LustreError: lustre-MDT0001-mdc-ffff969890af7800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5832.753334] Lustre: lustre-MDT0001-mdc-ffff969890af7800: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 5834.367300] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5834.930089] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5842.094554] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5848.241428] LustreError: 154072:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5848.276144] Lustre: Unmounted lustre-client [ 5868.025948] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 13:27:02 (1772476022) [ 5900.107411] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5901.460040] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5909.131740] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5909.331956] Lustre: Mounted lustre-client [ 5919.826776] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5920.405465] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5935.587051] Lustre: lustre-OST0001-osc-ffff969883512800: Connection to lustre-OST0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5937.840175] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5948.157094] Lustre: Unmounted lustre-client [ 5988.203174] Key type lgssc unregistered [ 5988.329482] LNet: 159198:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5988.332051] LNetError: 159198:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5988.340960] LNet: Removed LNI 192.168.202.21@tcp [ 5988.608728] Key type .llcrypt unregistered [ 5988.609800] Key type ._llcrypt unregistered [ 5999.039302] Key type ._llcrypt registered [ 5999.040381] Key type .llcrypt registered [ 5999.570925] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 13:29:14 (1772476154) [ 6000.481454] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6000.489598] alg: No test for adler32 (adler32-zlib) [ 6001.376773] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6001.485231] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6003.079169] Key type lgssc registered [ 6003.550502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6022.259670] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6023.575144] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6029.996060] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6031.183318] Lustre: Mounted lustre-client [ 6067.997332] LustreError: 162458:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6068.030138] Lustre: Unmounted lustre-client [ 6084.580919] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6084.738716] Lustre: Mounted lustre-client [ 6116.696984] LustreError: 163109:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698850e6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6116.732148] Lustre: Unmounted lustre-client [ 6142.793301] Key type lgssc unregistered [ 6142.913688] LNet: 163517:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6142.916479] LNetError: 163517:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6142.930395] LNet: Removed LNI 192.168.202.21@tcp [ 6143.205669] Key type .llcrypt unregistered [ 6143.207454] Key type ._llcrypt unregistered [ 6148.635482] Key type ._llcrypt registered [ 6148.637311] Key type .llcrypt registered [ 6149.173839] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 13:31:44 (1772476304) [ 6149.972558] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6150.006621] alg: No test for adler32 (adler32-zlib) [ 6150.884298] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6150.984773] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6152.575165] Key type lgssc registered [ 6152.997517] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6171.036918] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6172.451082] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6178.831810] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6189.551366] Lustre: Mounted lustre-client [ 6196.528436] LustreError: 166791:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698913b9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6196.570155] Lustre: Unmounted lustre-client [ 6213.944527] Key type lgssc unregistered [ 6214.063557] LNet: 167194:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6214.066673] LNetError: 167194:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6214.074752] LNet: Removed LNI 192.168.202.21@tcp [ 6214.314240] Key type .llcrypt unregistered [ 6214.315538] Key type ._llcrypt unregistered [ 6218.637337] Key type ._llcrypt registered [ 6218.638504] Key type .llcrypt registered [ 6218.888857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6218.894449] alg: No test for adler32 (adler32-zlib) [ 6219.763390] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6219.864472] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6221.455218] Key type lgssc registered [ 6221.896836] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6240.066925] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6241.360168] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6247.597156] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6263.284206] Lustre: Mounted lustre-client [ 6266.235644] LustreError: 169762:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698913b9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6266.268394] Lustre: Unmounted lustre-client [ 6284.130820] Key type lgssc unregistered [ 6284.254929] LNet: 170166:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6284.259218] LNetError: 170166:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6284.272665] LNet: Removed LNI 192.168.202.21@tcp [ 6284.526158] Key type .llcrypt unregistered [ 6284.527874] Key type ._llcrypt unregistered [ 6289.975396] Key type ._llcrypt registered [ 6289.976384] Key type .llcrypt registered [ 6290.453587] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 13:34:05 (1772476445) [ 6291.338227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6291.362702] alg: No test for adler32 (adler32-zlib) [ 6292.228388] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6292.318124] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6293.919241] Key type lgssc registered [ 6294.359240] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6312.472188] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6313.803860] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6320.780441] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6332.402590] Lustre: Mounted lustre-client [ 6339.597244] LustreError: 173420:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969886ee5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6339.633148] Lustre: Unmounted lustre-client [ 6366.409317] Key type lgssc unregistered [ 6366.535580] LNet: 173824:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6366.538554] LNetError: 173824:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6366.547837] LNet: Removed LNI 192.168.202.21@tcp [ 6366.832075] Key type .llcrypt unregistered [ 6366.833226] Key type ._llcrypt unregistered [ 6371.256861] Key type ._llcrypt registered [ 6371.258284] Key type .llcrypt registered [ 6371.440606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6371.447973] alg: No test for adler32 (adler32-zlib) [ 6372.319680] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6372.411830] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6373.999162] Key type lgssc registered [ 6374.437787] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6392.342660] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6393.697388] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6400.110475] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6410.736310] Lustre: Mounted lustre-client [ 6413.657524] LustreError: 176391:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698913b9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6413.697162] Lustre: Unmounted lustre-client [ 6423.134673] Key type lgssc unregistered [ 6423.264616] LNet: 176792:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6423.268537] LNetError: 176792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6423.281505] LNet: Removed LNI 192.168.202.21@tcp [ 6423.534061] Key type .llcrypt unregistered [ 6423.535434] Key type ._llcrypt unregistered [ 6428.709720] Key type ._llcrypt registered [ 6428.711060] Key type .llcrypt registered [ 6429.174814] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 13:36:24 (1772476584) [ 6435.869128] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6435.921043] alg: No test for adler32 (adler32-zlib) [ 6436.781615] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6436.863334] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6438.439142] Key type lgssc registered [ 6438.829282] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6466.818739] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6468.085598] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6475.243640] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6504.647172] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 13:37:39 (1772476659) [ 6514.402885] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6515.634109] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6521.558085] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6533.101678] Lustre: Mounted lustre-client [ 6535.000139] LustreError: 183294:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883005000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6535.034343] Lustre: Unmounted lustre-client [ 6552.164814] Key type lgssc unregistered [ 6552.285445] LNet: 183697:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6552.288195] LNetError: 183697:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6552.295802] LNet: Removed LNI 192.168.202.21@tcp [ 6552.523554] Key type .llcrypt unregistered [ 6552.525333] Key type ._llcrypt unregistered [ 6557.519825] Key type ._llcrypt registered [ 6557.520733] Key type .llcrypt registered [ 6557.970667] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 6558.499818] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 13:38:33 (1772476713) [ 6564.179592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6564.185354] alg: No test for adler32 (adler32-zlib) [ 6565.037538] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6565.115827] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6566.695122] Key type lgssc registered [ 6567.065292] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6598.596446] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6599.726173] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6607.013423] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 6613.138517] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 6614.314254] Lustre: Mounted lustre-client [ 6620.360103] LustreError: 189223:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af2800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 6620.399148] Lustre: Unmounted lustre-client [ 6682.542447] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6683.791244] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6691.209993] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6720.567179] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 13:41:15 (1772476875) [ 6721.033976] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 6721.594317] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 13:41:16 (1772476876) [ 6740.541025] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6741.841516] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6767.101738] Key type lgssc unregistered [ 6767.226657] LNet: 195384:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6767.229113] LNetError: 195384:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6767.239714] LNet: Removed LNI 192.168.202.21@tcp [ 6767.497817] Key type .llcrypt unregistered [ 6767.499504] Key type ._llcrypt unregistered [ 6772.864936] Key type ._llcrypt registered [ 6772.866170] Key type .llcrypt registered [ 6773.345454] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 13:42:08 (1772476928) [ 6807.128964] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6807.136071] alg: No test for adler32 (adler32-zlib) [ 6808.015241] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6808.109244] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6809.695126] Key type lgssc registered [ 6810.081314] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6824.338648] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6825.539635] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6842.667608] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6854.013496] Key type lgssc unregistered [ 6854.133624] LNet: 199012:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6854.137175] LNetError: 199012:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6854.145397] LNet: Removed LNI 192.168.202.21@tcp [ 6854.411499] Key type .llcrypt unregistered [ 6854.413650] Key type ._llcrypt unregistered [ 6859.644820] Key type ._llcrypt registered [ 6859.646673] Key type .llcrypt registered [ 6860.132652] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 13:43:35 (1772477015) [ 6861.141788] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6861.173630] alg: No test for adler32 (adler32-zlib) [ 6862.039316] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6862.132057] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6863.719113] Key type lgssc registered [ 6864.103556] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6881.673208] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6883.008079] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6889.251712] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6904.817607] Lustre: Mounted lustre-client [ 6909.921720] Lustre: lustre-MDT0000-mdc-ffff9698834c3000: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6915.041848] Lustre: lustre-MDT0001-mdc-ffff9698834c3000: Connection to lustre-MDT0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6930.402712] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 6930.410277] Lustre: Evicted from MGS (at 192.168.202.121@tcp) after server handle changed from 0xebbec297dfe748e0 to 0xebbec297dfe76240 [ 6930.414896] Lustre: MGC192.168.202.121@tcp: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 6947.500431] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6949.860418] LustreError: lustre-MDT0000-mdc-ffff9698834c3000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6949.878371] Lustre: lustre-MDT0000-mdc-ffff9698834c3000: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 6951.228664] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 3 sec [ 6952.613773] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6953.157819] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6953.769974] LustreError: 203439:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698834c3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6953.795197] Lustre: Unmounted lustre-client [ 6970.928835] Key type lgssc unregistered [ 6971.043481] LNet: 203841:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6971.045652] LNetError: 203841:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6971.053622] LNet: Removed LNI 192.168.202.21@tcp [ 6971.283812] Key type .llcrypt unregistered [ 6971.285244] Key type ._llcrypt unregistered [ 6976.187076] Key type ._llcrypt registered [ 6976.188933] Key type .llcrypt registered [ 6976.629504] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 13:45:31 (1772477131) [ 6977.416367] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6977.431432] alg: No test for adler32 (adler32-zlib) [ 6978.285571] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 6978.362329] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 6979.943206] Key type lgssc registered [ 6980.343393] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6998.280962] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6999.449413] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7020.368212] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7021.544472] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7030.655880] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7037.355630] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7050.071645] Key type lgssc unregistered [ 7050.181299] LNet: 208938:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7050.183753] LNetError: 208938:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7050.190340] LNet: Removed LNI 192.168.202.21@tcp [ 7050.430409] Key type .llcrypt unregistered [ 7050.431422] Key type ._llcrypt unregistered [ 7071.148137] Key type ._llcrypt registered [ 7071.149415] Key type .llcrypt registered [ 7071.607420] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 13:47:06 (1772477226) [ 7083.467848] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7083.478444] alg: No test for adler32 (adler32-zlib) [ 7084.326875] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7084.406594] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7085.991152] Key type lgssc registered [ 7086.357387] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7113.938271] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7115.076647] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7122.101962] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7152.782717] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 13:48:27 (1772477307) [ 7155.298775] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 13:48:30 (1772477310) [ 7166.106589] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7167.353876] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7173.450704] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7188.973797] Lustre: Mounted lustre-client [ 7192.172249] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 7192.921640] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7193.465708] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7194.022865] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 7199.201660] Lustre: lustre-MDT0000-mdc-ffff969885197800: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7209.441289] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 7209.449130] Lustre: Evicted from MGS (at 192.168.202.121@tcp) after server handle changed from 0xed360899ab1c6151 to 0xed360899ab1c63e3 [ 7209.452618] Lustre: MGC192.168.202.121@tcp: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 7213.123455] Lustre: lustre-MDT0000-mdc-ffff969885197800: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 7214.385227] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7215.015648] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7216.963216] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 7219.689341] Lustre: lustre-MDT0000-mdc-ffff969885197800: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7235.041338] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 7235.047132] Lustre: Evicted from MGS (at 192.168.202.121@tcp) after server handle changed from 0xed360899ab1c63e3 to 0xed360899ab1c66f3 [ 7235.051603] Lustre: MGC192.168.202.121@tcp: Connection restored to 192.168.202.121@tcp (at 192.168.202.121@tcp) [ 7237.294177] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7237.817316] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7239.344976] LustreError: 219065:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969885197800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7239.380622] Lustre: Unmounted lustre-client [ 7272.253724] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7273.525082] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7279.722325] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7290.351323] Lustre: Mounted lustre-client [ 7290.731057] LustreError: 220677:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7290.763158] Lustre: Unmounted lustre-client [ 7316.522602] Key type lgssc unregistered [ 7316.650787] LNet: 221082:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7316.654057] LNetError: 221082:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7316.664912] LNet: Removed LNI 192.168.202.21@tcp [ 7316.907667] Key type .llcrypt unregistered [ 7316.908961] Key type ._llcrypt unregistered [ 7321.665988] Key type ._llcrypt registered [ 7321.667021] Key type .llcrypt registered [ 7322.112375] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 13:51:17 (1772477477) [ 7323.395393] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7323.441165] alg: No test for adler32 (adler32-zlib) [ 7324.298910] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7324.385740] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7325.967153] Key type lgssc registered [ 7326.363157] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7342.694778] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7343.852393] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7349.454296] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7350.629284] Lustre: Mounted lustre-client [ 7353.579839] LustreError: 224246:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969890af6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7353.609062] Lustre: Unmounted lustre-client [ 7384.455963] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7385.539151] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7391.343177] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7396.852221] Lustre: Mounted lustre-client [ 7402.697540] LustreError: 225840:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698913ba000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7402.722951] Lustre: Unmounted lustre-client [ 7433.826684] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7434.961797] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7440.734762] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7456.245665] Lustre: Mounted lustre-client [ 7456.585164] LustreError: 227453:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698936d6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7456.617849] Lustre: Unmounted lustre-client [ 7482.261839] Key type lgssc unregistered [ 7482.376480] LNet: 227857:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7482.379482] LNetError: 227857:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7482.387420] LNet: Removed LNI 192.168.202.21@tcp [ 7482.617332] Key type .llcrypt unregistered [ 7482.618343] Key type ._llcrypt unregistered [ 7487.637534] Key type ._llcrypt registered [ 7487.638627] Key type .llcrypt registered [ 7488.089709] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 13:54:03 (1772477643) [ 7489.155857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7489.161277] alg: No test for adler32 (adler32-zlib) [ 7490.017619] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7490.100760] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7491.679204] Key type lgssc registered [ 7492.098255] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7507.221338] Key type lgssc unregistered [ 7507.331443] LNet: 230173:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7507.334816] LNetError: 230173:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7507.347332] LNet: Removed LNI 192.168.202.21@tcp [ 7507.572462] Key type .llcrypt unregistered [ 7507.573987] Key type ._llcrypt unregistered [ 7517.110948] Key type ._llcrypt registered [ 7517.112673] Key type .llcrypt registered [ 7517.241088] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7517.247624] alg: No test for adler32 (adler32-zlib) [ 7518.106287] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7518.187476] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7519.775109] Key type lgssc registered [ 7520.150239] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7547.656423] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7548.878439] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7555.924033] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7576.374886] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 7576.922590] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 13:55:31 (1772477731) [ 7586.381808] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7587.544154] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7593.060372] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7599.617081] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7600.757215] Lustre: Mounted lustre-client [ 7606.243180] Lustre: lustre-OST0001-osc-ffff96988473e800: Connection to lustre-OST0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7608.279738] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7618.553929] Lustre: Unmounted lustre-client [ 7642.233811] Key type lgssc unregistered [ 7642.353815] LNet: 237062:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7642.356311] LNetError: 237062:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7642.365574] LNet: Removed LNI 192.168.202.21@tcp [ 7642.608851] Key type .llcrypt unregistered [ 7642.609726] Key type ._llcrypt unregistered [ 7652.006520] Key type ._llcrypt registered [ 7652.007339] Key type .llcrypt registered [ 7652.412491] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 13:56:47 (1772477807) [ 7656.742942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7656.758820] alg: No test for adler32 (adler32-zlib) [ 7657.611391] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7657.695705] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7659.271205] Key type lgssc registered [ 7659.623232] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7675.407307] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7676.457037] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7687.786781] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 13:57:22 (1772477842) [ 7696.957872] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7698.077578] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7703.844352] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7706.044284] Lustre: Mounted lustre-client [ 7713.258037] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7713.361166] Lustre: Unmounted lustre-client [ 7767.730673] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7768.964744] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7798.670112] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7809.010775] Lustre: Mounted lustre-client [ 7809.382447] LustreError: 244133:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969885195000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7809.411186] Lustre: Unmounted lustre-client [ 7818.433565] Key type lgssc unregistered [ 7818.545599] LNet: 244535:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7818.548670] LNetError: 244535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7818.557765] LNet: Removed LNI 192.168.202.21@tcp [ 7818.790939] Key type .llcrypt unregistered [ 7818.792378] Key type ._llcrypt unregistered [ 7827.907987] Key type ._llcrypt registered [ 7827.913424] Key type .llcrypt registered [ 7828.068522] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7828.078525] alg: No test for adler32 (adler32-zlib) [ 7828.935270] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7829.030217] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7830.615117] Key type lgssc registered [ 7830.984298] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7858.405340] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7859.535797] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7866.405803] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7887.029932] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 7887.606310] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 14:00:42 (1772478042) [ 7896.751515] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7897.822400] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7903.355797] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7905.308321] Lustre: Mounted lustre-client [ 7905.924836] LustreError: 250573:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883006800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7905.949155] Lustre: Unmounted lustre-client [ 7931.319224] Key type lgssc unregistered [ 7931.442566] LNet: 250987:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7931.445738] LNetError: 250987:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7931.453766] LNet: Removed LNI 192.168.202.21@tcp [ 7931.672635] Key type .llcrypt unregistered [ 7931.673688] Key type ._llcrypt unregistered [ 7936.539322] Key type ._llcrypt registered [ 7936.540566] Key type .llcrypt registered [ 7937.008288] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 7937.536524] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 14:01:32 (1772478092) [ 7940.512310] Key type .llcrypt unregistered [ 7940.513895] Key type ._llcrypt unregistered [ 7943.239105] Key type ._llcrypt registered [ 7943.240267] Key type .llcrypt registered [ 7943.402937] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7943.411429] alg: No test for adler32 (adler32-zlib) [ 7944.271669] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7944.351866] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7945.935112] Key type lgssc registered [ 7946.285489] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7963.768506] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7969.001651] Lustre: Mounted lustre-client [ 7969.435726] LustreError: 254000:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969884666000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7969.459135] Lustre: Unmounted lustre-client [ 7986.431221] Key type lgssc unregistered [ 7986.552538] LNet: 254403:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7986.554717] LNetError: 254403:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7986.564579] LNet: Removed LNI 192.168.202.21@tcp [ 7986.781984] Key type .llcrypt unregistered [ 7986.783405] Key type ._llcrypt unregistered [ 7991.734714] Key type ._llcrypt registered [ 7991.736127] Key type .llcrypt registered [ 7992.174259] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 14:02:27 (1772478147) [ 7992.919216] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7992.956626] alg: No test for adler32 (adler32-zlib) [ 7993.815857] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 7993.893411] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 7995.471146] Key type lgssc registered [ 7995.861231] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8054.892413] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8065.002882] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8066.259126] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8068.482367] Lustre: Mounted lustre-client [ 8068.968036] LustreError: 257444:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969886ff4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8068.997825] Lustre: Unmounted lustre-client [ 8086.020721] Key type lgssc unregistered [ 8086.134452] LNet: 257849:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8086.137149] LNetError: 257849:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8086.149400] LNet: Removed LNI 192.168.202.21@tcp [ 8086.372757] Key type .llcrypt unregistered [ 8086.374228] Key type ._llcrypt unregistered [ 8091.207642] Key type ._llcrypt registered [ 8091.209216] Key type .llcrypt registered [ 8091.681357] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 14:04:06 (1772478246) [ 8092.472812] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8092.482053] alg: No test for adler32 (adler32-zlib) [ 8093.349664] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 8093.443327] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 8095.031178] Key type lgssc registered [ 8095.489556] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8112.449342] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8113.676359] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8119.707301] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8130.034181] Lustre: Mounted lustre-client [ 8135.138195] Lustre: lustre-MDT0000-mdc-ffff9698902c0000: Connection to lustre-MDT0000 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8137.535494] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8137.545481] LustreError: 260913:0:(file.c:6084:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 8137.635955] LustreError: 260932:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698902c0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8137.636969] LustreError: MGC192.168.202.121@tcp: Connection to MGS (at 192.168.202.121@tcp) was lost; in progress operations using this service will fail [ 8137.659125] Lustre: Unmounted lustre-client [ 8148.416406] Key type lgssc unregistered [ 8148.532406] LNet: 261326:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8148.535545] LNetError: 261326:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8148.548302] LNet: Removed LNI 192.168.202.21@tcp [ 8148.774278] Key type .llcrypt unregistered [ 8148.775550] Key type ._llcrypt unregistered [ 8153.885369] Key type ._llcrypt registered [ 8153.886696] Key type .llcrypt registered [ 8154.340379] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 14:05:09 (1772478309) [ 8155.114993] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8155.122483] alg: No test for adler32 (adler32-zlib) [ 8155.986754] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 8156.070836] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 8157.655196] Key type lgssc registered [ 8158.050430] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8175.434284] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8176.610723] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8182.488190] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8193.006119] Lustre: Mounted lustre-client [ 8198.114593] Lustre: lustre-MDT0001-mdc-ffff96989030f000: Connection to lustre-MDT0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8209.102358] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8209.399485] LustreError: 264418:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff96989030f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8209.426247] Lustre: Unmounted lustre-client [ 8220.014423] Key type lgssc unregistered [ 8220.130421] LNet: 264812:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8220.132862] LNetError: 264812:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8220.142740] LNet: Removed LNI 192.168.202.21@tcp [ 8220.393670] Key type .llcrypt unregistered [ 8220.394683] Key type ._llcrypt unregistered [ 8225.416852] Key type ._llcrypt registered [ 8225.417933] Key type .llcrypt registered [ 8225.855894] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 14:06:20 (1772478380) [ 8231.176149] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8231.201922] alg: No test for adler32 (adler32-zlib) [ 8232.053490] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 8232.129908] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 8233.711175] Key type lgssc registered [ 8234.073183] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8267.911273] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8269.050500] Lustre: Mounted lustre-client [ 8285.154261] Lustre: lustre-MDT0001-mdc-ffff969883517800: Connection to lustre-MDT0001 (at 192.168.202.121@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8290.089825] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8300.343849] Lustre: Unmounted lustre-client [ 8333.923463] Key type lgssc unregistered [ 8334.045349] LNet: 270554:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8334.048218] LNetError: 270554:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8334.056380] LNet: Removed LNI 192.168.202.21@tcp [ 8334.270774] Key type .llcrypt unregistered [ 8334.272390] Key type ._llcrypt unregistered [ 8339.197704] Key type ._llcrypt registered [ 8339.198624] Key type .llcrypt registered [ 8339.596615] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 14:08:14 (1772478494) [ 8340.026878] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 8340.486498] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 14:08:15 (1772478495) [ 8340.940629] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 8341.443297] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 14:08:16 (1772478496) [ 8341.954471] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 8342.506114] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 14:08:17 (1772478497) [ 8342.940551] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 8343.399966] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 14:08:18 (1772478498) [ 8343.874887] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 8344.353262] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 14:08:19 (1772478499) [ 8346.897251] Key type .llcrypt unregistered [ 8346.898087] Key type ._llcrypt unregistered [ 8348.895172] Key type ._llcrypt registered [ 8348.896252] Key type .llcrypt registered [ 8349.076165] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8349.081054] alg: No test for adler32 (adler32-zlib) [ 8349.930606] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 8350.007978] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 8351.591160] Key type lgssc registered [ 8351.976174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8377.767954] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8378.918645] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8385.913919] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8387.074116] Lustre: Mounted lustre-client [ 8387.492727] LustreError: 276133:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969883513800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8387.524234] Lustre: Unmounted lustre-client [ 8410.723612] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 14:09:25 (1772478565) [ 8420.491101] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8421.635407] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8438.441140] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8443.888186] Lustre: Mounted lustre-client [ 8444.197715] LustreError: 278241:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698879d9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8444.223103] Lustre: Unmounted lustre-client [ 8473.216094] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 14:10:28 (1772478628) [ 8499.551254] LNet: 1 local NIs in recovery (showing 1): 192.168.202.21@tcp [ 9060.133142] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9061.212081] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9078.313467] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9119.285930] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 14:21:14 (1772479274) [ 9122.941199] Key type lgssc unregistered [ 9123.051534] LNet: 283769:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9123.053731] LNetError: 283769:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9123.060548] LNet: Removed LNI 192.168.202.21@tcp [ 9123.303941] Key type .llcrypt unregistered [ 9123.305565] Key type ._llcrypt unregistered [ 9205.870274] Key type ._llcrypt registered [ 9205.871142] Key type .llcrypt registered [ 9206.125876] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9206.130845] alg: No test for adler32 (adler32-zlib) [ 9207.007115] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 9207.094108] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 9208.687161] Key type lgssc registered [ 9209.101057] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9241.011146] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9242.093796] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9249.573134] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9276.282202] Key type lgssc unregistered [ 9276.394376] LNet: 287355:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9276.398150] LNetError: 287355:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9276.404597] LNet: Removed LNI 192.168.202.21@tcp [ 9276.611363] Key type .llcrypt unregistered [ 9276.612438] Key type ._llcrypt unregistered [ 9287.119996] Key type ._llcrypt registered [ 9287.120888] Key type .llcrypt registered [ 9287.555781] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 14:24:02 (1772479442) [ 9294.240710] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9294.254246] alg: No test for adler32 (adler32-zlib) [ 9295.109470] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 9295.189877] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 9296.775159] Key type lgssc registered [ 9297.174572] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9319.341515] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 14:24:34 (1772479474) [ 9324.167897] Key type lgssc unregistered [ 9324.275533] LNet: 290898:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9324.277816] LNetError: 290898:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9324.286535] LNet: Removed LNI 192.168.202.21@tcp [ 9324.515409] Key type .llcrypt unregistered [ 9324.516593] Key type ._llcrypt unregistered [ 9328.025261] Key type ._llcrypt registered [ 9328.026294] Key type .llcrypt registered [ 9328.166506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9328.170853] alg: No test for adler32 (adler32-zlib) [ 9329.053800] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 9329.145666] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 9330.735185] Key type lgssc registered [ 9331.146868] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9352.657322] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9353.729192] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9361.605791] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9440.693435] LNet: Added LNI 192.168.202.21@tcp50 [8/256/0/180] [ 9441.365323] LNet: Removed LNI 192.168.202.21@tcp [ 9442.731473] Lustre: 295163:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff9698913ba000: config has no valid NIDs, force dynamic NIDs [ 9443.777942] Lustre: Mounted lustre-client [ 9443.799434] LustreError: 295178:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9698913ba000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9443.830895] Lustre: Unmounted lustre-client [ 9444.686097] Key type lgssc unregistered [ 9444.821622] LNet: 295428:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9444.825257] LNetError: 295428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9444.836255] LNet: Removed LNI 192.168.202.21@tcp50 [ 9445.027922] Key type .llcrypt unregistered [ 9445.029288] Key type ._llcrypt unregistered [ 9454.730408] Key type ._llcrypt registered [ 9454.731450] Key type .llcrypt registered [ 9454.935310] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9454.945690] alg: No test for adler32 (adler32-zlib) [ 9455.825729] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 9455.918224] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 9457.511237] Key type lgssc registered [ 9458.058420] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9486.108165] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9487.585882] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9490.424817] LNet: Added LNI 192.168.202.21@tcp50 [8/256/0/180] [ 9490.742415] LNet: Removed LNI 192.168.202.21@tcp [ 9491.819609] Lustre: 298053:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff969886751000: config has no valid NIDs, force dynamic NIDs [ 9492.862494] Lustre: Mounted lustre-client [ 9493.001289] LustreError: 298088:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969886751000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9493.034128] Lustre: Unmounted lustre-client [ 9512.806083] Key type lgssc unregistered [ 9513.021555] LNet: 298926:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9513.026583] LNetError: 298926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9513.039922] LNet: Removed LNI 192.168.202.21@tcp50 [ 9513.392590] Key type .llcrypt unregistered [ 9513.395213] Key type ._llcrypt unregistered [ 9517.318514] Key type ._llcrypt registered [ 9517.319635] Key type .llcrypt registered [ 9518.003826] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 14:27:52 (1772479672) [ 9519.132931] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9519.154657] alg: No test for adler32 (adler32-zlib) [ 9520.036450] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 9520.124841] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 9521.719200] Key type lgssc registered [ 9522.390636] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9541.095859] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9542.228156] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9548.502739] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9564.141874] Lustre: Mounted lustre-client [ 9586.171668] Lustre: Mounted fs15246-client [ 9592.427870] LustreError: 303055:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffff9698850e6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9592.447141] Lustre: Unmounted fs15246-client [ 9602.713814] LustreError: 303273:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff969886ff3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9602.744199] Lustre: Unmounted lustre-client [ 9621.098684] Key type lgssc unregistered [ 9621.214628] LNet: 303674:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9621.218328] LNetError: 303674:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9621.227721] LNet: Removed LNI 192.168.202.21@tcp [ 9621.518690] Key type .llcrypt unregistered [ 9621.520421] Key type ._llcrypt unregistered [ 9625.407721] Key type ._llcrypt registered [ 9625.408720] Key type .llcrypt registered [ 9625.844863] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 14:29:40 (1772479780) [ 9626.500488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9626.506257] alg: No test for adler32 (adler32-zlib) [ 9627.370145] Lustre: Lustre: Build Version: 2.17.50_194_gae5720b [ 9627.458147] LNet: Added LNI 192.168.202.21@tcp [8/256/0/180] [ 9629.063165] Key type lgssc registered [ 9629.440677] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9680.890510] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9682.473469] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9691.617761] Lustre: DEBUG MARKER: oleg221-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9745.615608] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 9381 sec ========== 14:31:40 (1772479900) [ 9746.366715] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 14:31:41 (1772479901) === [ 9747.823422] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 14:31:42 (1772479902) === [ 9761.627775] Key type lgssc unregistered [ 9761.750453] LNet: 312827:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9761.753386] LNetError: 312827:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9761.766132] LNet: Removed LNI 192.168.202.21@tcp [ 9762.104475] Key type .llcrypt unregistered [ 9762.105765] Key type ._llcrypt unregistered