[ 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 527964775 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: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001013] APIC: Switch to symmetric I/O mode setup [ 0.002191] x2apic enabled [ 0.003004] Switched APIC routing to physical x2apic. [ 0.003923] kvm-guest: setup PV IPIs [ 0.005962] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.006000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.006027] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.007015] pid_max: default: 32768 minimum: 301 [ 0.009084] LSM: Security Framework initializing [ 0.010048] Yama: becoming mindful. [ 0.011039] SELinux: Initializing. [ 0.012096] *** VALIDATE selinux *** [ 0.023017] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.029239] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.030306] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031128] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032149] *** VALIDATE tmpfs *** [ 0.033507] *** VALIDATE proc *** [ 0.034254] *** VALIDATE cgroup *** [ 0.035014] *** VALIDATE cgroup2 *** [ 0.036300] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037191] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039040] Spectre V2 : User space: Vulnerable [ 0.040015] Speculative Store Bypass: Vulnerable [ 0.043249] debug: unmapping init [mem 0xffffffffa0859000-0xffffffffa0860fff] [ 0.046284] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047838] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048032] ... version: 2 [ 0.049015] ... bit width: 48 [ 0.050018] ... generic registers: 4 [ 0.051011] ... value mask: 0000ffffffffffff [ 0.052020] ... max period: 00007fffffffffff [ 0.053020] ... fixed-purpose events: 3 [ 0.054013] ... event mask: 000000070000000f [ 0.056287] rcu: Hierarchical SRCU implementation. [ 0.058680] smp: Bringing up secondary CPUs ... [ 0.059742] x86: Booting SMP configuration: [ 0.060027] .... node #0, CPUs: #1 #2 #3 [ 0.068771] smp: Brought up 1 node, 4 CPUs [ 0.070016] smpboot: Max logical packages: 1 [ 0.071022] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.188925] node 0 deferred pages initialised in 113ms [ 0.191013] devtmpfs: initialized [ 0.192372] x86/mm: Memory block size: 128MB [ 0.195157] gcov: version magic: 0x41383552 [ 0.197422] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.201179] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.204419] pinctrl core: initialized pinctrl subsystem [ 0.206182] [ 0.206719] ************************************************************* [ 0.209019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.212016] ** ** [ 0.214015] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.216013] ** ** [ 0.218015] ** This means that this kernel is built to expose internal ** [ 0.220016] ** IOMMU data structures, which may compromise security on ** [ 0.222013] ** your system. ** [ 0.224013] ** ** [ 0.227023] ** If you see this message and you are not debugging the ** [ 0.229012] ** kernel, report this immediately to your vendor! ** [ 0.231011] ** ** [ 0.232011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.234011] ************************************************************* [ 0.236796] NET: Registered protocol family 16 [ 0.238468] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.240114] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.243083] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.246174] cpuidle: using governor menu [ 0.248032] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.250070] PCI: Using configuration type 1 for base access [ 0.252129] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.265115] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.267022] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.271062] cryptd: max_cpu_qlen set to 1000 [ 0.275257] ACPI: Added _OSI(Module Device) [ 0.276009] ACPI: Added _OSI(Processor Device) [ 0.278013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.280014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.285797] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.292865] ACPI: Interpreter enabled [ 0.295069] ACPI: PM: (supports S0 S3 S4 S5) [ 0.296015] ACPI: Using IOAPIC for interrupt routing [ 0.298180] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.302619] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.314836] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.317137] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.320031] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.324115] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.330842] acpiphp: Slot [2] registered [ 0.332275] acpiphp: Slot [5] registered [ 0.334306] acpiphp: Slot [6] registered [ 0.336304] acpiphp: Slot [3] registered [ 0.338127] acpiphp: Slot [4] registered [ 0.340407] acpiphp: Slot [7] registered [ 0.342152] acpiphp: Slot [8] registered [ 0.344125] acpiphp: Slot [9] registered [ 0.345127] acpiphp: Slot [10] registered [ 0.348072] acpiphp: Slot [11] registered [ 0.349101] acpiphp: Slot [12] registered [ 0.350121] acpiphp: Slot [13] registered [ 0.352090] acpiphp: Slot [14] registered [ 0.353100] acpiphp: Slot [15] registered [ 0.354147] acpiphp: Slot [16] registered [ 0.355074] acpiphp: Slot [17] registered [ 0.356076] acpiphp: Slot [18] registered [ 0.357075] acpiphp: Slot [19] registered [ 0.358119] acpiphp: Slot [20] registered [ 0.360082] acpiphp: Slot [21] registered [ 0.361079] acpiphp: Slot [22] registered [ 0.362078] acpiphp: Slot [23] registered [ 0.363072] acpiphp: Slot [24] registered [ 0.364091] acpiphp: Slot [25] registered [ 0.366095] acpiphp: Slot [26] registered [ 0.367073] acpiphp: Slot [27] registered [ 0.368085] acpiphp: Slot [28] registered [ 0.369114] acpiphp: Slot [29] registered [ 0.370172] acpiphp: Slot [30] registered [ 0.372082] acpiphp: Slot [31] registered [ 0.373082] PCI host bridge to bus 0000:00 [ 0.374022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.376025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.379024] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.381029] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.384029] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.386051] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.388249] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.391120] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.394536] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.401017] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.405055] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.407020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.410022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.412021] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.415377] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.417889] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.420042] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.422872] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.428021] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.436019] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.439000] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.444019] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.451022] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.454021] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.469057] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.479804] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.489022] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.494068] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.512021] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.519468] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.522372] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.524600] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.526349] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.527362] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.534044] iommu: Default domain type: Passthrough [ 0.536489] SCSI subsystem initialized [ 0.538235] ACPI: bus type USB registered [ 0.540235] usbcore: registered new interface driver usbfs [ 0.542130] usbcore: registered new interface driver hub [ 0.545113] usbcore: registered new device driver usb [ 0.547322] pps_core: LinuxPPS API ver. 1 registered [ 0.549012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.552074] PTP clock support registered [ 0.554159] EDAC MC: Ver: 3.0.0 [ 0.555078] PCI: Using ACPI for IRQ routing [ 0.556000] NetLabel: Initializing [ 0.557011] NetLabel: domain hash size = 128 [ 0.559109] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.561107] NetLabel: unlabeled traffic allowed by default [ 0.563483] vgaarb: loaded [ 0.565579] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.568016] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.574400] clocksource: Switched to clocksource kvm-clock [ 0.717826] VFS: Disk quotas dquot_6.6.0 [ 0.719315] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.721306] *** VALIDATE ramfs *** [ 0.722097] *** VALIDATE hugetlbfs *** [ 0.723147] pnp: PnP ACPI init [ 0.724991] pnp: PnP ACPI: found 6 devices [ 0.743206] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.745958] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.747943] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.749958] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.752038] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.754368] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.757068] NET: Registered protocol family 2 [ 0.759938] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.765498] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.768893] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.777990] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.781517] TCP: Hash tables configured (established 65536 bind 65536) [ 0.784452] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.787913] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.790749] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.793211] NET: Registered protocol family 1 [ 0.795862] RPC: Registered named UNIX socket transport module. [ 0.798286] RPC: Registered udp transport module. [ 0.799909] RPC: Registered tcp transport module. [ 0.801567] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.803309] NET: Registered protocol family 44 [ 0.804590] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.806359] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.807989] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.809824] PCI: CLS 0 bytes, default 64 [ 0.811888] Unpacking initramfs... [ 2.552570] debug: unmapping init [mem 0xffff9926fcc64000-0xffff9926fffcffff] [ 2.556271] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.557899] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.561627] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.129330] Initialise system trusted keyrings [ 3.131250] Key type blacklist registered [ 3.133214] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.142283] zbud: loaded [ 3.144943] *** VALIDATE nfs *** [ 3.145939] *** VALIDATE nfs4 *** [ 3.147357] pstore: using deflate compression [ 3.151174] Platform Keyring initialized [ 3.263590] NET: Registered protocol family 38 [ 3.265551] Key type asymmetric registered [ 3.267302] Asymmetric key parser 'x509' registered [ 3.268905] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.272293] io scheduler mq-deadline registered [ 3.274112] io scheduler kyber registered [ 3.276303] io scheduler bfq registered [ 3.278727] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.280741] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.283410] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.286465] ACPI: Power Button [PWRF] [ 3.291567] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.299196] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.324718] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.355051] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.383356] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.388490] Non-volatile memory driver v1.3 [ 3.389965] Linux agpgart interface v0.103 [ 3.418895] virtio_blk virtio1: [vda] 133944 512-byte logical blocks (68.6 MB/65.4 MiB) [ 3.421712] vda: detected capacity change from 0 to 68579328 [ 3.439749] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.442873] vdb: detected capacity change from 0 to 1073741824 [ 3.449361] libphy: Fixed MDIO Bus: probed [ 3.467818] usbcore: registered new interface driver usbserial_generic [ 3.470552] usbserial: USB Serial support registered for generic [ 3.473194] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.479019] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.481853] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.485581] mousedev: PS/2 mouse device common for all mice [ 3.488429] rtc_cmos 00:05: RTC can wake from S4 [ 3.492987] rtc_cmos 00:05: registered as rtc0 [ 3.495525] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.498628] intel_pstate: CPU model not supported [ 3.498830] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.507213] hid: raw HID events driver (C) Jiri Kosina [ 3.510916] usbcore: registered new interface driver usbhid [ 3.514121] usbhid: USB HID core driver [ 3.515601] drop_monitor: Initializing network drop monitor service [ 3.518217] Initializing XFRM netlink socket [ 3.520274] NET: Registered protocol family 10 [ 3.524212] Segment Routing with IPv6 [ 3.525876] NET: Registered protocol family 17 [ 3.527665] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.529124] mpls_gso: MPLS GSO support [ 3.538900] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.543845] RAS: Correctable Errors collector initialized. [ 3.545981] AVX version of gcm_enc/dec engaged. [ 3.547765] AES CTR mode by8 optimization enabled [ 3.633784] sched_clock: Marking stable (3633766135, 0)->(4514669283, -880903148) [ 3.637895] registered taskstats version 1 [ 3.639849] Loading compiled-in X.509 certificates [ 3.642527] zswap: loaded using pool lzo/zbud [ 3.667939] Key type big_key registered [ 3.680877] Key type encrypted registered [ 3.682516] ima: No TPM chip found, activating TPM-bypass! [ 3.684713] ima: Allocated hash algorithm: sha1 [ 3.686432] ima: No architecture policies found [ 3.688161] evm: Initialising EVM extended attributes: [ 3.689782] evm: security.selinux [ 3.690934] evm: security.ima [ 3.691988] evm: security.capability [ 3.693323] evm: HMAC attrs: 0x1 [ 3.695605] rtc_cmos 00:05: setting system clock to 2026-04-23 04:39:13 UTC (1776919153) [ 3.702889] debug: unmapping init [mem 0xffffffffa1803000-0xffffffffa19fffff] [ 3.705960] debug: unmapping init [mem 0xffffffffa0582000-0xffffffffa0858fff] [ 3.716236] Write protecting the kernel read-only data: 28672k [ 3.721649] debug: unmapping init [mem 0xffffffff9ec03000-0xffffffff9edfffff] [ 3.724209] debug: unmapping init [mem 0xffffffff9f514000-0xffffffff9f5fffff] [ 3.756225] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.763957] systemd[1]: Detected virtualization kvm. [ 3.765888] systemd[1]: Detected architecture x86-64. [ 3.767414] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.801194] systemd[1]: No hostname configured. [ 3.802777] systemd[1]: Set hostname to . [ 3.804777] random: systemd: uninitialized urandom read (16 bytes read) [ 3.806992] systemd[1]: Initializing machine ID from random generator. [ 3.912458] random: ln: uninitialized urandom read (6 bytes read) [ 4.076908] random: systemd: uninitialized urandom read (16 bytes read) [ 4.079806] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 4.085954] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 4.091112] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Swap. [ OK ] Reached target Paths. [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket. Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... Starting Setup Virtual Console... Starting Create Volatile Files and Directories... [ OK ] Reached target Sockets. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.939723] device-mapper: uevent: version 1.0.3 [ 4.941646] 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. [ 5.993645] virtio_net virtio0 ens2: renamed from eth0 [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 6.627084] scsi host0: ata_piix [ 6.701493] scsi host1: ata_piix [ 6.703591] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 6.712313] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 11.223386] random: crng init done [ 11.224861] random: 7 urandom warning(s) missed due to ratelimiting [ 13.834192] dracut-initqueue[585]: 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... [ 15.298733] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 17.191656] printk: systemd: 25 output lines suppressed due to ratelimiting [ 17.838948] SELinux: Disabled at runtime. [ 17.897284] 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) [ 17.906318] systemd[1]: Detected virtualization kvm. [ 17.908344] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 18.939158] systemd[1]: initrd-switch-root.service: Succeeded. [ 18.946292] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 18.957793] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 18.964715] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 18.975179] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 19.003491] systemd[1]: Starting Journal Service... Starting Journal Service... [ 19.020913] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on udev Control Socket. [ OK ] Reached target rpc_pipefs.target. Starting Remount Root and Kernel File Systems... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting POSIX Message Queue File System... [ OK ] Created slice system-getty.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ 19.290215] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Process Core Dump Socket. [ OK ] Stopped target Initrd File Systems. [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-serial\x2dgetty.slice. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting udev Coldplug all Devices... Mounting Huge Pages File System... [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... 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. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 21.057943] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 23.131943] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 23.251191] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 25.275724] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 25.363540] EDAC sbridge: Ver: 1.1.2 [ 26.796162] Key type dns_resolver registered [* ] A start job is running for Configur…-only root support (8s / no limit)[ 27.402501] NFS: Registering the id_resolver key type [ 27.404776] Key type id_resolver registered [ 27.406768] Key type id_legacy registered [** ] A start job is running for Configur…-only root support (8s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started daily update of the root trust anchor for DNSSEC. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started dnf makecache --timer. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started irqbalance daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Login Service. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. Starting Authorization Manager... [ OK ] Started System Logging Service. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. [ OK ] Started Authorization Manager. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg229-client login: [ 74.447831] libcfs: loading out-of-tree module taints kernel. [ 74.484192] Key type ._llcrypt registered [ 74.486900] Key type .llcrypt registered [ 74.763133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 74.788323] alg: No test for adler32 (adler32-zlib) [ 76.032335] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 76.573786] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 78.272583] Key type lgssc registered [ 79.389348] Lustre: Echo OBD driver; http://www.lustre.org/ [ 173.324570] Lustre: Mounted lustre-client [ 176.605312] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 190.825594] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing check_logdir /tmp/testlogs/ [ 193.522874] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing yml_node [ 196.284896] Lustre: DEBUG MARKER: Client: 2.17.51.74 [ 197.830247] Lustre: DEBUG MARKER: MDS: 2.17.51.74 [ 199.136468] Lustre: lustre-OST0000-osc-ffff9927469e1800: disconnect after 24s idle [ 199.465976] Lustre: DEBUG MARKER: OSS: 2.17.51.74 [ 200.437699] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Apr 23 00:42:29 EDT 2026 [ 211.488124] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 212.329567] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 213.534694] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 223.818512] Lustre: Unmounted lustre-client [ 284.731933] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 286.440300] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 296.739718] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 322.311768] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 00:44:31 (1776919471) [ 323.674537] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 324.486086] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 00:44:33 (1776919473) [ 339.160921] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 341.359962] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 349.672069] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 355.317760] Lustre: Mounted lustre-client [ 360.862042] LustreError: 14411:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750dda000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 360.895270] Lustre: Unmounted lustre-client [ 379.349952] Key type lgssc unregistered [ 379.477437] LNet: 14821:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 379.480938] LNetError: 14821:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 379.490946] LNet: Removed LNI 192.168.202.29@tcp [ 379.803804] Key type .llcrypt unregistered [ 379.806396] Key type ._llcrypt unregistered [ 386.732850] Key type ._llcrypt registered [ 386.734225] Key type .llcrypt registered [ 387.380931] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 00:45:36 (1776919536) [ 388.021688] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 388.038260] alg: No test for adler32 (adler32-zlib) [ 388.925172] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 389.023823] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 390.624167] Key type lgssc registered [ 391.192995] Lustre: Echo OBD driver; http://www.lustre.org/ [ 430.556222] Lustre: Mounted lustre-client [ 510.161965] LustreError: 18193:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927522fb800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 510.183806] Lustre: Unmounted lustre-client [ 524.808443] Key type lgssc unregistered [ 524.937930] LNet: 18657:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 524.940680] LNetError: 18657:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 524.950991] LNet: Removed LNI 192.168.202.29@tcp [ 525.212964] Key type .llcrypt unregistered [ 525.214429] Key type ._llcrypt unregistered [ 528.857576] Key type ._llcrypt registered [ 528.859173] Key type .llcrypt registered [ 529.385290] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 00:47:58 (1776919678) [ 530.202875] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 530.233426] alg: No test for adler32 (adler32-zlib) [ 531.102799] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 531.189803] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 532.784182] Key type lgssc registered [ 533.227038] Lustre: Echo OBD driver; http://www.lustre.org/ [ 553.406557] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 554.839953] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 562.493810] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 572.930984] Lustre: Mounted lustre-client [ 577.599110] LustreError: 21756:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927469e0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 577.639156] Lustre: Unmounted lustre-client [ 596.075755] Key type lgssc unregistered [ 596.197851] LNet: 22157:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 596.201492] LNetError: 22157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 596.213770] LNet: Removed LNI 192.168.202.29@tcp [ 596.523555] Key type .llcrypt unregistered [ 596.525394] Key type ._llcrypt unregistered [ 600.469096] Key type ._llcrypt registered [ 600.470675] Key type .llcrypt registered [ 601.032749] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 00:49:10 (1776919750) [ 602.026245] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 602.034590] alg: No test for adler32 (adler32-zlib) [ 602.916487] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 603.014899] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 604.600172] Key type lgssc registered [ 605.017658] Lustre: Echo OBD driver; http://www.lustre.org/ [ 624.165429] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 625.466068] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 632.284728] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 643.062755] Lustre: Mounted lustre-client [ 646.007114] LustreError: 24846:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750dd8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 646.043367] Lustre: Unmounted lustre-client [ 664.204643] Key type lgssc unregistered [ 664.327607] LNet: 25248:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 664.332271] LNetError: 25248:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 664.339878] LNet: Removed LNI 192.168.202.29@tcp [ 664.621424] Key type .llcrypt unregistered [ 664.622783] Key type ._llcrypt unregistered [ 670.335181] Key type ._llcrypt registered [ 670.336348] Key type .llcrypt registered [ 670.892515] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 00:50:20 (1776919820) [ 671.851592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 671.862327] alg: No test for adler32 (adler32-zlib) [ 672.732165] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 672.828877] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 674.416128] Key type lgssc registered [ 674.848543] Lustre: Echo OBD driver; http://www.lustre.org/ [ 695.375769] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 696.934659] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 704.666796] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 715.250366] Lustre: Mounted lustre-client [ 720.355503] Lustre: lustre-MDT0000-mdc-ffff9927469e0800: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 725.477343] Lustre: lustre-MDT0001-mdc-ffff9927469e0800: Connection to lustre-MDT0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 732.410467] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 741.728188] Lustre: 26204:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1776919875/real 1776919875] req@00000000dbbf4161 x1863235479279488/t0(0) o400->MGC192.168.202.129@tcp@192.168.202.129@tcp:26/25 lens 224/224 e 0 to 1 dl 1776919891 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 741.741272] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 742.722729] Lustre: Unmounted lustre-client [ 754.351471] Key type lgssc unregistered [ 754.508365] LNet: 28807:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 754.513575] LNetError: 28807:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 754.523411] LNet: Removed LNI 192.168.202.29@tcp [ 754.911975] Key type .llcrypt unregistered [ 754.913237] Key type ._llcrypt unregistered [ 761.410791] Key type ._llcrypt registered [ 761.412188] Key type .llcrypt registered [ 762.111084] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 00:51:51 (1776919911) [ 763.174472] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 763.183643] alg: No test for adler32 (adler32-zlib) [ 764.140689] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 764.281786] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 765.913232] Key type lgssc registered [ 766.526836] Lustre: Echo OBD driver; http://www.lustre.org/ [ 788.016567] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 789.973930] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 797.517682] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 807.930882] Lustre: Mounted lustre-client [ 813.028200] Lustre: lustre-OST0000-osc-ffff9927536f7800: Connection to lustre-OST0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 817.293893] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 827.590498] Lustre: Unmounted lustre-client [ 846.764835] Key type lgssc unregistered [ 846.922384] LNet: 32324:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 846.930266] LNetError: 32324:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 846.943682] LNet: Removed LNI 192.168.202.29@tcp [ 847.262718] Key type .llcrypt unregistered [ 847.265320] Key type ._llcrypt unregistered [ 854.748135] Key type ._llcrypt registered [ 854.749761] Key type .llcrypt registered [ 855.368362] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 00:53:24 (1776920004) [ 856.519764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 856.527943] alg: No test for adler32 (adler32-zlib) [ 857.425387] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 857.555631] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 859.184263] Key type lgssc registered [ 859.771553] Lustre: Echo OBD driver; http://www.lustre.org/ [ 882.060728] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 883.534749] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 890.718082] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 901.114764] Lustre: Mounted lustre-client [ 903.160592] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 904.773452] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 915.566168] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-04-23 0h54m24s [ 916.537377] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 921.571153] Lustre: lustre-MDT0000-mdc-ffff9927522fb000: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 932.700119] LustreError: 36023:0:(lmv_obd.c:1437:lmv_statfs()) lustre-MDT0000-mdc-ffff9927522fb000: can't stat MDS #0: rc = -19 [ 933.309895] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 938.983855] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 938.991690] Lustre: Evicted from MGS (at 192.168.202.129@tcp) after server handle changed from 0xb07fb304000302ce to 0xb07fb30400030671 [ 938.996069] Lustre: MGC192.168.202.129@tcp: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 939.367475] Lustre: DEBUG MARKER: Wait for df (36023) ... [ 939.935162] Lustre: DEBUG MARKER: done [ 940.004862] LustreError: lustre-MDT0000-mdc-ffff9927522fb000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 940.012245] Lustre: lustre-MDT0000-mdc-ffff9927522fb000: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 940.322638] LustreError: 36632:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927522fb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 940.350789] Lustre: Unmounted lustre-client [ 956.126942] Key type lgssc unregistered [ 956.262673] LNet: 37033:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 956.266315] LNetError: 37033:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 956.276531] LNet: Removed LNI 192.168.202.29@tcp [ 956.533304] Key type .llcrypt unregistered [ 956.534822] Key type ._llcrypt unregistered [ 967.434712] Key type ._llcrypt registered [ 967.436083] Key type .llcrypt registered [ 967.940700] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 00:55:17 (1776920117) [ 968.886334] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 968.894281] alg: No test for adler32 (adler32-zlib) [ 969.768860] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 969.865366] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 971.464190] Key type lgssc registered [ 971.898463] Lustre: Echo OBD driver; http://www.lustre.org/ [ 990.744492] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 992.062660] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 999.406249] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1001.828873] Lustre: Mounted lustre-client [ 1005.289276] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-04-23 0h55m53s [ 1006.935587] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1016.946593] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1019.007519] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1039.328371] Lustre: 41083:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1776920168/real 1776920168] req@0000000038af44d9 x1863235790707456/t0(0) o101->lustre-MDT0000-mdc-ffff992750ddc800@192.168.202.129@tcp:12/10 lens 576/1152 e 0 to 1 dl 1776920188 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1039.374759] Lustre: lustre-MDT0000-mdc-ffff992750ddc800: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1039.434942] Lustre: lustre-MDT0000-mdc-ffff992750ddc800: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 1061.025063] hrtimer: interrupt took 3355166 ns [ 1062.064924] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1068.018289] Lustre: DEBUG MARKER: done [ 1075.027646] LustreError: 41566:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750ddc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1075.159094] Lustre: Unmounted lustre-client [ 1111.586393] Key type lgssc unregistered [ 1111.985965] LNet: 41970:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1111.991981] LNetError: 41970:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1112.018764] LNet: Removed LNI 192.168.202.29@tcp [ 1112.846508] Key type .llcrypt unregistered [ 1112.848604] Key type ._llcrypt unregistered [ 1140.027965] Key type ._llcrypt registered [ 1140.032306] Key type .llcrypt registered [ 1141.015783] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 00:58:09 (1776920289) [ 1142.349941] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1144.315571] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 00:58:12 (1776920292) [ 1147.613434] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1147.627853] alg: No test for adler32 (adler32-zlib) [ 1148.623975] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1148.854287] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1150.602901] Key type lgssc registered [ 1152.010885] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1180.603138] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 00:58:48 (1776920328) [ 1210.702502] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1214.202907] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1222.695820] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1230.322619] Lustre: Mounted lustre-client [ 1232.568953] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1233.680443] LustreError: 46315:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99275024a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1233.738262] Lustre: Unmounted lustre-client [ 1244.901759] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1262.861421] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1264.374166] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1264.630111] Lustre: Mounted lustre-client [ 1265.925767] LustreError: 47571:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992751e94000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1265.975995] Lustre: Unmounted lustre-client [ 1294.044267] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1295.512670] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1295.721364] Lustre: Mounted lustre-client [ 1296.857745] LustreError: 48684:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99274508f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1296.898135] Lustre: Unmounted lustre-client [ 1309.791958] Lustre: DEBUG MARKER: files compared the same [ 1325.347810] Key type lgssc unregistered [ 1325.490839] LNet: 49403:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1325.493787] LNetError: 49403:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1325.505834] LNet: Removed LNI 192.168.202.29@tcp [ 1325.805240] Key type .llcrypt unregistered [ 1325.807068] Key type ._llcrypt unregistered [ 1331.723114] Key type ._llcrypt registered [ 1331.724622] Key type .llcrypt registered [ 1332.389658] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 01:01:21 (1776920481) [ 1333.717460] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1333.733582] alg: No test for adler32 (adler32-zlib) [ 1334.646654] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1334.762407] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1336.376320] Key type lgssc registered [ 1337.074311] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1357.195156] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1358.674287] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1366.583553] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1378.288784] Lustre: Mounted lustre-client [ 1380.031082] LustreError: 52489:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927522fc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1380.061761] Lustre: Unmounted lustre-client [ 1406.859044] Key type lgssc unregistered [ 1406.988544] LNet: 52893:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1406.991033] LNetError: 52893:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1406.999773] LNet: Removed LNI 192.168.202.29@tcp [ 1407.294996] Key type .llcrypt unregistered [ 1407.296976] Key type ._llcrypt unregistered [ 1413.560494] Key type ._llcrypt registered [ 1413.561768] Key type .llcrypt registered [ 1414.011467] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 01:02:43 (1776920563) [ 1414.885857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1414.896872] alg: No test for adler32 (adler32-zlib) [ 1415.768508] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1415.863517] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1417.456274] Key type lgssc registered [ 1417.877689] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1478.690747] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1492.064549] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1493.430381] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1511.665448] Key type lgssc unregistered [ 1511.786463] LNet: 56279:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1511.789260] LNetError: 56279:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1511.797598] LNet: Removed LNI 192.168.202.29@tcp [ 1512.019437] Key type .llcrypt unregistered [ 1512.020909] Key type ._llcrypt unregistered [ 1517.612260] Key type ._llcrypt registered [ 1517.613798] Key type .llcrypt registered [ 1518.118968] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 01:04:27 (1776920667) [ 1519.278569] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1519.286842] alg: No test for adler32 (adler32-zlib) [ 1520.166276] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1520.260155] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1521.856212] Key type lgssc registered [ 1522.271873] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1552.695508] Lustre: Mounted lustre-client [ 1558.277581] LustreError: 58770:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992746997800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1558.306983] Lustre: Unmounted lustre-client [ 1579.581812] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 01:05:28 (1776920728) [ 1622.206453] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1628.217838] Lustre: Mounted lustre-client [ 1633.603579] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1633.606615] LustreError: 62713:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9927441ec800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1633.614750] Lustre: 57269:0:(llite_lib.c:4149:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.129@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1643.902317] Lustre: Unmounted lustre-client [ 1671.375488] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 01:07:00 (1776920820) [ 1675.797570] Key type lgssc unregistered [ 1675.937935] LNet: 63921:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1675.941306] LNetError: 63921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1675.951371] LNet: Removed LNI 192.168.202.29@tcp [ 1676.213360] Key type .llcrypt unregistered [ 1676.214731] Key type ._llcrypt unregistered [ 1680.438404] Key type ._llcrypt registered [ 1680.439513] Key type .llcrypt registered [ 1680.640786] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1680.646506] alg: No test for adler32 (adler32-zlib) [ 1681.504616] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1681.586586] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1683.168206] Key type lgssc registered [ 1683.611295] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1703.161900] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1704.785098] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1711.593386] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1722.356567] Lustre: Mounted lustre-client [ 1724.038659] LustreError: 66438:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992751e94000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1724.072906] Lustre: Unmounted lustre-client [ 1750.738510] Key type lgssc unregistered [ 1750.931944] LNet: 66843:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1750.934505] LNetError: 66843:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1750.947876] LNet: Removed LNI 192.168.202.29@tcp [ 1751.276708] Key type .llcrypt unregistered [ 1751.281173] Key type ._llcrypt unregistered [ 1755.283672] Key type ._llcrypt registered [ 1755.285312] Key type .llcrypt registered [ 1755.521699] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1755.526631] alg: No test for adler32 (adler32-zlib) [ 1756.413373] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1756.508592] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1758.096126] Key type lgssc registered [ 1758.620568] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1809.359965] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1810.648903] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1816.873820] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1827.311743] Lustre: Mounted lustre-client [ 1827.762334] LustreError: 69790:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992744e6c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1827.795262] Lustre: Unmounted lustre-client [ 1845.493185] Key type lgssc unregistered [ 1845.637907] LNet: 70193:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1845.642619] LNetError: 70193:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1845.650994] LNet: Removed LNI 192.168.202.29@tcp [ 1845.930991] Key type .llcrypt unregistered [ 1845.932661] Key type ._llcrypt unregistered [ 1851.756400] Key type ._llcrypt registered [ 1851.757645] Key type .llcrypt registered [ 1852.292258] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 01:10:01 (1776921001) [ 1853.131360] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1853.196793] alg: No test for adler32 (adler32-zlib) [ 1854.076253] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1854.162097] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1855.752198] Key type lgssc registered [ 1856.238611] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1876.237609] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1877.604174] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1884.055913] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1894.382569] Lustre: Mounted lustre-client [ 1896.576817] LustreError: 73310:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500a2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1896.604510] Lustre: Unmounted lustre-client [ 1896.724561] Lustre: Mounted lustre-client [ 1897.346343] LustreError: 73384:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992752a18800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1897.378149] Lustre: Unmounted lustre-client [ 1913.537236] Key type lgssc unregistered [ 1913.760261] LNet: 73785:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1913.767950] LNetError: 73785:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1913.785517] LNet: Removed LNI 192.168.202.29@tcp [ 1914.457236] Key type .llcrypt unregistered [ 1914.459558] Key type ._llcrypt unregistered [ 1924.582543] Key type ._llcrypt registered [ 1924.585409] Key type .llcrypt registered [ 1925.102707] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1925.117382] alg: No test for adler32 (adler32-zlib) [ 1926.076586] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 1926.294523] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 1927.947104] Key type lgssc registered [ 1930.018487] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1984.842502] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1987.589376] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2000.966617] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2007.051826] Lustre: Mounted lustre-client [ 2009.803834] LustreError: 76332:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992746993000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2009.867161] Lustre: Unmounted lustre-client [ 2033.178489] Key type lgssc unregistered [ 2033.404818] LNet: 76733:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2033.410666] LNetError: 76733:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2033.429129] LNet: Removed LNI 192.168.202.29@tcp [ 2033.924731] Key type .llcrypt unregistered [ 2033.926486] Key type ._llcrypt unregistered [ 2045.652613] Key type ._llcrypt registered [ 2045.654027] Key type .llcrypt registered [ 2046.742355] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 01:13:15 (1776921195) [ 2048.379310] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2048.405471] alg: No test for adler32 (adler32-zlib) [ 2049.394099] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 2049.572320] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 2051.200239] Key type lgssc registered [ 2052.173365] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2084.819143] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2087.299092] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2099.054375] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2100.475302] Lustre: Mounted lustre-client [ 2114.073099] Lustre: lustre: nosquash_nids is cleared [ 2114.092607] Lustre: lustre: root_squash is set to 500:500 [ 2122.019630] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.29@tcp 192.168.0.[2,10]@tcp [ 2139.163803] Lustre: lustre: nosquash_nids set to 192.168.202.29/24@tcp [ 2141.703730] LustreError: 80227:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992753484000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2141.787582] Lustre: Unmounted lustre-client [ 2164.736546] Key type lgssc unregistered [ 2164.932815] LNet: 80630:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2164.938252] LNetError: 80630:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2164.966872] LNet: Removed LNI 192.168.202.29@tcp [ 2165.415466] Key type .llcrypt unregistered [ 2165.417232] Key type ._llcrypt unregistered [ 2175.735551] Key type ._llcrypt registered [ 2175.737019] Key type .llcrypt registered [ 2176.827162] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 01:15:25 (1776921325) [ 2178.410785] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2179.539947] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 01:15:28 (1776921328) [ 2181.137345] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2181.145433] alg: No test for adler32 (adler32-zlib) [ 2182.097967] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 2182.252412] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 2183.912446] Key type lgssc registered [ 2184.638390] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2217.302841] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2220.224527] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2231.895867] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2233.297266] Lustre: lustre: root_squash is set to 500:500 [ 2233.331475] Lustre: lustre: nosquash_nids set to 192.168.202.29/24@tcp [ 2234.389396] Lustre: Mounted lustre-client [ 2241.748726] LustreError: 84108:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99274676d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2241.808278] Lustre: Unmounted lustre-client [ 2263.293269] Key type lgssc unregistered [ 2263.495353] LNet: 84511:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2263.503502] LNetError: 84511:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2263.515946] LNet: Removed LNI 192.168.202.29@tcp [ 2263.946298] Key type .llcrypt unregistered [ 2263.948267] Key type ._llcrypt unregistered [ 2273.987170] Key type ._llcrypt registered [ 2273.988465] Key type .llcrypt registered [ 2274.832842] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2276.237235] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 01:17:04 (1776921424) [ 2291.269918] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2291.293798] alg: No test for adler32 (adler32-zlib) [ 2292.287771] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 2292.397552] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 2293.992181] Key type lgssc registered [ 2294.765430] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2351.396614] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2353.726288] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2369.077895] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2418.055094] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2420.762934] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2433.225917] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2441.694200] Lustre: Mounted lustre-client [ 2460.155910] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff992750031800.ost_server_uuid 50 [ 2460.994559] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff992750031800.ost_server_uuid in FULL state after 0 sec [ 2461.301365] Lustre: Mounted lustre-client [ 2463.130580] LustreError: 91400:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500e9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2463.205967] Lustre: Unmounted lustre-client [ 2463.990416] LustreError: 91419:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750031800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2463.998137] LustreError: 91419:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 2464.052088] Lustre: Unmounted lustre-client [ 2497.381560] Key type lgssc unregistered [ 2497.558939] LNet: 91971:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2497.563302] LNetError: 91971:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2497.575304] LNet: Removed LNI 192.168.202.29@tcp [ 2497.888688] Key type .llcrypt unregistered [ 2497.889674] Key type ._llcrypt unregistered [ 2515.576223] Key type ._llcrypt registered [ 2515.577590] Key type .llcrypt registered [ 2516.388599] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 01:21:05 (1776921665) [ 2526.277530] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2526.329260] alg: No test for adler32 (adler32-zlib) [ 2527.282574] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 2527.410933] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 2529.008171] Key type lgssc registered [ 2529.633602] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2574.065480] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2576.149384] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2588.210853] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2590.623372] Lustre: Mounted lustre-client [ 2611.175966] Lustre: lustre-OST0000-osc-ffff992750171800: Connection to lustre-OST0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2612.192166] Lustre: 93339:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1776921745/real 1776921745] req@0000000042cb4f6e x1863237424387328/t0(0) o400->lustre-OST0000-osc-ffff992750171800@192.168.202.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1776921761 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2616.288164] Lustre: 93338:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1776921750/real 1776921750] req@000000008d5f125c x1863237424387840/t0(0) o400->lustre-OST0000-osc-ffff992750171800@192.168.202.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1776921766 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2616.295644] Lustre: lustre-MDT0000-mdc-ffff992750171800: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2621.408233] Lustre: 93339:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1776921755/real 1776921755] req@00000000f61a39ff x1863237424388352/t0(0) o400->lustre-OST0000-osc-ffff992750171800@192.168.202.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1776921771 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2626.385529] Lustre: lustre-OST0000-osc-ffff992750171800: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 2626.530456] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 2626.536760] Lustre: 96419:0:(mgc_request.c:1917:mgc_process_log()) MGC192.168.202.129@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 2626.541239] Lustre: Evicted from MGS (at 192.168.202.129@tcp) after server handle changed from 0xbd771007ac918807 to 0xbd771007ac918abc [ 2631.775793] Lustre: lustre-MDT0000-mdc-ffff992750171800: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 2631.782561] Lustre: Skipped 1 previous similar message [ 2632.272331] LustreError: 97141:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750171800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2632.318678] Lustre: Unmounted lustre-client [ 2653.190643] Key type lgssc unregistered [ 2653.378539] LNet: 97543:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2653.381710] LNetError: 97543:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2653.392280] LNet: Removed LNI 192.168.202.29@tcp [ 2653.746911] Key type .llcrypt unregistered [ 2653.747956] Key type ._llcrypt unregistered [ 2662.361071] Key type ._llcrypt registered [ 2662.362604] Key type .llcrypt registered [ 2663.193577] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 01:23:32 (1776921812) [ 2675.971585] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2676.001307] alg: No test for adler32 (adler32-zlib) [ 2676.988980] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 2677.156970] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 2678.792406] Key type lgssc registered [ 2679.391304] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2699.162914] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2748.707659] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2750.772571] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2761.681444] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2763.981295] Lustre: Mounted lustre-client [ 2765.140397] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2766.286675] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 01:25:15 (1776921915) [ 2893.907514] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2904.192250] Lustre: Unmounted lustre-client [ 2982.140852] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2983.962841] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2995.117139] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3016.032807] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 01:29:25 (1776922165) [ 3057.816836] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3059.897304] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3070.945510] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3071.201735] Lustre: Mounted lustre-client [ 3072.924869] LustreError: 115683:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750175000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3072.968754] Lustre: Unmounted lustre-client [ 3094.335822] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 01:30:43 (1776922243) [ 3136.317781] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3138.260109] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3148.614754] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3148.893415] Lustre: Mounted lustre-client [ 3150.405455] LustreError: 119721:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992746eef000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3150.449212] Lustre: Unmounted lustre-client [ 3169.244898] Key type lgssc unregistered [ 3169.385795] LNet: 120123:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3169.388889] LNetError: 120123:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3169.395933] LNet: Removed LNI 192.168.202.29@tcp [ 3169.741596] Key type .llcrypt unregistered [ 3169.743024] Key type ._llcrypt unregistered [ 3178.664459] Key type ._llcrypt registered [ 3178.666190] Key type .llcrypt registered [ 3179.361586] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 01:32:08 (1776922328) [ 3180.340664] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3180.346762] alg: No test for adler32 (adler32-zlib) [ 3181.245539] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 3181.342197] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 3182.952190] Key type lgssc registered [ 3183.580624] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3205.744577] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3207.446727] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3216.204557] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3223.049785] Lustre: Mounted lustre-client [ 3234.052140] LustreError: 123235:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927467c6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3234.087429] Lustre: Unmounted lustre-client [ 3253.221344] Key type lgssc unregistered [ 3253.364603] LNet: 123638:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3253.367791] LNetError: 123638:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3253.380167] LNet: Removed LNI 192.168.202.29@tcp [ 3253.661077] Key type .llcrypt unregistered [ 3253.663812] Key type ._llcrypt unregistered [ 3259.908208] Key type ._llcrypt registered [ 3259.909364] Key type .llcrypt registered [ 3260.542530] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 01:33:29 (1776922409) [ 3261.584689] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3261.596538] alg: No test for adler32 (adler32-zlib) [ 3262.492518] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 3262.582860] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 3264.168138] Key type lgssc registered [ 3264.684666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3285.064362] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3286.816777] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3294.604355] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3301.367972] Lustre: Mounted lustre-client [ 3306.468421] Lustre: lustre-OST0000-osc-ffff992746f54800: Connection to lustre-OST0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3311.778555] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff992746f54800.ost_server_uuid 50 [ 3312.417654] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 3321.768913] LustreError: 127168:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992746f54800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3321.800222] Lustre: Unmounted lustre-client [ 3333.793966] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 01:34:43 (1776922483) [ 3344.091503] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3345.329617] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3351.678235] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3359.342455] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3364.854549] Lustre: Mounted lustre-client [ 3369.955475] Lustre: lustre-OST0000-osc-ffff9927536f0800: Connection to lustre-OST0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3384.203864] LustreError: 129818:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927536f0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3384.234392] Lustre: Unmounted lustre-client [ 3407.150557] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 01:35:56 (1776922556) [ 3416.634086] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3417.929256] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3423.698847] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3429.738552] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3429.917760] Lustre: Mounted lustre-client [ 3434.980340] Lustre: lustre-OST0000-osc-ffff9927500eb000: Connection to lustre-OST0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3446.677130] LustreError: 132564:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500eb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3446.680796] LustreError: 132564:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 3446.711571] Lustre: Unmounted lustre-client [ 3469.709504] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 01:36:59 (1776922619) [ 3498.890455] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3500.026678] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3507.119153] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3537.135630] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3538.281480] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3544.800809] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3564.961330] Lustre: Mounted lustre-client [ 3592.328820] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3592.900669] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3593.205117] LustreError: 139136:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927469e5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3593.210326] LustreError: 139136:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 3593.239127] Lustre: Unmounted lustre-client [ 3603.291277] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 01:39:12 (1776922752) [ 3612.087583] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3613.247222] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3619.099627] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3640.203886] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3652.966374] Lustre: Mounted lustre-client [ 3679.736965] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3680.270537] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3683.812143] Lustre: lustre-OST0001-osc-ffff992748532000: Connection to lustre-OST0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3687.882551] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3698.171096] Lustre: Unmounted lustre-client [ 3735.494857] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 01:41:24 (1776922884) [ 3744.616401] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3745.806189] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3751.400771] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3757.045047] Lustre: Mounted lustre-client [ 3763.927446] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3764.422679] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3768.063585] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9927536f6800.ost_server_uuid 50 [ 3768.531881] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9927536f6800.ost_server_uuid in FULL state after 0 sec [ 3769.125487] LustreError: 146126:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927536f6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3769.152073] Lustre: Unmounted lustre-client [ 3769.227047] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3769.229218] Lustre: Skipped 3 previous similar messages [ 3769.585516] LustreError: 146188:0:(sec.c:413:import_sec_validate_get()) import 00000000f954de56 (NEW) with no sec [ 3799.726216] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 01:42:29 (1776922949) [ 3809.006276] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3810.110649] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3816.047204] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3821.475838] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3821.593394] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3826.671399] Lustre: Mounted lustre-client [ 3826.672203] Lustre: Skipped 1 previous similar message [ 3831.186114] LustreError: 149003:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927469e2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3831.189572] LustreError: 149003:0:(lov_obd.c:786:lov_cleanup()) Skipped 2 previous similar messages [ 3831.224226] Lustre: Unmounted lustre-client [ 3831.225289] Lustre: Skipped 1 previous similar message [ 3851.614866] Key type lgssc unregistered [ 3851.730804] LNet: 149450:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3851.732811] LNetError: 149450:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3851.741931] LNet: Removed LNI 192.168.202.29@tcp [ 3851.988747] Key type .llcrypt unregistered [ 3851.989794] Key type ._llcrypt unregistered [ 3856.891435] Key type ._llcrypt registered [ 3856.892504] Key type .llcrypt registered [ 3857.372345] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 01:43:26 (1776923006) [ 3857.805912] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3857.831097] alg: No test for adler32 (adler32-zlib) [ 3858.684224] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 3858.761805] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 3860.344176] Key type lgssc registered [ 3860.744987] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3878.365402] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3879.550389] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3885.390265] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3891.205636] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3891.333252] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3896.816584] Lustre: Mounted lustre-client [ 3900.587261] LustreError: lustre-MDT0001-mdc-ffff9927442c2800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 3900.592418] Lustre: lustre-MDT0001-mdc-ffff9927442c2800: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 3902.456280] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3902.992564] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3907.430996] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3919.193572] LustreError: 153642:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927442c2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3919.218430] Lustre: Unmounted lustre-client [ 3938.752887] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 01:44:48 (1776923088) [ 3969.332281] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3970.446086] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3977.267652] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3982.832957] Lustre: Mounted lustre-client [ 3992.626505] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3993.135457] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4007.396651] Lustre: lustre-OST0001-osc-ffff992746eee800: Connection to lustre-OST0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4019.727628] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4030.008695] Lustre: Unmounted lustre-client [ 4053.184222] Key type lgssc unregistered [ 4053.293583] LNet: 158769:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4053.295776] LNetError: 158769:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4053.305792] LNet: Removed LNI 192.168.202.29@tcp [ 4053.515792] Key type .llcrypt unregistered [ 4053.516793] Key type ._llcrypt unregistered [ 4063.682132] Key type ._llcrypt registered [ 4063.682906] Key type .llcrypt registered [ 4064.118530] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 01:46:53 (1776923213) [ 4064.977628] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4064.997461] alg: No test for adler32 (adler32-zlib) [ 4065.882659] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4065.970539] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4067.560181] Key type lgssc registered [ 4067.981042] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4084.687859] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4085.874383] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4091.758381] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4092.907975] Lustre: Mounted lustre-client [ 4129.154515] LustreError: 162028:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927442c7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4129.180132] Lustre: Unmounted lustre-client [ 4145.465841] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4145.610524] Lustre: Mounted lustre-client [ 4177.743819] LustreError: 162679:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927467c5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4177.776494] Lustre: Unmounted lustre-client [ 4195.152236] Key type lgssc unregistered [ 4195.269498] LNet: 163088:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4195.272348] LNetError: 163088:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4195.282586] LNet: Removed LNI 192.168.202.29@tcp [ 4195.515910] Key type .llcrypt unregistered [ 4195.517218] Key type ._llcrypt unregistered [ 4200.770346] Key type ._llcrypt registered [ 4200.771384] Key type .llcrypt registered [ 4201.231794] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 01:49:10 (1776923350) [ 4201.948616] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4201.977566] alg: No test for adler32 (adler32-zlib) [ 4202.835841] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4202.911154] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4204.488118] Key type lgssc registered [ 4204.895587] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4222.317386] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4223.562440] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4229.774242] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4240.365751] Lustre: Mounted lustre-client [ 4247.145023] LustreError: 166359:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992753216800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4247.173155] Lustre: Unmounted lustre-client [ 4264.125964] Key type lgssc unregistered [ 4264.231470] LNet: 166762:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4264.233811] LNetError: 166762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4264.241867] LNet: Removed LNI 192.168.202.29@tcp [ 4264.477120] Key type .llcrypt unregistered [ 4264.478668] Key type ._llcrypt unregistered [ 4268.713532] Key type ._llcrypt registered [ 4268.718057] Key type .llcrypt registered [ 4268.928765] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4268.934318] alg: No test for adler32 (adler32-zlib) [ 4269.788822] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4269.866205] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4271.448118] Key type lgssc registered [ 4271.826598] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4288.741175] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4289.957301] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4295.850913] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4311.538653] Lustre: Mounted lustre-client [ 4314.374107] LustreError: 169328:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500ea800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4314.401103] Lustre: Unmounted lustre-client [ 4340.081992] Key type lgssc unregistered [ 4340.199591] LNet: 169733:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4340.201879] LNetError: 169733:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4340.211655] LNet: Removed LNI 192.168.202.29@tcp [ 4340.466673] Key type .llcrypt unregistered [ 4340.468530] Key type ._llcrypt unregistered [ 4345.992915] Key type ._llcrypt registered [ 4345.994131] Key type .llcrypt registered [ 4346.460521] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 01:51:35 (1776923495) [ 4347.139426] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4347.178632] alg: No test for adler32 (adler32-zlib) [ 4348.030128] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4348.118972] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4349.720217] Key type lgssc registered [ 4350.100320] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4366.899755] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4368.194304] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4374.471121] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4385.263738] Lustre: Mounted lustre-client [ 4391.669792] LustreError: 172986:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99274429c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4391.699307] Lustre: Unmounted lustre-client [ 4416.870714] Key type lgssc unregistered [ 4416.983589] LNet: 173391:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4416.985733] LNetError: 173391:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4416.994404] LNet: Removed LNI 192.168.202.29@tcp [ 4417.209694] Key type .llcrypt unregistered [ 4417.211244] Key type ._llcrypt unregistered [ 4421.151796] Key type ._llcrypt registered [ 4421.152907] Key type .llcrypt registered [ 4421.312418] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4421.317365] alg: No test for adler32 (adler32-zlib) [ 4422.171156] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4422.252327] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4423.824195] Key type lgssc registered [ 4424.196927] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4440.619707] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4441.776520] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4447.331757] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4448.475615] Lustre: Mounted lustre-client [ 4451.098991] LustreError: 175955:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992743977000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4451.129172] Lustre: Unmounted lustre-client [ 4460.294323] Key type lgssc unregistered [ 4460.413577] LNet: 176357:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4460.415852] LNetError: 176357:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4460.423460] LNet: Removed LNI 192.168.202.29@tcp [ 4460.703115] Key type .llcrypt unregistered [ 4460.705066] Key type ._llcrypt unregistered [ 4465.823627] Key type ._llcrypt registered [ 4465.824505] Key type .llcrypt registered [ 4466.301383] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 01:53:35 (1776923615) [ 4473.013605] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4473.025786] alg: No test for adler32 (adler32-zlib) [ 4473.902321] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4473.992088] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4475.576206] Key type lgssc registered [ 4475.981427] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4503.398746] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4504.589408] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4511.596864] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4532.150743] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 01:54:41 (1776923681) [ 4541.186127] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4542.313126] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4548.143797] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4549.304471] Lustre: Mounted lustre-client [ 4551.186215] LustreError: 182850:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99274676d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4551.216205] Lustre: Unmounted lustre-client [ 4568.317825] Key type lgssc unregistered [ 4568.438600] LNet: 183253:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4568.441483] LNetError: 183253:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4568.455469] LNet: Removed LNI 192.168.202.29@tcp [ 4568.700956] Key type .llcrypt unregistered [ 4568.702321] Key type ._llcrypt unregistered [ 4573.996446] Key type ._llcrypt registered [ 4573.997989] Key type .llcrypt registered [ 4574.471744] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4575.043436] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 01:55:24 (1776923724) [ 4581.085621] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4581.112222] alg: No test for adler32 (adler32-zlib) [ 4581.959214] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4582.033740] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4583.616186] Key type lgssc registered [ 4583.947447] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4614.394823] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4615.519961] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4622.515555] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 4628.102975] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 4629.255992] Lustre: Mounted lustre-client [ 4634.757241] LustreError: 188775:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992753210000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 4634.785456] Lustre: Unmounted lustre-client [ 4694.600472] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4695.659298] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4702.369648] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4724.355938] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 01:57:53 (1776923873) [ 4724.814820] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4725.337767] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 01:57:54 (1776923874) [ 4741.701701] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4742.838144] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4769.189202] Key type lgssc unregistered [ 4769.306433] LNet: 194935:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4769.308754] LNetError: 194935:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4769.317691] LNet: Removed LNI 192.168.202.29@tcp [ 4769.532388] Key type .llcrypt unregistered [ 4769.533457] Key type ._llcrypt unregistered [ 4774.060687] Key type ._llcrypt registered [ 4774.061498] Key type .llcrypt registered [ 4774.466170] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 01:58:43 (1776923923) [ 4807.799426] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4807.813381] alg: No test for adler32 (adler32-zlib) [ 4808.671809] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4808.757884] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4810.344233] Key type lgssc registered [ 4810.701542] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4823.812223] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4824.973149] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4843.985099] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4855.247731] Key type lgssc unregistered [ 4855.370348] LNet: 198565:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4855.374720] LNetError: 198565:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4855.384307] LNet: Removed LNI 192.168.202.29@tcp [ 4855.634399] Key type .llcrypt unregistered [ 4855.635927] Key type ._llcrypt unregistered [ 4860.443799] Key type ._llcrypt registered [ 4860.444574] Key type .llcrypt registered [ 4860.880742] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 02:00:10 (1776924010) [ 4861.585319] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4861.614066] alg: No test for adler32 (adler32-zlib) [ 4862.451407] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4862.533698] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4864.112174] Key type lgssc registered [ 4864.483326] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4880.599644] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4881.689618] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4889.303437] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4899.823543] Lustre: Mounted lustre-client [ 4904.931310] Lustre: lustre-MDT0000-mdc-ffff992747326800: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4910.050480] Lustre: lustre-MDT0001-mdc-ffff992747326800: Connection to lustre-MDT0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4920.289925] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 4920.295034] Lustre: Evicted from MGS (at 192.168.202.129@tcp) after server handle changed from 0xeb06dd93e1d0714c to 0xeb06dd93e1d08aac [ 4920.298134] Lustre: MGC192.168.202.129@tcp: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 4927.459547] Lustre: 201580:0:(mgc_request.c:1917:mgc_process_log()) MGC192.168.202.129@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4941.297652] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4945.891299] LustreError: lustre-MDT0000-mdc-ffff992747326800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4945.906152] Lustre: lustre-MDT0000-mdc-ffff992747326800: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 4946.949546] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 5 sec [ 4948.138296] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4948.700688] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4949.276975] LustreError: 203014:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992747326800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4949.306325] Lustre: Unmounted lustre-client [ 4966.419382] Key type lgssc unregistered [ 4966.529609] LNet: 203418:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4966.531973] LNetError: 203418:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4966.540727] LNet: Removed LNI 192.168.202.29@tcp [ 4966.782238] Key type .llcrypt unregistered [ 4966.783155] Key type ._llcrypt unregistered [ 4972.090532] Key type ._llcrypt registered [ 4972.091477] Key type .llcrypt registered [ 4972.535812] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 02:02:01 (1776924121) [ 4973.384348] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4973.392038] alg: No test for adler32 (adler32-zlib) [ 4974.244849] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 4974.319496] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 4975.904123] Key type lgssc registered [ 4976.261858] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4993.411949] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4994.758875] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5023.696646] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5024.873943] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5037.839295] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5044.148474] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5077.418977] Key type lgssc unregistered [ 5077.546481] LNet: 208531:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5077.548755] LNetError: 208531:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5077.557387] LNet: Removed LNI 192.168.202.29@tcp [ 5077.818490] Key type .llcrypt unregistered [ 5077.819451] Key type ._llcrypt unregistered [ 5099.126464] Key type ._llcrypt registered [ 5099.127794] Key type .llcrypt registered [ 5099.570127] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 02:04:08 (1776924248) [ 5111.592618] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5111.605382] alg: No test for adler32 (adler32-zlib) [ 5112.475722] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 5112.558217] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 5114.144105] Key type lgssc registered [ 5114.556411] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5142.705314] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5144.006194] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5151.263373] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5172.010042] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 02:05:21 (1776924321) [ 5174.392711] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 02:05:23 (1776924323) [ 5183.735672] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5184.957293] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5191.088327] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5206.511800] Lustre: Mounted lustre-client [ 5209.744747] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 5210.510166] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5211.080668] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5211.615647] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 5216.739041] Lustre: lustre-MDT0000-mdc-ffff992744f0e000: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5226.981841] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 5226.987873] Lustre: Evicted from MGS (at 192.168.202.129@tcp) after server handle changed from 0xcc4e071fce4fd30 to 0xcc4e071fce4ffa6 [ 5226.990962] Lustre: MGC192.168.202.129@tcp: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 5230.686034] Lustre: lustre-MDT0000-mdc-ffff992744f0e000: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 5231.861375] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5232.400902] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5234.301625] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 5237.219434] Lustre: lustre-MDT0000-mdc-ffff992744f0e000: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5252.578630] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 5252.583689] Lustre: Evicted from MGS (at 192.168.202.129@tcp) after server handle changed from 0xcc4e071fce4ffa6 to 0xcc4e071fce502b6 [ 5252.586889] Lustre: MGC192.168.202.129@tcp: Connection restored to 192.168.202.129@tcp (at 192.168.202.129@tcp) [ 5254.324550] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5254.862135] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5256.406187] LustreError: 218657:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992744f0e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5256.431147] Lustre: Unmounted lustre-client [ 5287.913434] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5289.042540] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5294.859710] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5310.448082] Lustre: Mounted lustre-client [ 5310.783630] LustreError: 220267:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500eb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5310.813105] Lustre: Unmounted lustre-client [ 5320.536370] Key type lgssc unregistered [ 5320.647437] LNet: 220669:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5320.649883] LNetError: 220669:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5320.664555] LNet: Removed LNI 192.168.202.29@tcp [ 5320.898212] Key type .llcrypt unregistered [ 5320.899214] Key type ._llcrypt unregistered [ 5326.197419] Key type ._llcrypt registered [ 5326.198718] Key type .llcrypt registered [ 5326.687109] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 02:07:55 (1776924475) [ 5328.108910] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5328.135185] alg: No test for adler32 (adler32-zlib) [ 5329.017715] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 5329.116925] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 5330.704108] Key type lgssc registered [ 5331.105907] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5348.260345] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5349.534887] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5355.568529] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5366.258702] Lustre: Mounted lustre-client [ 5369.238085] LustreError: 223833:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992746768000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5369.268343] Lustre: Unmounted lustre-client [ 5400.833277] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5401.984442] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5407.992203] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5408.177340] Lustre: Mounted lustre-client [ 5414.076661] LustreError: 225422:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992746e3c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5414.109026] Lustre: Unmounted lustre-client [ 5446.069179] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5447.282891] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5453.141151] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5468.657700] Lustre: Mounted lustre-client [ 5469.028191] LustreError: 227032:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992752d3e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5469.059425] Lustre: Unmounted lustre-client [ 5486.303324] Key type lgssc unregistered [ 5486.429630] LNet: 227436:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5486.431970] LNetError: 227436:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5486.442779] LNet: Removed LNI 192.168.202.29@tcp [ 5486.682316] Key type .llcrypt unregistered [ 5486.684106] Key type ._llcrypt unregistered [ 5491.995101] Key type ._llcrypt registered [ 5491.996152] Key type .llcrypt registered [ 5492.494347] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 02:10:41 (1776924641) [ 5493.604111] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5493.609922] alg: No test for adler32 (adler32-zlib) [ 5494.481148] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 5494.575808] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 5496.176165] Key type lgssc registered [ 5496.585621] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5512.036186] Key type lgssc unregistered [ 5512.150385] LNet: 229751:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5512.153186] LNetError: 229751:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5512.164272] LNet: Removed LNI 192.168.202.29@tcp [ 5512.368324] Key type .llcrypt unregistered [ 5512.369273] Key type ._llcrypt unregistered [ 5521.437722] Key type ._llcrypt registered [ 5521.439248] Key type .llcrypt registered [ 5521.627288] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5521.633325] alg: No test for adler32 (adler32-zlib) [ 5522.494181] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 5522.573391] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 5524.152148] Key type lgssc registered [ 5524.537588] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5552.393460] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5553.650944] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5561.149130] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5582.459149] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 5582.996281] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 02:12:12 (1776924732) [ 5592.846187] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5594.015149] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5600.318123] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5607.602872] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5608.763135] Lustre: Mounted lustre-client [ 5614.051408] Lustre: lustre-OST0001-osc-ffff99274676a800: Connection to lustre-OST0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5616.465693] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5626.747163] Lustre: Unmounted lustre-client [ 5650.163491] Key type lgssc unregistered [ 5650.279594] LNet: 236639:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5650.283888] LNetError: 236639:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5650.292964] LNet: Removed LNI 192.168.202.29@tcp [ 5650.505387] Key type .llcrypt unregistered [ 5650.506445] Key type ._llcrypt unregistered [ 5661.722481] Key type ._llcrypt registered [ 5661.724080] Key type .llcrypt registered [ 5662.137787] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 02:13:31 (1776924811) [ 5667.929076] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5667.938767] alg: No test for adler32 (adler32-zlib) [ 5668.795933] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 5668.882662] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 5670.456177] Key type lgssc registered [ 5670.954001] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5689.361267] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5690.591644] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5710.751283] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 02:14:20 (1776924860) [ 5720.342983] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5721.529429] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5727.626455] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5733.859041] Lustre: Mounted lustre-client [ 5739.432367] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5740.685468] Lustre: Unmounted lustre-client [ 5791.474831] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5792.797454] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5828.714717] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5839.351741] Lustre: Mounted lustre-client [ 5839.786800] LustreError: 243719:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992753212000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5839.820081] Lustre: Unmounted lustre-client [ 5857.751620] Key type lgssc unregistered [ 5857.864461] LNet: 244122:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5857.866911] LNetError: 244122:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5857.876956] LNet: Removed LNI 192.168.202.29@tcp [ 5858.147873] Key type .llcrypt unregistered [ 5858.149307] Key type ._llcrypt unregistered [ 5867.765269] Key type ._llcrypt registered [ 5867.766363] Key type .llcrypt registered [ 5867.938451] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5867.948342] alg: No test for adler32 (adler32-zlib) [ 5868.804142] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 5868.888548] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 5870.472179] Key type lgssc registered [ 5870.939497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5901.818205] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5903.004029] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5910.404640] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5936.281374] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 5937.079863] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 02:18:06 (1776925086) [ 5950.748296] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5952.506419] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5960.641413] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5967.359964] Lustre: Mounted lustre-client [ 5968.359766] LustreError: 250154:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992752dd6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5968.394849] Lustre: Unmounted lustre-client [ 5987.258227] Key type lgssc unregistered [ 5987.380969] LNet: 250557:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5987.385936] LNetError: 250557:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5987.398838] LNet: Removed LNI 192.168.202.29@tcp [ 5987.726984] Key type .llcrypt unregistered [ 5987.729470] Key type ._llcrypt unregistered [ 5993.912431] Key type ._llcrypt registered [ 5993.913439] Key type .llcrypt registered [ 5994.528408] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 5995.431200] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 02:19:04 (1776925144) [ 5998.976312] Key type .llcrypt unregistered [ 5998.977424] Key type ._llcrypt unregistered [ 6002.106199] Key type ._llcrypt registered [ 6002.107640] Key type .llcrypt registered [ 6002.346090] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6002.352102] alg: No test for adler32 (adler32-zlib) [ 6003.275093] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 6003.392579] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 6005.016198] Key type lgssc registered [ 6005.730728] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6027.224627] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6038.529123] Lustre: Mounted lustre-client [ 6038.989445] LustreError: 253573:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992753216000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6039.019910] Lustre: Unmounted lustre-client [ 6057.861276] Key type lgssc unregistered [ 6058.021661] LNet: 253976:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6058.024817] LNetError: 253976:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6058.033625] LNet: Removed LNI 192.168.202.29@tcp [ 6058.337257] Key type .llcrypt unregistered [ 6058.338201] Key type ._llcrypt unregistered [ 6065.044396] Key type ._llcrypt registered [ 6065.045454] Key type .llcrypt registered [ 6065.661091] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 02:20:14 (1776925214) [ 6066.677302] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6066.713129] alg: No test for adler32 (adler32-zlib) [ 6067.557337] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 6067.632390] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 6069.208156] Key type lgssc registered [ 6069.618475] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6131.137757] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6142.626350] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6144.312602] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6145.500514] Lustre: Mounted lustre-client [ 6146.029231] LustreError: 257020:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500ef800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6146.065708] Lustre: Unmounted lustre-client [ 6163.770069] Key type lgssc unregistered [ 6163.885775] LNet: 257425:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6163.890358] LNetError: 257425:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6163.903066] LNet: Removed LNI 192.168.202.29@tcp [ 6164.188910] Key type .llcrypt unregistered [ 6164.190045] Key type ._llcrypt unregistered [ 6169.248128] Key type ._llcrypt registered [ 6169.249163] Key type .llcrypt registered [ 6169.750423] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 02:21:59 (1776925319) [ 6170.645090] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6170.653467] alg: No test for adler32 (adler32-zlib) [ 6171.519200] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 6171.603833] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 6173.208109] Key type lgssc registered [ 6173.557386] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6192.974272] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6194.186400] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6200.341576] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6211.053988] Lustre: Mounted lustre-client [ 6216.163269] Lustre: lustre-MDT0000-mdc-ffff9927541fe800: Connection to lustre-MDT0000 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6218.963645] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6218.971568] LustreError: 260487:0:(file.c:6139:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 6219.060744] LustreError: 260506:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927541fe800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6219.062097] LustreError: MGC192.168.202.129@tcp: Connection to MGS (at 192.168.202.129@tcp) was lost; in progress operations using this service will fail [ 6219.084145] Lustre: Unmounted lustre-client [ 6229.910669] Key type lgssc unregistered [ 6230.039447] LNet: 260901:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6230.041547] LNetError: 260901:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6230.049370] LNet: Removed LNI 192.168.202.29@tcp [ 6230.275395] Key type .llcrypt unregistered [ 6230.276445] Key type ._llcrypt unregistered [ 6235.867909] Key type ._llcrypt registered [ 6235.868896] Key type .llcrypt registered [ 6236.331097] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 02:23:05 (1776925385) [ 6237.085989] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6237.113436] alg: No test for adler32 (adler32-zlib) [ 6237.960955] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 6238.035159] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 6239.608206] Key type lgssc registered [ 6240.188679] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6259.452425] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6260.618205] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6266.717230] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6277.110530] Lustre: Mounted lustre-client [ 6282.211976] Lustre: lustre-MDT0001-mdc-ffff992751e92000: Connection to lustre-MDT0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6284.901079] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6285.210673] LustreError: 263999:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992751e92000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6285.233089] Lustre: Unmounted lustre-client [ 6296.031530] Key type lgssc unregistered [ 6296.137566] LNet: 264393:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6296.140108] LNetError: 264393:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6296.146647] LNet: Removed LNI 192.168.202.29@tcp [ 6296.365624] Key type .llcrypt unregistered [ 6296.366540] Key type ._llcrypt unregistered [ 6301.744729] Key type ._llcrypt registered [ 6301.745747] Key type .llcrypt registered [ 6302.152511] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 02:24:11 (1776925451) [ 6308.160377] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6308.184434] alg: No test for adler32 (adler32-zlib) [ 6309.029281] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 6309.106218] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 6310.680237] Key type lgssc registered [ 6311.161262] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6349.446569] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6355.930293] Lustre: Mounted lustre-client [ 6371.299879] Lustre: lustre-MDT0001-mdc-ffff992746e3e800: Connection to lustre-MDT0001 (at 192.168.202.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6374.300672] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6384.568150] Lustre: Unmounted lustre-client [ 6402.098882] Key type lgssc unregistered [ 6402.204492] LNet: 270130:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6402.206573] LNetError: 270130:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6402.215627] LNet: Removed LNI 192.168.202.29@tcp [ 6402.434610] Key type .llcrypt unregistered [ 6402.435668] Key type ._llcrypt unregistered [ 6408.030164] Key type ._llcrypt registered [ 6408.031942] Key type .llcrypt registered [ 6408.544470] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 02:25:57 (1776925557) [ 6409.219239] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 6409.885307] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 02:25:59 (1776925559) [ 6410.386230] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 6410.889862] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 02:26:00 (1776925560) [ 6411.515553] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 6412.156601] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 02:26:01 (1776925561) [ 6412.639531] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 6413.199860] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 02:26:02 (1776925562) [ 6413.870078] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 6414.513663] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 02:26:03 (1776925563) [ 6418.544308] Key type .llcrypt unregistered [ 6418.546679] Key type ._llcrypt unregistered [ 6421.214577] Key type ._llcrypt registered [ 6421.215697] Key type .llcrypt registered [ 6421.460684] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6421.465957] alg: No test for adler32 (adler32-zlib) [ 6422.354031] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 6422.457302] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 6424.056159] Key type lgssc registered [ 6424.445450] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6454.338287] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6455.583559] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6463.778517] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6470.108622] Lustre: Mounted lustre-client [ 6470.558967] LustreError: 275716:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992748537800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6470.592210] Lustre: Unmounted lustre-client [ 6494.606235] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 02:27:23 (1776925643) [ 6505.814638] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6506.955348] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6527.014978] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6542.836054] Lustre: Mounted lustre-client [ 6543.128677] LustreError: 277830:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99274654e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6543.153637] Lustre: Unmounted lustre-client [ 6573.193517] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 02:28:42 (1776925722) [ 6583.264391] LNet: 1 local NIs in recovery (showing 1): 192.168.202.29@tcp [ 7167.782518] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7168.886169] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7189.847509] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7241.495111] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 02:39:50 (1776926390) [ 7245.050818] Key type lgssc unregistered [ 7245.160479] LNet: 283363:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7245.162491] LNetError: 283363:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7245.168742] LNet: Removed LNI 192.168.202.29@tcp [ 7245.365221] Key type .llcrypt unregistered [ 7245.366066] Key type ._llcrypt unregistered [ 7315.326890] Key type ._llcrypt registered [ 7315.327803] Key type .llcrypt registered [ 7315.477518] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7315.482080] alg: No test for adler32 (adler32-zlib) [ 7316.331852] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 7316.413881] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 7317.992113] Key type lgssc registered [ 7318.419802] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7356.882032] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7357.971712] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7364.562240] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7376.582677] Key type lgssc unregistered [ 7376.680496] LNet: 286947:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7376.682526] LNetError: 286947:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7376.691423] LNet: Removed LNI 192.168.202.29@tcp [ 7376.898378] Key type .llcrypt unregistered [ 7376.899369] Key type ._llcrypt unregistered [ 7395.454531] Key type ._llcrypt registered [ 7395.456011] Key type .llcrypt registered [ 7395.852870] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 02:42:25 (1776926545) [ 7401.742507] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7401.767303] alg: No test for adler32 (adler32-zlib) [ 7402.604398] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 7402.675250] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 7404.248086] Key type lgssc registered [ 7404.552244] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7419.379605] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 02:42:48 (1776926568) [ 7422.755297] Key type lgssc unregistered [ 7422.862387] LNet: 290491:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7422.864395] LNetError: 290491:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7422.872484] LNet: Removed LNI 192.168.202.29@tcp [ 7423.054633] Key type .llcrypt unregistered [ 7423.055969] Key type ._llcrypt unregistered [ 7426.347965] Key type ._llcrypt registered [ 7426.355142] Key type .llcrypt registered [ 7426.508406] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7426.513065] alg: No test for adler32 (adler32-zlib) [ 7427.366298] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 7427.440947] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 7429.016110] Key type lgssc registered [ 7429.342719] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7450.290502] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7451.306760] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7458.207242] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7537.273641] LNet: Added LNI 192.168.202.29@tcp50 [8/256/0/180] [ 7537.919238] LNet: Removed LNI 192.168.202.29@tcp [ 7539.243549] Lustre: 294761:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff99274469f000: config has no valid NIDs, force dynamic NIDs [ 7540.280210] Lustre: Mounted lustre-client [ 7540.299959] LustreError: 294776:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff99274469f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7540.323651] Lustre: Unmounted lustre-client [ 7541.109910] Key type lgssc unregistered [ 7541.249703] LNet: 295026:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7541.252259] LNetError: 295026:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7541.266314] LNet: Removed LNI 192.168.202.29@tcp50 [ 7541.436111] Key type .llcrypt unregistered [ 7541.437081] Key type ._llcrypt unregistered [ 7550.888314] Key type ._llcrypt registered [ 7550.889250] Key type .llcrypt registered [ 7551.028344] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7551.032759] alg: No test for adler32 (adler32-zlib) [ 7551.870117] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 7551.941417] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 7553.512120] Key type lgssc registered [ 7553.826506] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7565.890818] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7566.946061] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7569.080917] LNet: Added LNI 192.168.202.29@tcp50 [8/256/0/180] [ 7569.308397] LNet: Removed LNI 192.168.202.29@tcp [ 7570.346862] Lustre: 297664:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff992750287000: config has no valid NIDs, force dynamic NIDs [ 7571.386696] Lustre: Mounted lustre-client [ 7571.499233] LustreError: 297699:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff992750287000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7571.522079] Lustre: Unmounted lustre-client [ 7589.820177] Key type lgssc unregistered [ 7589.953971] LNet: 298539:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7589.956242] LNetError: 298539:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7589.964425] LNet: Removed LNI 192.168.202.29@tcp50 [ 7590.132112] Key type .llcrypt unregistered [ 7590.133170] Key type ._llcrypt unregistered [ 7593.511733] Key type ._llcrypt registered [ 7593.512539] Key type .llcrypt registered [ 7593.933380] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 02:45:43 (1776926743) [ 7594.903919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7594.923190] alg: No test for adler32 (adler32-zlib) [ 7595.833728] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 7595.953181] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 7597.544168] Key type lgssc registered [ 7598.202176] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7614.788586] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7615.894237] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7621.615270] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7622.780940] Lustre: Mounted lustre-client [ 7644.018440] Lustre: Mounted fs15246-client [ 7648.527439] LustreError: 302666:0:(lov_obd.c:786:lov_cleanup()) fs15246-clilov-ffff992750cce000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7648.542506] Lustre: Unmounted fs15246-client [ 7660.674661] LustreError: 302884:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff9927500ea000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7660.700332] Lustre: Unmounted lustre-client [ 7677.534281] Key type lgssc unregistered [ 7677.645580] LNet: 303286:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7677.647849] LNetError: 303286:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7677.658660] LNet: Removed LNI 192.168.202.29@tcp [ 7677.862159] Key type .llcrypt unregistered [ 7677.863149] Key type ._llcrypt unregistered [ 7681.081598] Key type ._llcrypt registered [ 7681.082477] Key type .llcrypt registered [ 7681.512929] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 02:47:10 (1776926830) [ 7682.015416] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7682.025100] alg: No test for adler32 (adler32-zlib) [ 7682.875430] Lustre: Lustre: Build Version: 2.17.51_74_g68f2299 [ 7682.948464] LNet: Added LNI 192.168.202.29@tcp [8/256/0/180] [ 7684.528078] Key type lgssc registered [ 7684.878549] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7728.028746] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7729.264611] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7736.371265] Lustre: DEBUG MARKER: oleg229-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7777.068922] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 7576 sec ========== 02:48:46 (1776926926) [ 7777.609849] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 02:48:46 (1776926926) === [ 7778.731494] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 02:48:48 (1776926928) === [ 7790.001479] Key type lgssc unregistered [ 7790.122558] LNet: 312425:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7790.124796] LNetError: 312425:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7790.133413] LNet: Removed LNI 192.168.202.29@tcp [ 7790.376615] Key type .llcrypt unregistered [ 7790.377666] Key type ._llcrypt unregistered