[ 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 434199097 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.003195] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005015] kvm-guest: setup PV IPIs [ 0.008437] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009020] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010014] pid_max: default: 32768 minimum: 301 [ 0.011139] LSM: Security Framework initializing [ 0.012058] Yama: becoming mindful. [ 0.013046] SELinux: Initializing. [ 0.014084] *** VALIDATE selinux *** [ 0.022562] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026736] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028137] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029102] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030113] *** VALIDATE tmpfs *** [ 0.032049] *** VALIDATE proc *** [ 0.033238] *** VALIDATE cgroup *** [ 0.034010] *** VALIDATE cgroup2 *** [ 0.036214] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037149] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039029] Spectre V2 : User space: Vulnerable [ 0.040009] Speculative Store Bypass: Vulnerable [ 0.043369] debug: unmapping init [mem 0xffffffffb2a59000-0xffffffffb2a60fff] [ 0.045232] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046699] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047023] ... version: 2 [ 0.048015] ... bit width: 48 [ 0.049013] ... generic registers: 4 [ 0.050014] ... value mask: 0000ffffffffffff [ 0.051016] ... max period: 00007fffffffffff [ 0.052013] ... fixed-purpose events: 3 [ 0.053012] ... event mask: 000000070000000f [ 0.054275] rcu: Hierarchical SRCU implementation. [ 0.056435] smp: Bringing up secondary CPUs ... [ 0.057595] x86: Booting SMP configuration: [ 0.058030] .... node #0, CPUs: #1 #2 #3 [ 0.064159] smp: Brought up 1 node, 4 CPUs [ 0.066019] smpboot: Max logical packages: 1 [ 0.067017] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.239366] node 0 deferred pages initialised in 170ms [ 0.242448] devtmpfs: initialized [ 0.244388] x86/mm: Memory block size: 128MB [ 0.247958] gcov: version magic: 0x41383552 [ 0.250298] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.254095] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.257373] pinctrl core: initialized pinctrl subsystem [ 0.260216] [ 0.262011] ************************************************************* [ 0.264014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.267017] ** ** [ 0.270015] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.272012] ** ** [ 0.275029] ** This means that this kernel is built to expose internal ** [ 0.278014] ** IOMMU data structures, which may compromise security on ** [ 0.280205] ** your system. ** [ 0.283017] ** ** [ 0.285012] ** If you see this message and you are not debugging the ** [ 0.287016] ** kernel, report this immediately to your vendor! ** [ 0.289016] ** ** [ 0.292014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.294012] ************************************************************* [ 0.296752] NET: Registered protocol family 16 [ 0.298477] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.301072] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.304083] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.309134] cpuidle: using governor menu [ 0.310737] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.313527] PCI: Using configuration type 1 for base access [ 0.315154] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.325062] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.327039] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.331319] cryptd: max_cpu_qlen set to 1000 [ 0.334156] ACPI: Added _OSI(Module Device) [ 0.335026] ACPI: Added _OSI(Processor Device) [ 0.336018] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.337036] ACPI: Added _OSI(Processor Aggregator Device) [ 0.342719] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.350556] ACPI: Interpreter enabled [ 0.351053] ACPI: PM: (supports S0 S3 S4 S5) [ 0.353019] ACPI: Using IOAPIC for interrupt routing [ 0.355169] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.359503] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.370500] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.372054] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.375029] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.379107] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.383584] acpiphp: Slot [2] registered [ 0.386203] acpiphp: Slot [5] registered [ 0.387152] acpiphp: Slot [6] registered [ 0.389143] acpiphp: Slot [3] registered [ 0.390069] acpiphp: Slot [4] registered [ 0.391124] acpiphp: Slot [7] registered [ 0.392074] acpiphp: Slot [8] registered [ 0.394092] acpiphp: Slot [9] registered [ 0.395145] acpiphp: Slot [10] registered [ 0.397145] acpiphp: Slot [11] registered [ 0.398125] acpiphp: Slot [12] registered [ 0.399087] acpiphp: Slot [13] registered [ 0.401133] acpiphp: Slot [14] registered [ 0.402086] acpiphp: Slot [15] registered [ 0.403102] acpiphp: Slot [16] registered [ 0.405147] acpiphp: Slot [17] registered [ 0.407167] acpiphp: Slot [18] registered [ 0.409121] acpiphp: Slot [19] registered [ 0.410158] acpiphp: Slot [20] registered [ 0.412124] acpiphp: Slot [21] registered [ 0.414096] acpiphp: Slot [22] registered [ 0.415165] acpiphp: Slot [23] registered [ 0.417102] acpiphp: Slot [24] registered [ 0.418087] acpiphp: Slot [25] registered [ 0.419140] acpiphp: Slot [26] registered [ 0.420118] acpiphp: Slot [27] registered [ 0.422088] acpiphp: Slot [28] registered [ 0.423157] acpiphp: Slot [29] registered [ 0.424090] acpiphp: Slot [30] registered [ 0.425158] acpiphp: Slot [31] registered [ 0.427067] PCI host bridge to bus 0000:00 [ 0.428021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.430026] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.432049] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.436040] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.439031] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.443040] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.445242] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.449384] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.454635] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.462924] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.467042] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.470020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.472018] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.475026] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.478664] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.481255] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.483039] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.487175] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.493022] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.504020] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.510019] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.515402] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.523021] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.529027] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.546020] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.556187] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.562020] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.568017] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.585021] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.597221] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.601663] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.604436] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.608512] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.611276] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.616167] iommu: Default domain type: Passthrough [ 0.618479] SCSI subsystem initialized [ 0.619232] ACPI: bus type USB registered [ 0.621113] usbcore: registered new interface driver usbfs [ 0.623116] usbcore: registered new interface driver hub [ 0.624152] usbcore: registered new device driver usb [ 0.626178] pps_core: LinuxPPS API ver. 1 registered [ 0.627011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.629074] PTP clock support registered [ 0.631160] EDAC MC: Ver: 3.0.0 [ 0.633143] PCI: Using ACPI for IRQ routing [ 0.634814] NetLabel: Initializing [ 0.636018] NetLabel: domain hash size = 128 [ 0.637010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.639087] NetLabel: unlabeled traffic allowed by default [ 0.641294] vgaarb: loaded [ 0.643264] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.645018] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.650643] clocksource: Switched to clocksource kvm-clock [ 0.765586] VFS: Disk quotas dquot_6.6.0 [ 0.766851] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.770778] *** VALIDATE ramfs *** [ 0.771892] *** VALIDATE hugetlbfs *** [ 0.773877] pnp: PnP ACPI init [ 0.776037] pnp: PnP ACPI: found 6 devices [ 0.793958] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.796584] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.798392] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.801457] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.805605] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.807803] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.810410] NET: Registered protocol family 2 [ 0.813116] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.818389] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.822350] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.827862] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.831599] TCP: Hash tables configured (established 65536 bind 65536) [ 0.834627] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.837764] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.840779] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.844182] NET: Registered protocol family 1 [ 0.847610] RPC: Registered named UNIX socket transport module. [ 0.849886] RPC: Registered udp transport module. [ 0.852410] RPC: Registered tcp transport module. [ 0.854354] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.856718] NET: Registered protocol family 44 [ 0.858621] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.860813] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.862991] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.865424] PCI: CLS 0 bytes, default 64 [ 0.867366] Unpacking initramfs... [ 2.267547] debug: unmapping init [mem 0xffff90f07cc64000-0xffff90f07ffcffff] [ 2.271917] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.274186] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.282118] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 4.287395] Initialise system trusted keyrings [ 4.291129] Key type blacklist registered [ 4.296969] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 4.320522] zbud: loaded [ 4.324712] *** VALIDATE nfs *** [ 4.326071] *** VALIDATE nfs4 *** [ 4.330492] pstore: using deflate compression [ 4.357368] Platform Keyring initialized [ 4.618852] NET: Registered protocol family 38 [ 4.622492] Key type asymmetric registered [ 4.625221] Asymmetric key parser 'x509' registered [ 4.631155] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 4.636349] io scheduler mq-deadline registered [ 4.642755] io scheduler kyber registered [ 4.646171] io scheduler bfq registered [ 4.650501] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 4.654161] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 4.660368] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 4.665344] ACPI: Power Button [PWRF] [ 4.678109] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 4.704298] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 4.731413] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 4.770349] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 4.817605] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 4.835665] Non-volatile memory driver v1.3 [ 4.838277] Linux agpgart interface v0.103 [ 4.936833] virtio_blk virtio1: [vda] 134784 512-byte logical blocks (69.0 MB/65.8 MiB) [ 4.943260] vda: detected capacity change from 0 to 69009408 [ 4.988785] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 4.994715] vdb: detected capacity change from 0 to 1073741824 [ 5.009167] libphy: Fixed MDIO Bus: probed [ 5.031631] usbcore: registered new interface driver usbserial_generic [ 5.037840] usbserial: USB Serial support registered for generic [ 5.041615] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 5.049261] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 5.054403] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 5.058292] mousedev: PS/2 mouse device common for all mice [ 5.068085] rtc_cmos 00:05: RTC can wake from S4 [ 5.074253] rtc_cmos 00:05: registered as rtc0 [ 5.077321] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 5.081781] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 5.087427] intel_pstate: CPU model not supported [ 5.092883] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 5.100844] hid: raw HID events driver (C) Jiri Kosina [ 5.103499] usbcore: registered new interface driver usbhid [ 5.106691] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 5.112487] usbhid: USB HID core driver [ 5.124422] drop_monitor: Initializing network drop monitor service [ 5.128267] Initializing XFRM netlink socket [ 5.131526] NET: Registered protocol family 10 [ 5.135873] Segment Routing with IPv6 [ 5.140682] NET: Registered protocol family 17 [ 5.143072] mpls_gso: MPLS GSO support [ 5.149799] RAS: Correctable Errors collector initialized. [ 5.153304] AVX version of gcm_enc/dec engaged. [ 5.155703] AES CTR mode by8 optimization enabled [ 5.258795] sched_clock: Marking stable (5258714322, 0)->(6200048745, -941334423) [ 5.263635] registered taskstats version 1 [ 5.266802] Loading compiled-in X.509 certificates [ 5.270661] zswap: loaded using pool lzo/zbud [ 5.304692] Key type big_key registered [ 5.325114] Key type encrypted registered [ 5.326819] ima: No TPM chip found, activating TPM-bypass! [ 5.328757] ima: Allocated hash algorithm: sha1 [ 5.336509] ima: No architecture policies found [ 5.339565] evm: Initialising EVM extended attributes: [ 5.342828] evm: security.selinux [ 5.344777] evm: security.ima [ 5.346730] evm: security.capability [ 5.348946] evm: HMAC attrs: 0x1 [ 5.352799] rtc_cmos 00:05: setting system clock to 2026-05-16 09:12:07 UTC (1778922727) [ 5.360553] debug: unmapping init [mem 0xffffffffb3a03000-0xffffffffb3bfffff] [ 5.369525] debug: unmapping init [mem 0xffffffffb2782000-0xffffffffb2a58fff] [ 5.380335] Write protecting the kernel read-only data: 28672k [ 5.391984] debug: unmapping init [mem 0xffffffffb0e03000-0xffffffffb0ffffff] [ 5.400461] debug: unmapping init [mem 0xffffffffb1714000-0xffffffffb17fffff] [ 5.497615] 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) [ 5.517957] systemd[1]: Detected virtualization kvm. [ 5.524975] systemd[1]: Detected architecture x86-64. [ 5.529468] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 5.578543] systemd[1]: No hostname configured. [ 5.581774] systemd[1]: Set hostname to . [ 5.585435] random: systemd: uninitialized urandom read (16 bytes read) [ 5.589704] systemd[1]: Initializing machine ID from random generator. [ 5.718607] random: ln: uninitialized urandom read (6 bytes read) [ 5.911350] random: systemd: uninitialized urandom read (16 bytes read) [ 5.916484] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 5.924414] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 5.942547] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Paths. Starting Journal Service... [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Timers. Starting Setup Virtual Console... Starting Create Volatile Files and Directories... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Swap. [ OK ] Reached target Initrd Root Device. Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Journal Service. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 7.330172] device-mapper: uevent: version 1.0.3 [ 7.334227] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 8.967872] virtio_net virtio0 ens2: renamed from eth0 [ 9.518380] scsi host0: ata_piix [ 9.567384] scsi host1: ata_piix [ 9.569609] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 9.573675] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 13.862466] random: crng init done [ 13.866983] random: 7 urandom warning(s) missed due to ratelimiting [ 14.742373] dracut-initqueue[581]: 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... [ 17.105855] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 19.885119] printk: systemd: 23 output lines suppressed due to ratelimiting [ 20.668154] SELinux: Disabled at runtime. [ 20.776662] 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) [ 20.804552] systemd[1]: Detected virtualization kvm. [ 20.812538] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 22.500316] systemd[1]: initrd-switch-root.service: Succeeded. [ 22.514728] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 22.549757] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 22.564737] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 22.578323] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 22.591434] systemd[1]: Starting Journal Service... Starting Journal Service... [ 22.606051] systemd[1]: Activating swap /dev/disk/by-label/SWAP... Activating swap /dev/disk/by-label/SWAP... Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. [ 22.653611] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Created slice system-getty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice User and Session Slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target Local Encrypted Volumes. Mounting POSIX Message Queue File System... Mounting Huge Pages File System... Starting Apply Kernel Variables... [ OK ] Reached target rpc_pipefs.target. Mounting Kernel Debug File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Initrd File Systems. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started 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 /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 24.025947] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 24.948401] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 25.078252] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 25.232440] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 25.283243] EDAC sbridge: Ver: 1.1.2 [ 28.339158] Key type dns_resolver registered [ 29.045864] NFS: Registering the id_resolver key type [ 29.048341] Key type id_resolver registered [ 29.049955] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg316-client login: [ 85.418221] libcfs: loading out-of-tree module taints kernel. [ 85.497572] Key type ._llcrypt registered [ 85.500538] Key type .llcrypt registered [ 85.939164] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 85.963709] alg: No test for adler32 (adler32-zlib) [ 87.396204] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 88.179323] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 89.999192] Key type lgssc registered [ 91.533474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 140.079023] hrtimer: interrupt took 3013662 ns [ 244.361666] Lustre: Mounted lustre-client [ 249.138662] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 265.259716] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing check_logdir /tmp/testlogs/ [ 269.794388] Lustre: lustre-OST0000-osc-ffff90f0c7ee3000: disconnect after 23s idle [ 269.800942] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing yml_node [ 273.965561] Lustre: DEBUG MARKER: Client: 2.17.53.3 [ 276.226731] Lustre: DEBUG MARKER: MDS: 2.17.53.3 [ 278.807943] Lustre: DEBUG MARKER: OSS: 2.17.53.3 [ 280.730411] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sat May 16 05:16:41 EDT 2026 [ 301.277421] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 303.496674] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 306.878680] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 317.262414] Lustre: Unmounted lustre-client [ 434.282904] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 438.549653] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 459.416827] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 508.267486] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 05:20:28 (1778923228) [ 510.506738] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 512.598931] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 05:20:33 (1778923233) [ 546.800924] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 551.064392] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 570.581670] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 571.142646] Lustre: Mounted lustre-client [ 576.108212] LustreError: 14439:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c79ff800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 576.190674] Lustre: Unmounted lustre-client [ 603.309486] Key type lgssc unregistered [ 603.614278] LNet: 14848:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 603.629100] LNetError: 14848:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 603.649674] LNet: Removed LNI 192.168.203.16@tcp [ 604.398162] Key type .llcrypt unregistered [ 604.400285] Key type ._llcrypt unregistered [ 618.701484] Key type ._llcrypt registered [ 618.705469] Key type .llcrypt registered [ 619.969215] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 05:22:20 (1778923340) [ 621.074406] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 621.283216] alg: No test for adler32 (adler32-zlib) [ 622.267187] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 622.436106] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 624.103642] Key type lgssc registered [ 625.420645] Lustre: Echo OBD driver; http://www.lustre.org/ [ 694.713500] Lustre: Mounted lustre-client [ 780.007502] LustreError: 18208:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2f20800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 780.071340] Lustre: Unmounted lustre-client [ 807.898959] Key type lgssc unregistered [ 808.165584] LNet: 18673:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 808.175756] LNetError: 18673:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 808.191282] LNet: Removed LNI 192.168.203.16@tcp [ 808.854206] Key type .llcrypt unregistered [ 808.858658] Key type ._llcrypt unregistered [ 818.478306] Key type ._llcrypt registered [ 818.480975] Key type .llcrypt registered [ 819.759512] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 05:25:40 (1778923540) [ 822.722620] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 822.754880] alg: No test for adler32 (adler32-zlib) [ 823.899324] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 824.085812] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 825.712617] Key type lgssc registered [ 826.950997] Lustre: Echo OBD driver; http://www.lustre.org/ [ 874.544798] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 879.047291] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 902.260417] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 905.114403] Lustre: Mounted lustre-client [ 915.281845] LustreError: 21782:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c7ee0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 915.363305] Lustre: Unmounted lustre-client [ 942.566737] Key type lgssc unregistered [ 942.917786] LNet: 22188:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 942.924329] LNetError: 22188:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 942.964474] LNet: Removed LNI 192.168.203.16@tcp [ 943.707462] Key type .llcrypt unregistered [ 943.713097] Key type ._llcrypt unregistered [ 953.304393] Key type ._llcrypt registered [ 953.306476] Key type .llcrypt registered [ 954.670160] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 05:27:55 (1778923675) [ 957.224410] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 957.248130] alg: No test for adler32 (adler32-zlib) [ 958.394153] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 958.702332] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 960.415261] Key type lgssc registered [ 961.732866] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1010.772505] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1015.163116] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1036.187158] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1037.885791] Lustre: Mounted lustre-client [ 1043.698188] LustreError: 24886:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c48000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1043.786262] Lustre: Unmounted lustre-client [ 1072.043169] Key type lgssc unregistered [ 1072.310945] LNet: 25290:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1072.321332] LNetError: 25290:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1072.359124] LNet: Removed LNI 192.168.203.16@tcp [ 1073.070779] Key type .llcrypt unregistered [ 1073.075407] Key type ._llcrypt unregistered [ 1087.787936] Key type ._llcrypt registered [ 1087.790599] Key type .llcrypt registered [ 1088.955732] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 05:30:09 (1778923809) [ 1091.218062] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1091.244404] alg: No test for adler32 (adler32-zlib) [ 1092.309605] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 1092.575953] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 1094.255182] Key type lgssc registered [ 1095.371724] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1145.321781] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1149.180049] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1166.381813] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1168.797045] Lustre: Mounted lustre-client [ 1173.997643] Lustre: lustre-MDT0000-mdc-ffff90f0c45d6000: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1179.160205] Lustre: lustre-MDT0001-mdc-ffff90f0c45d6000: Connection to lustre-MDT0001 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1186.694172] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1195.487187] Lustre: 26248:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778923901/real 1778923901] req@0000000018f37736 x1865336817194496/t0(0) o400->MGC192.168.203.116@tcp@192.168.203.116@tcp:26/25 lens 224/224 e 0 to 1 dl 1778923917 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1195.513293] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 1197.034280] Lustre: Unmounted lustre-client [ 1216.437957] Key type lgssc unregistered [ 1216.715667] LNet: 28854:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1216.729848] LNetError: 28854:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1216.745694] LNet: Removed LNI 192.168.203.16@tcp [ 1217.568270] Key type .llcrypt unregistered [ 1217.573958] Key type ._llcrypt unregistered [ 1233.672587] Key type ._llcrypt registered [ 1233.674770] Key type .llcrypt registered [ 1235.786898] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 05:32:35 (1778923955) [ 1238.817159] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1238.833583] alg: No test for adler32 (adler32-zlib) [ 1240.097803] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 1240.357615] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 1242.167284] Key type lgssc registered [ 1243.679590] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1299.146439] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1303.269716] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1324.487219] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1327.298904] Lustre: Mounted lustre-client [ 1332.717160] Lustre: lustre-OST0000-osc-ffff90f0d8301000: Connection to lustre-OST0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1339.801295] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1350.153344] Lustre: Unmounted lustre-client [ 1378.987059] Key type lgssc unregistered [ 1379.278802] LNet: 32379:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1379.289418] LNetError: 32379:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1379.319112] LNet: Removed LNI 192.168.203.16@tcp [ 1380.045992] Key type .llcrypt unregistered [ 1380.048878] Key type ._llcrypt unregistered [ 1397.168441] Key type ._llcrypt registered [ 1397.178997] Key type .llcrypt registered [ 1398.614385] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 05:35:19 (1778924119) [ 1401.430432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1401.472818] alg: No test for adler32 (adler32-zlib) [ 1402.758236] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 1403.126610] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 1404.911214] Key type lgssc registered [ 1406.306677] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1459.845314] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1464.627322] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1486.861441] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1489.747947] Lustre: Mounted lustre-client [ 1494.428531] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1499.207130] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1510.935099] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-05-16 5h37m11s [ 1513.288680] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1520.637951] Lustre: lustre-MDT0000-mdc-ffff90f0d2b48800: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1523.705193] LustreError: 36078:0:(lmv_obd.c:1449:lmv_statfs()) lustre-MDT0000-mdc-ffff90f0d2b48800: can't stat MDS #0: rc = -19 [ 1524.984447] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1533.928613] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 1533.945583] Lustre: Evicted from MGS (at 192.168.203.116@tcp) after server handle changed from 0xe98974fe6c85ef45 to 0xe98974fe6c85f1f3 [ 1533.962753] LustreError: lustre-MDT0000-mdc-ffff90f0d2b48800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1533.977779] Lustre: lustre-MDT0000-mdc-ffff90f0d2b48800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 1533.992664] Lustre: Skipped 1 previous similar message [ 1542.053938] Lustre: DEBUG MARKER: Wait for df (36078) ... [ 1544.136279] Lustre: DEBUG MARKER: done [ 1547.666672] LustreError: 36690:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d2b48800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1547.756411] Lustre: Unmounted lustre-client [ 1589.899962] Key type lgssc unregistered [ 1590.331807] LNet: 37097:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1590.342414] LNetError: 37097:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1590.374812] LNet: Removed LNI 192.168.203.16@tcp [ 1591.180341] Key type .llcrypt unregistered [ 1591.183664] Key type ._llcrypt unregistered [ 1624.243091] Key type ._llcrypt registered [ 1624.245858] Key type .llcrypt registered [ 1625.705334] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 05:39:06 (1778924346) [ 1628.645652] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1628.684242] alg: No test for adler32 (adler32-zlib) [ 1629.894296] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 1630.165877] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 1631.847529] Key type lgssc registered [ 1633.564725] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1680.909527] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1684.599398] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1705.568948] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1707.661988] Lustre: Mounted lustre-client [ 1713.608457] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-05-16 5h40m33s [ 1716.158279] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1726.933162] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1730.433415] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1751.007146] Lustre: 41163:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778924452/real 1778924452] req@00000000fd6d570e x1865337381330048/t0(0) o101->lustre-MDT0000-mdc-ffff90f0e06bc800@192.168.203.116@tcp:12/10 lens 576/1152 e 0 to 1 dl 1778924472 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1751.059455] Lustre: lustre-MDT0000-mdc-ffff90f0e06bc800: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1751.109446] Lustre: lustre-MDT0000-mdc-ffff90f0e06bc800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 1772.525596] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1775.555139] Lustre: DEBUG MARKER: done [ 1780.415743] LustreError: 41637:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0e06bc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1780.487972] Lustre: Unmounted lustre-client [ 1816.044368] Key type lgssc unregistered [ 1816.357560] LNet: 42041:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1816.366857] LNetError: 42041:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1816.390991] LNet: Removed LNI 192.168.203.16@tcp [ 1817.042856] Key type .llcrypt unregistered [ 1817.047273] Key type ._llcrypt unregistered [ 1847.530400] Key type ._llcrypt registered [ 1847.532953] Key type .llcrypt registered [ 1849.228796] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 05:42:49 (1778924569) [ 1850.889027] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1852.678964] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 05:42:53 (1778924573) [ 1857.049504] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1857.171203] alg: No test for adler32 (adler32-zlib) [ 1858.324217] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 1858.605100] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 1860.343183] Key type lgssc registered [ 1861.857776] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1891.689107] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 05:43:32 (1778924612) [ 1923.133708] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1927.089643] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1946.688001] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1949.295739] Lustre: Mounted lustre-client [ 1952.832822] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1956.543682] LustreError: 46382:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c786a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1956.686500] Lustre: Unmounted lustre-client [ 1973.208382] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2020.879467] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2025.675977] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2026.579862] Lustre: Mounted lustre-client [ 2030.688578] LustreError: 47636:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c6220800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2030.815885] Lustre: Unmounted lustre-client [ 2097.574148] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2102.196032] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2103.035345] Lustre: Mounted lustre-client [ 2108.123620] LustreError: 48751:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c7ee0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2108.292551] Lustre: Unmounted lustre-client [ 2141.124779] Lustre: DEBUG MARKER: files compared the same [ 2167.059972] Key type lgssc unregistered [ 2167.461293] LNet: 49459:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2167.484400] LNetError: 49459:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2167.509304] LNet: Removed LNI 192.168.203.16@tcp [ 2168.497767] Key type .llcrypt unregistered [ 2168.501306] Key type ._llcrypt unregistered [ 2187.467913] Key type ._llcrypt registered [ 2187.470865] Key type .llcrypt registered [ 2189.206711] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 05:48:29 (1778924909) [ 2192.852148] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2192.897616] alg: No test for adler32 (adler32-zlib) [ 2194.112782] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 2194.418071] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 2196.208802] Key type lgssc registered [ 2198.443357] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2256.088596] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2260.120477] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2282.676243] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2285.382821] Lustre: Mounted lustre-client [ 2289.904995] LustreError: 52554:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c6df7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2290.055149] Lustre: Unmounted lustre-client [ 2319.158528] Key type lgssc unregistered [ 2319.444195] LNet: 52957:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2319.460462] LNetError: 52957:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2319.491203] LNet: Removed LNI 192.168.203.16@tcp [ 2320.290505] Key type .llcrypt unregistered [ 2320.292054] Key type ._llcrypt unregistered [ 2336.765556] Key type ._llcrypt registered [ 2336.769635] Key type .llcrypt registered [ 2338.896705] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 05:50:58 (1778925058) [ 2341.996868] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2342.033281] alg: No test for adler32 (adler32-zlib) [ 2343.258770] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 2343.530619] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 2345.359190] Key type lgssc registered [ 2346.965871] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2434.182236] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2471.170838] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2475.070432] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2504.041640] Key type lgssc unregistered [ 2504.416424] LNet: 56357:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2504.425817] LNetError: 56357:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2504.439606] LNet: Removed LNI 192.168.203.16@tcp [ 2505.280670] Key type .llcrypt unregistered [ 2505.282393] Key type ._llcrypt unregistered [ 2523.261174] Key type ._llcrypt registered [ 2523.272437] Key type .llcrypt registered [ 2524.781639] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 05:54:05 (1778925245) [ 2528.413617] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2528.427731] alg: No test for adler32 (adler32-zlib) [ 2529.726591] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 2530.194687] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 2531.983270] Key type lgssc registered [ 2533.246914] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2609.011990] Lustre: Mounted lustre-client [ 2616.232779] LustreError: 58843:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d0d18000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2616.297315] Lustre: Unmounted lustre-client [ 2656.103878] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 05:56:16 (1778925376) [ 2776.304531] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2798.663792] Lustre: Mounted lustre-client [ 2806.895590] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2806.921921] LustreError: 62800:0:(file.c:252:ll_close_inode_openhandle()) lustre-clilmv-ffff90f0c45d1000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2806.973112] Lustre: 57342:0:(llite_lib.c:4187:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.116@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2817.306777] Lustre: Unmounted lustre-client [ 2859.599980] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 05:59:40 (1778925580) [ 2871.741054] Key type lgssc unregistered [ 2871.998810] LNet: 64012:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2872.010713] LNetError: 64012:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2872.028065] LNet: Removed LNI 192.168.203.16@tcp [ 2872.795152] Key type .llcrypt unregistered [ 2872.802394] Key type ._llcrypt unregistered [ 2886.033982] Key type ._llcrypt registered [ 2886.037422] Key type .llcrypt registered [ 2886.460414] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2886.485485] alg: No test for adler32 (adler32-zlib) [ 2887.515391] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 2887.730402] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 2889.495153] Key type lgssc registered [ 2890.763491] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2938.357141] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2942.478903] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2962.511345] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2964.216925] Lustre: Mounted lustre-client [ 2968.399590] LustreError: 66549:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d4a89000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2968.493351] Lustre: Unmounted lustre-client [ 2995.253823] Key type lgssc unregistered [ 2995.594506] LNet: 66952:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2995.603089] LNetError: 66952:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2995.619413] LNet: Removed LNI 192.168.203.16@tcp [ 2996.306742] Key type .llcrypt unregistered [ 2996.310054] Key type ._llcrypt unregistered [ 3007.141262] Key type ._llcrypt registered [ 3007.144470] Key type .llcrypt registered [ 3007.592575] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3007.618294] alg: No test for adler32 (adler32-zlib) [ 3008.608631] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 3008.807628] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 3010.559558] Key type lgssc registered [ 3012.235714] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3119.061139] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3123.563885] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3147.734455] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3150.545275] Lustre: Mounted lustre-client [ 3153.643678] LustreError: 69908:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0e06bb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3153.752382] Lustre: Unmounted lustre-client [ 3184.054308] Key type lgssc unregistered [ 3184.322587] LNet: 70314:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3184.337327] LNetError: 70314:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3184.385871] LNet: Removed LNI 192.168.203.16@tcp [ 3185.192916] Key type .llcrypt unregistered [ 3185.195074] Key type ._llcrypt unregistered [ 3201.632091] Key type ._llcrypt registered [ 3201.634638] Key type .llcrypt registered [ 3202.931459] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 06:05:23 (1778925923) [ 3205.315627] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3205.356160] alg: No test for adler32 (adler32-zlib) [ 3206.400754] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 3206.608829] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 3208.303865] Key type lgssc registered [ 3209.539235] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3256.450953] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3260.344657] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3279.653348] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3282.490934] Lustre: Mounted lustre-client [ 3287.913589] LustreError: 73435:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d283e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3287.993188] Lustre: Unmounted lustre-client [ 3288.571584] Lustre: Mounted lustre-client [ 3291.825099] LustreError: 73509:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c8151800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3291.910749] Lustre: Unmounted lustre-client [ 3324.683226] Key type lgssc unregistered [ 3325.019397] LNet: 73914:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3325.063915] LNetError: 73914:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3325.114136] LNet: Removed LNI 192.168.203.16@tcp [ 3326.147548] Key type .llcrypt unregistered [ 3326.159229] Key type ._llcrypt unregistered [ 3340.071967] Key type ._llcrypt registered [ 3340.075961] Key type .llcrypt registered [ 3340.574935] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3340.589162] alg: No test for adler32 (adler32-zlib) [ 3341.741840] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 3342.123731] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 3343.911226] Key type lgssc registered [ 3345.660371] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3394.644717] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3398.357512] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3418.339150] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3420.196919] Lustre: Mounted lustre-client [ 3424.392298] LustreError: 76453:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d1d13800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3424.499981] Lustre: Unmounted lustre-client [ 3452.735954] Key type lgssc unregistered [ 3453.099480] LNet: 76857:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3453.104819] LNetError: 76857:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3453.138377] LNet: Removed LNI 192.168.203.16@tcp [ 3453.826467] Key type .llcrypt unregistered [ 3453.829662] Key type ._llcrypt unregistered [ 3469.409684] Key type ._llcrypt registered [ 3469.412342] Key type .llcrypt registered [ 3470.764885] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 06:09:51 (1778926191) [ 3472.899609] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3472.937794] alg: No test for adler32 (adler32-zlib) [ 3474.110721] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 3474.412111] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 3476.119212] Key type lgssc registered [ 3477.170617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3523.992592] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3528.914605] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3550.953770] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3553.692490] Lustre: Mounted lustre-client [ 3563.607895] Lustre: lustre: root_squash is set to 0:0 [ 3569.175842] Lustre: lustre: nosquash_nids is cleared [ 3577.901635] Lustre: lustre: root_squash is set to 500:500 [ 3588.170864] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.16@tcp 192.168.0.[2,10]@tcp [ 3604.034659] Lustre: lustre: nosquash_nids set to 192.168.203.16/24@tcp [ 3607.434243] LustreError: 80353:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c4b97800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3607.576797] Lustre: Unmounted lustre-client [ 3642.042909] Key type lgssc unregistered [ 3642.295292] LNet: 80757:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3642.312435] LNetError: 80757:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3642.331943] LNet: Removed LNI 192.168.203.16@tcp [ 3643.004989] Key type .llcrypt unregistered [ 3643.007736] Key type ._llcrypt unregistered [ 3658.414351] Key type ._llcrypt registered [ 3658.418980] Key type .llcrypt registered [ 3659.891927] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 06:13:00 (1778926380) [ 3662.563088] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3664.240494] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 06:13:05 (1778926385) [ 3666.938282] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3666.971462] alg: No test for adler32 (adler32-zlib) [ 3668.136992] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 3668.417661] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 3670.151161] Key type lgssc registered [ 3671.831125] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3718.559712] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3722.632340] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3742.374538] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3742.889143] Lustre: lustre: root_squash is set to 500:500 [ 3742.919088] Lustre: lustre: nosquash_nids set to 192.168.203.16/24@tcp [ 3743.982029] Lustre: Mounted lustre-client [ 3750.378662] LustreError: 84221:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c8395000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3750.515503] Lustre: Unmounted lustre-client [ 3781.807524] Key type lgssc unregistered [ 3782.160673] LNet: 84626:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3782.173542] LNetError: 84626:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3782.216039] LNet: Removed LNI 192.168.203.16@tcp [ 3783.170665] Key type .llcrypt unregistered [ 3783.185780] Key type ._llcrypt unregistered [ 3799.422289] Key type ._llcrypt registered [ 3799.424036] Key type .llcrypt registered [ 3800.975456] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3802.788982] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 06:15:23 (1778926523) [ 3823.474183] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3823.499537] alg: No test for adler32 (adler32-zlib) [ 3824.672970] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 3824.934146] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 3826.653801] Key type lgssc registered [ 3828.181714] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3906.295569] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3910.273462] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3929.878319] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4001.810525] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4005.481896] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4021.394683] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4033.194856] Lustre: Mounted lustre-client [ 4062.082943] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff90f0c2f26000.ost_server_uuid 50 [ 4063.543991] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff90f0c2f26000.ost_server_uuid in FULL state after 0 sec [ 4063.920620] Lustre: Mounted lustre-client [ 4066.940672] LustreError: 91524:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d4b0a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4067.018903] Lustre: Unmounted lustre-client [ 4068.803883] LustreError: 91544:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2f26000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4068.818088] LustreError: 91544:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 4068.867428] Lustre: Unmounted lustre-client [ 4109.303898] Key type lgssc unregistered [ 4109.560103] LNet: 92097:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4109.566860] LNetError: 92097:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4109.589548] LNet: Removed LNI 192.168.203.16@tcp [ 4110.319787] Key type .llcrypt unregistered [ 4110.326483] Key type ._llcrypt unregistered [ 4139.399177] Key type ._llcrypt registered [ 4139.403473] Key type .llcrypt registered [ 4140.711804] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 06:21:01 (1778926861) [ 4157.841898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4157.934270] alg: No test for adler32 (adler32-zlib) [ 4159.085783] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 4159.355934] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 4161.127247] Key type lgssc registered [ 4162.642617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4229.425073] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4233.146554] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4251.073127] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4253.965484] Lustre: Mounted lustre-client [ 4274.668369] Lustre: lustre-OST0000-osc-ffff90f0c5a66800: Connection to lustre-OST0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4275.685817] Lustre: 93460:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778926981/real 1778926981] req@00000000e06c768a x1865340033176832/t0(0) o400->lustre-OST0000-osc-ffff90f0c5a66800@192.168.203.116@tcp:28/4 lens 224/224 e 0 to 1 dl 1778926997 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4278.672903] Lustre: lustre-OST0000-osc-ffff90f0c5a66800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 4280.802113] Lustre: 93460:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778926986/real 1778926986] req@00000000dca8b439 x1865340033177344/t0(0) o400->lustre-OST0000-osc-ffff90f0c5a66800@192.168.203.116@tcp:28/4 lens 224/224 e 0 to 1 dl 1778927002 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4284.903463] Lustre: lustre-MDT0000-mdc-ffff90f0c5a66800: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4285.920497] Lustre: 93460:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778926991/real 1778926991] req@00000000a8098226 x1865340033177856/t0(0) o400->lustre-OST0000-osc-ffff90f0c5a66800@192.168.203.116@tcp:28/4 lens 224/224 e 0 to 1 dl 1778927007 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4300.268994] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 4300.284182] Lustre: Evicted from MGS (at 192.168.203.116@tcp) after server handle changed from 0x5a2210d98a28791 to 0x5a2210d98a28912 [ 4300.300727] Lustre: MGC192.168.203.116@tcp: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 4312.459428] Lustre: lustre-MDT0000-mdc-ffff90f0c5a66800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 4314.879528] LustreError: 97268:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5a66800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4314.946809] Lustre: Unmounted lustre-client [ 4338.955735] Key type lgssc unregistered [ 4339.184539] LNet: 97671:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4339.190244] LNetError: 97671:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4339.205512] LNet: Removed LNI 192.168.203.16@tcp [ 4339.748365] Key type .llcrypt unregistered [ 4339.754304] Key type ._llcrypt unregistered [ 4351.930654] Key type ._llcrypt registered [ 4351.934068] Key type .llcrypt registered [ 4353.042820] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 06:24:33 (1778927073) [ 4367.059901] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4367.071719] alg: No test for adler32 (adler32-zlib) [ 4368.103547] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 4368.304964] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 4369.967539] Key type lgssc registered [ 4370.921299] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4398.744554] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4462.193695] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4464.910806] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4478.846360] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4481.259122] Lustre: Mounted lustre-client [ 4482.703876] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4484.097565] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 06:26:45 (1778927205) [ 4649.618547] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4659.910978] Lustre: Unmounted lustre-client [ 4741.336629] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4743.613213] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4755.573541] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4793.088041] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 06:31:54 (1778927514) [ 4842.445181] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4844.315824] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4855.531161] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4860.920632] Lustre: Mounted lustre-client [ 4862.777401] LustreError: 115827:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4862.821756] Lustre: Unmounted lustre-client [ 4883.931866] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 06:33:25 (1778927605) [ 4931.106686] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4932.998606] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4944.916121] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4945.211374] Lustre: Mounted lustre-client [ 4947.293841] LustreError: 119856:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d1d11000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4947.356265] Lustre: Unmounted lustre-client [ 4963.913223] Key type lgssc unregistered [ 4964.093933] LNet: 120259:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4964.103148] LNetError: 120259:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4964.118684] LNet: Removed LNI 192.168.203.16@tcp [ 4964.484591] Key type .llcrypt unregistered [ 4964.487453] Key type ._llcrypt unregistered [ 4972.358084] Key type ._llcrypt registered [ 4972.364195] Key type .llcrypt registered [ 4973.242469] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 06:34:54 (1778927694) [ 4974.517675] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4974.535766] alg: No test for adler32 (adler32-zlib) [ 4975.466656] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 4975.612656] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 4977.224491] Key type lgssc registered [ 4977.808979] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5001.036966] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5002.780666] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5012.426344] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5019.106582] Lustre: Mounted lustre-client [ 5033.818598] LustreError: 123350:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c7ee3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5033.858517] Lustre: Unmounted lustre-client [ 5052.549504] Key type lgssc unregistered [ 5052.674691] LNet: 123754:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5052.678565] LNetError: 123754:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5052.687807] LNet: Removed LNI 192.168.203.16@tcp [ 5052.992248] Key type .llcrypt unregistered [ 5052.994123] Key type ._llcrypt unregistered [ 5059.244303] Key type ._llcrypt registered [ 5059.246267] Key type .llcrypt registered [ 5059.928518] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 06:36:21 (1778927781) [ 5061.104656] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5061.112207] alg: No test for adler32 (adler32-zlib) [ 5062.036378] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 5062.138693] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 5063.751181] Key type lgssc registered [ 5064.324281] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5086.773886] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5088.453286] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5096.212908] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5101.564948] Lustre: Mounted lustre-client [ 5106.659178] Lustre: lustre-OST0000-osc-ffff90f0c45d7800: Connection to lustre-OST0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5112.235304] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff90f0c45d7800.ost_server_uuid 50 [ 5112.888839] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5122.330111] LustreError: 127281:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c45d7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5122.362122] Lustre: Unmounted lustre-client [ 5133.984706] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 06:37:35 (1778927855) [ 5147.190332] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5148.862518] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5157.202902] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5167.771487] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5168.129586] Lustre: Mounted lustre-client [ 5173.221943] Lustre: lustre-OST0000-osc-ffff90f0c2c48800: Connection to lustre-OST0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5189.634487] LustreError: 129922:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c48800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5189.669104] Lustre: Unmounted lustre-client [ 5217.179452] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 06:38:58 (1778927938) [ 5230.847622] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5232.452716] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5240.285276] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5247.935676] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5248.148515] Lustre: Mounted lustre-client [ 5253.606977] Lustre: lustre-OST0000-osc-ffff90f0c4613000: Connection to lustre-OST0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5273.952795] LustreError: 132667:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c4613000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5273.957345] LustreError: 132667:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 5273.991147] Lustre: Unmounted lustre-client [ 5299.631716] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 06:40:21 (1778928021) [ 5337.454801] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5339.091292] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5349.008287] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5383.637833] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5385.330489] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5393.981765] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5413.035933] Lustre: Mounted lustre-client [ 5442.500410] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5443.392419] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5444.053457] LustreError: 139246:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c605f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5444.060547] LustreError: 139246:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 5444.108219] Lustre: Unmounted lustre-client [ 5465.271720] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 06:43:06 (1778928186) [ 5479.988267] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5481.426666] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5489.328286] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5505.841716] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5521.629656] Lustre: Mounted lustre-client [ 5550.023146] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5550.691396] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5552.613028] Lustre: lustre-OST0001-osc-ffff90f0c45d3000: Connection to lustre-OST0001 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5554.720537] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5564.990131] Lustre: Unmounted lustre-client [ 5596.968230] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 06:45:18 (1778928318) [ 5608.844474] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5610.270332] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5617.660789] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5617.930273] Lustre: Mounted lustre-client [ 5626.802394] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5627.482867] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5635.500163] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff90f0c41ef000.ost_server_uuid 50 [ 5636.147755] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff90f0c41ef000.ost_server_uuid in FULL state after 0 sec [ 5636.915630] LustreError: 146227:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c41ef000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5636.954137] Lustre: Unmounted lustre-client [ 5637.052882] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5637.055521] Lustre: Skipped 3 previous similar messages [ 5637.091625] Lustre: Mounted lustre-client [ 5637.561145] LustreError: 146282:0:(sec.c:413:import_sec_validate_get()) import 000000005f5a7420 (NEW) with no sec [ 5671.989207] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 06:46:33 (1778928393) [ 5685.202269] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5686.757399] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5693.673158] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5701.012425] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5701.187250] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5701.252056] Lustre: Mounted lustre-client [ 5713.314149] LustreError: 149136:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5713.319289] LustreError: 149136:0:(lov_obd.c:792:lov_cleanup()) Skipped 2 previous similar messages [ 5713.360332] Lustre: Unmounted lustre-client [ 5713.362187] Lustre: Skipped 1 previous similar message [ 5738.841903] Key type lgssc unregistered [ 5738.955976] LNet: 149584:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5738.959866] LNetError: 149584:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5738.969048] LNet: Removed LNI 192.168.203.16@tcp [ 5739.262808] Key type .llcrypt unregistered [ 5739.264782] Key type ._llcrypt unregistered [ 5746.345099] Key type ._llcrypt registered [ 5746.346521] Key type .llcrypt registered [ 5746.868680] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 06:47:48 (1778928468) [ 5747.282805] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5747.296059] alg: No test for adler32 (adler32-zlib) [ 5748.158184] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 5748.246177] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 5749.831150] Key type lgssc registered [ 5750.212133] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5771.569301] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5773.092473] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5780.786850] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5788.528569] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5789.697309] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5790.743679] Lustre: Mounted lustre-client [ 5795.831398] LustreError: lustre-MDT0001-mdc-ffff90f0d0d1b800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5795.846201] Lustre: lustre-MDT0001-mdc-ffff90f0d0d1b800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 5798.133976] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5798.862559] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5804.198750] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5811.081996] LustreError: 153764:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d0d1b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5811.120119] Lustre: Unmounted lustre-client [ 5831.736654] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 06:49:13 (1778928553) [ 5866.849254] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5868.313576] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5877.071645] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5882.361191] Lustre: Mounted lustre-client [ 5893.387250] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5894.062691] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5906.916676] Lustre: lustre-OST0001-osc-ffff90f0c5948000: Connection to lustre-OST0001 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5911.055863] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5921.340624] Lustre: Unmounted lustre-client [ 5946.213636] Key type lgssc unregistered [ 5946.352693] LNet: 158882:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5946.357269] LNetError: 158882:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5946.368018] LNet: Removed LNI 192.168.203.16@tcp [ 5946.665927] Key type .llcrypt unregistered [ 5946.667524] Key type ._llcrypt unregistered [ 5959.290368] Key type ._llcrypt registered [ 5959.292019] Key type .llcrypt registered [ 5959.890622] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 06:51:21 (1778928681) [ 5960.869663] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5960.889534] alg: No test for adler32 (adler32-zlib) [ 5961.780145] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 5961.879026] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 5963.471134] Key type lgssc registered [ 5963.999492] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5984.813182] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5986.214431] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5993.212847] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5995.461275] Lustre: Mounted lustre-client [ 6032.759451] LustreError: 162137:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d14e1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6032.800845] Lustre: Unmounted lustre-client [ 6050.082372] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6050.282460] Lustre: Mounted lustre-client [ 6082.936502] LustreError: 162781:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6082.968152] Lustre: Unmounted lustre-client [ 6100.764262] Key type lgssc unregistered [ 6100.876437] LNet: 163189:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6100.879561] LNetError: 163189:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6100.890665] LNet: Removed LNI 192.168.203.16@tcp [ 6101.156428] Key type .llcrypt unregistered [ 6101.158196] Key type ._llcrypt unregistered [ 6106.799657] Key type ._llcrypt registered [ 6106.801202] Key type .llcrypt registered [ 6107.327798] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 06:53:48 (1778928828) [ 6108.197673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6108.258103] alg: No test for adler32 (adler32-zlib) [ 6109.142620] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6109.235545] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6110.831255] Key type lgssc registered [ 6111.274141] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6130.011286] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6131.323153] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6138.091104] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6148.596916] Lustre: Mounted lustre-client [ 6155.968122] LustreError: 166440:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c41e9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6155.995898] Lustre: Unmounted lustre-client [ 6181.973316] Key type lgssc unregistered [ 6182.095517] LNet: 166844:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6182.098328] LNetError: 166844:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6182.107134] LNet: Removed LNI 192.168.203.16@tcp [ 6182.352967] Key type .llcrypt unregistered [ 6182.354247] Key type ._llcrypt unregistered [ 6186.680893] Key type ._llcrypt registered [ 6186.682306] Key type .llcrypt registered [ 6186.873739] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6186.898295] alg: No test for adler32 (adler32-zlib) [ 6187.788639] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6187.892413] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6189.479160] Key type lgssc registered [ 6189.914675] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6209.205485] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6210.472673] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6217.510114] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6227.951678] Lustre: Mounted lustre-client [ 6230.863682] LustreError: 169403:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5bc6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6230.898437] Lustre: Unmounted lustre-client [ 6248.406567] Key type lgssc unregistered [ 6248.507534] LNet: 169806:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6248.510296] LNetError: 169806:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6248.521608] LNet: Removed LNI 192.168.203.16@tcp [ 6248.750244] Key type .llcrypt unregistered [ 6248.751860] Key type ._llcrypt unregistered [ 6254.282359] Key type ._llcrypt registered [ 6254.286516] Key type .llcrypt registered [ 6254.790329] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 06:56:16 (1778928976) [ 6255.630425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6255.642403] alg: No test for adler32 (adler32-zlib) [ 6256.523905] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6256.622482] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6258.207154] Key type lgssc registered [ 6258.643473] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6276.643325] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6277.987529] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6284.402439] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6295.029149] Lustre: Mounted lustre-client [ 6302.096915] LustreError: 173050:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c6159800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6302.131938] Lustre: Unmounted lustre-client [ 6319.809164] Key type lgssc unregistered [ 6319.931390] LNet: 173453:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6319.934025] LNetError: 173453:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6319.940630] LNet: Removed LNI 192.168.203.16@tcp [ 6320.175986] Key type .llcrypt unregistered [ 6320.177440] Key type ._llcrypt unregistered [ 6324.549957] Key type ._llcrypt registered [ 6324.551264] Key type .llcrypt registered [ 6324.726079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6324.732997] alg: No test for adler32 (adler32-zlib) [ 6325.598289] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6325.686463] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6327.271145] Key type lgssc registered [ 6327.742857] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6345.929979] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6347.161880] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6353.358214] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6364.141919] Lustre: Mounted lustre-client [ 6366.926026] LustreError: 176013:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5bc7000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6366.956193] Lustre: Unmounted lustre-client [ 6376.020320] Key type lgssc unregistered [ 6376.146519] LNet: 176415:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6376.149059] LNetError: 176415:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6376.156634] LNet: Removed LNI 192.168.203.16@tcp [ 6376.388125] Key type .llcrypt unregistered [ 6376.389645] Key type ._llcrypt unregistered [ 6381.660777] Key type ._llcrypt registered [ 6381.662383] Key type .llcrypt registered [ 6382.129445] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 06:58:23 (1778929103) [ 6389.114458] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6389.124124] alg: No test for adler32 (adler32-zlib) [ 6390.004788] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6390.105115] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6391.695177] Key type lgssc registered [ 6392.125915] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6421.053757] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6422.290938] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6429.844696] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6452.085231] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 06:59:33 (1778929173) [ 6461.700430] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6462.890875] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6468.860444] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6484.464036] Lustre: Mounted lustre-client [ 6486.459138] LustreError: 182910:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c41ef000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6486.495192] Lustre: Unmounted lustre-client [ 6504.205137] Key type lgssc unregistered [ 6504.329474] LNet: 183313:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6504.332495] LNetError: 183313:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6504.342777] LNet: Removed LNI 192.168.203.16@tcp [ 6504.592580] Key type .llcrypt unregistered [ 6504.593842] Key type ._llcrypt unregistered [ 6510.019541] Key type ._llcrypt registered [ 6510.020456] Key type .llcrypt registered [ 6510.498394] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 6511.081877] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 07:00:32 (1778929232) [ 6516.888257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6516.901987] alg: No test for adler32 (adler32-zlib) [ 6517.747349] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6517.822498] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6519.399173] Key type lgssc registered [ 6519.773818] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6550.728189] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6551.808832] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6558.889484] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 6564.841258] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 6565.998693] Lustre: Mounted lustre-client [ 6572.041251] LustreError: 188839:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c615a800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 6572.072743] Lustre: Unmounted lustre-client [ 6633.239661] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6634.341213] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6641.518364] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6670.961704] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 07:03:12 (1778929392) [ 6671.496158] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 6672.131631] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 07:03:13 (1778929393) [ 6714.716799] Key type lgssc unregistered [ 6714.831508] LNet: 194507:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6714.834487] LNetError: 194507:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6714.842737] LNet: Removed LNI 192.168.203.16@tcp [ 6715.065314] Key type .llcrypt unregistered [ 6715.066881] Key type ._llcrypt unregistered [ 6719.944846] Key type ._llcrypt registered [ 6719.946071] Key type .llcrypt registered [ 6720.404591] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 07:04:02 (1778929442) [ 6742.655528] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6742.698584] alg: No test for adler32 (adler32-zlib) [ 6743.547882] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6743.622074] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6745.199095] Key type lgssc registered [ 6745.530695] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6759.914186] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6761.052123] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6780.204296] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6799.648546] Key type lgssc unregistered [ 6799.771424] LNet: 198138:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6799.774331] LNetError: 198138:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6799.784551] LNet: Removed LNI 192.168.203.16@tcp [ 6800.032402] Key type .llcrypt unregistered [ 6800.034168] Key type ._llcrypt unregistered [ 6804.685616] Key type ._llcrypt registered [ 6804.687029] Key type .llcrypt registered [ 6805.163036] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 07:05:26 (1778929526) [ 6806.002253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6806.019771] alg: No test for adler32 (adler32-zlib) [ 6806.868317] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6806.946727] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6808.535145] Key type lgssc registered [ 6808.892792] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6825.115041] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6826.281350] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6833.917814] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6844.398136] Lustre: Mounted lustre-client [ 6849.505814] Lustre: lustre-MDT0000-mdc-ffff90f0c8390000: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6854.625322] Lustre: lustre-MDT0001-mdc-ffff90f0c8390000: Connection to lustre-MDT0001 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6864.864932] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 6864.870457] Lustre: Evicted from MGS (at 192.168.203.116@tcp) after server handle changed from 0x177866861eba548d to 0x177866861eba6dd1 [ 6864.876048] Lustre: MGC192.168.203.116@tcp: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 6874.082396] Lustre: 201154:0:(mgc_request.c:1897:mgc_process_log()) MGC192.168.203.116@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 6886.056203] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6890.465655] LustreError: lustre-MDT0000-mdc-ffff90f0c8390000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6890.479837] Lustre: lustre-MDT0000-mdc-ffff90f0c8390000: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 6891.649641] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 5 sec [ 6892.685599] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6893.191634] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6893.766564] LustreError: 202566:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c8390000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6893.792133] Lustre: Unmounted lustre-client [ 6918.797913] Key type lgssc unregistered [ 6918.909489] LNet: 202970:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6918.911792] LNetError: 202970:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6918.921674] LNet: Removed LNI 192.168.203.16@tcp [ 6919.144128] Key type .llcrypt unregistered [ 6919.145128] Key type ._llcrypt unregistered [ 6923.654959] Key type ._llcrypt registered [ 6923.656008] Key type .llcrypt registered [ 6924.075116] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 07:07:25 (1778929645) [ 6924.739875] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6924.778870] alg: No test for adler32 (adler32-zlib) [ 6925.629775] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 6925.708851] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 6927.287131] Key type lgssc registered [ 6927.650589] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6944.554491] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6945.691793] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6966.302808] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6967.423405] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6980.212771] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6986.440898] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7011.226165] Key type lgssc unregistered [ 7011.335231] LNet: 208064:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7011.337256] LNetError: 208064:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7011.343233] LNet: Removed LNI 192.168.203.16@tcp [ 7011.540450] Key type .llcrypt unregistered [ 7011.542053] Key type ._llcrypt unregistered [ 7032.312987] Key type ._llcrypt registered [ 7032.314381] Key type .llcrypt registered [ 7032.761167] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 07:09:14 (1778929754) [ 7045.210206] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7045.225234] alg: No test for adler32 (adler32-zlib) [ 7046.105328] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7046.198854] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7047.783179] Key type lgssc registered [ 7048.181107] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7075.980424] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7077.117884] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7084.173894] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7105.966538] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 07:10:27 (1778929827) [ 7108.413984] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 07:10:30 (1778929830) [ 7118.342597] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7119.468897] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7125.340547] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7127.541787] Lustre: Mounted lustre-client [ 7130.659866] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 7131.190578] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7131.720781] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7132.252452] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 7137.762325] Lustre: lustre-MDT0000-mdc-ffff90f0c5b4c800: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7148.001184] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 7148.007152] Lustre: Evicted from MGS (at 192.168.203.116@tcp) after server handle changed from 0x7a22080c628d2582 to 0x7a22080c628d27e3 [ 7148.010607] Lustre: MGC192.168.203.116@tcp: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 7150.968773] Lustre: lustre-MDT0000-mdc-ffff90f0c5b4c800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 7152.092703] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7152.652901] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7154.526425] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 7158.241643] Lustre: lustre-MDT0000-mdc-ffff90f0c5b4c800: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7168.480958] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 7168.488566] Lustre: Evicted from MGS (at 192.168.203.116@tcp) after server handle changed from 0x7a22080c628d27e3 to 0x7a22080c628d2aec [ 7168.493376] Lustre: MGC192.168.203.116@tcp: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 7173.496604] Lustre: lustre-MDT0000-mdc-ffff90f0c5b4c800: Connection restored to 192.168.203.116@tcp (at 192.168.203.116@tcp) [ 7174.669156] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7175.165720] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7176.692779] LustreError: 218177:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5b4c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7176.717493] Lustre: Unmounted lustre-client [ 7208.417351] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7209.603480] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7215.495740] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7215.665487] Lustre: Mounted lustre-client [ 7216.024221] LustreError: 219780:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7216.054256] Lustre: Unmounted lustre-client [ 7232.974310] Key type lgssc unregistered [ 7233.085553] LNet: 220184:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7233.088267] LNetError: 220184:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7233.095664] LNet: Removed LNI 192.168.203.16@tcp [ 7233.302535] Key type .llcrypt unregistered [ 7233.304127] Key type ._llcrypt unregistered [ 7238.441324] Key type ._llcrypt registered [ 7238.442815] Key type .llcrypt registered [ 7238.885456] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 07:12:40 (1778929960) [ 7240.348226] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7240.369438] alg: No test for adler32 (adler32-zlib) [ 7241.225857] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7241.311887] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7242.887176] Key type lgssc registered [ 7243.251353] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7259.932525] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7261.116828] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7266.664914] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7282.157287] Lustre: Mounted lustre-client [ 7285.056222] LustreError: 223345:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5b41000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7285.082178] Lustre: Unmounted lustre-client [ 7315.589820] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7316.799540] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7322.653199] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7338.481208] Lustre: Mounted lustre-client [ 7344.595685] LustreError: 224932:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7344.629187] Lustre: Unmounted lustre-client [ 7376.252715] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7377.477667] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7383.712431] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7394.288098] Lustre: Mounted lustre-client [ 7394.631507] LustreError: 226535:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c6ef4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7394.658557] Lustre: Unmounted lustre-client [ 7411.891082] Key type lgssc unregistered [ 7412.002509] LNet: 226938:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7412.005426] LNetError: 226938:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7412.012601] LNet: Removed LNI 192.168.203.16@tcp [ 7412.230766] Key type .llcrypt unregistered [ 7412.232172] Key type ._llcrypt unregistered [ 7417.249232] Key type ._llcrypt registered [ 7417.250566] Key type .llcrypt registered [ 7417.683424] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 07:15:39 (1778930139) [ 7418.629166] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7418.651059] alg: No test for adler32 (adler32-zlib) [ 7419.508905] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7419.594962] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7421.167130] Key type lgssc registered [ 7421.508338] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7436.397438] Key type lgssc unregistered [ 7436.519309] LNet: 229251:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7436.522258] LNetError: 229251:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7436.528258] LNet: Removed LNI 192.168.203.16@tcp [ 7436.743374] Key type .llcrypt unregistered [ 7436.744578] Key type ._llcrypt unregistered [ 7445.625969] Key type ._llcrypt registered [ 7445.627206] Key type .llcrypt registered [ 7445.804085] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7445.810931] alg: No test for adler32 (adler32-zlib) [ 7446.662101] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7446.748335] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7448.335122] Key type lgssc registered [ 7448.717531] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7476.121255] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7477.268808] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7484.257951] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7505.256362] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 7505.782018] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 07:17:07 (1778930227) [ 7514.957089] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7516.059918] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7522.223546] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7529.486774] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7530.642270] Lustre: Mounted lustre-client [ 7536.100931] Lustre: lustre-OST0001-osc-ffff90f0e06ba800: Connection to lustre-OST0001 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7538.299862] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7548.602596] Lustre: Unmounted lustre-client [ 7580.426521] Key type lgssc unregistered [ 7580.554576] LNet: 236123:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7580.557948] LNetError: 236123:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7580.567931] LNet: Removed LNI 192.168.203.16@tcp [ 7580.811663] Key type .llcrypt unregistered [ 7580.813071] Key type ._llcrypt unregistered [ 7591.608856] Key type ._llcrypt registered [ 7591.610527] Key type .llcrypt registered [ 7592.077502] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 07:18:33 (1778930313) [ 7596.378217] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7596.387314] alg: No test for adler32 (adler32-zlib) [ 7597.228466] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7597.300145] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7598.879148] Key type lgssc registered [ 7599.222546] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7615.202181] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7616.266811] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7627.018020] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 07:19:08 (1778930348) [ 7636.129956] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7637.331760] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7643.410965] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7649.755149] Lustre: Mounted lustre-client [ 7654.559548] LustreError: 241103:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c8392800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7654.593099] Lustre: Unmounted lustre-client [ 7705.138237] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7706.329536] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7733.955815] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7744.497760] Lustre: Mounted lustre-client [ 7744.945131] LustreError: 243133:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7744.976497] Lustre: Unmounted lustre-client [ 7762.395194] Key type lgssc unregistered [ 7762.521631] LNet: 243535:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7762.524238] LNetError: 243535:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7762.533505] LNet: Removed LNI 192.168.203.16@tcp [ 7762.789294] Key type .llcrypt unregistered [ 7762.790843] Key type ._llcrypt unregistered [ 7772.390522] Key type ._llcrypt registered [ 7772.393090] Key type .llcrypt registered [ 7772.578597] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7772.583635] alg: No test for adler32 (adler32-zlib) [ 7773.447173] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7773.534317] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7775.119212] Key type lgssc registered [ 7775.531091] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7803.986078] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7805.221085] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7812.748202] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7836.867871] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 7837.379932] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 07:22:39 (1778930559) [ 7846.987349] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7848.175797] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7854.305187] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7865.838785] Lustre: Mounted lustre-client [ 7866.695344] LustreError: 249561:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0e06bc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7866.722672] Lustre: Unmounted lustre-client [ 7884.073629] Key type lgssc unregistered [ 7884.193421] LNet: 249964:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7884.196247] LNetError: 249964:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7884.210893] LNet: Removed LNI 192.168.203.16@tcp [ 7884.434527] Key type .llcrypt unregistered [ 7884.435660] Key type ._llcrypt unregistered [ 7889.737877] Key type ._llcrypt registered [ 7889.738965] Key type .llcrypt registered [ 7890.224335] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 7890.723093] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 07:23:32 (1778930612) [ 7893.601239] Key type .llcrypt unregistered [ 7893.602719] Key type ._llcrypt unregistered [ 7896.285710] Key type ._llcrypt registered [ 7896.287321] Key type .llcrypt registered [ 7896.459713] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7896.467376] alg: No test for adler32 (adler32-zlib) [ 7897.330872] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7897.415324] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7898.999141] Key type lgssc registered [ 7899.372780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7916.789633] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7922.177936] Lustre: Mounted lustre-client [ 7922.611081] LustreError: 252975:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0d82ff800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7922.636172] Lustre: Unmounted lustre-client [ 7939.694688] Key type lgssc unregistered [ 7939.812611] LNet: 253379:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7939.815312] LNetError: 253379:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7939.823201] LNet: Removed LNI 192.168.203.16@tcp [ 7940.065552] Key type .llcrypt unregistered [ 7940.067388] Key type ._llcrypt unregistered [ 7945.166226] Key type ._llcrypt registered [ 7945.167225] Key type .llcrypt registered [ 7945.636260] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 07:24:27 (1778930667) [ 7946.466674] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7946.476713] alg: No test for adler32 (adler32-zlib) [ 7947.348322] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 7947.429508] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 7949.007156] Key type lgssc registered [ 7949.395303] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8008.935757] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8018.564249] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8019.765905] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8025.074731] Lustre: Mounted lustre-client [ 8025.537602] LustreError: 256414:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5b40800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8025.565185] Lustre: Unmounted lustre-client [ 8042.679481] Key type lgssc unregistered [ 8042.800575] LNet: 256818:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8042.803545] LNetError: 256818:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8042.810632] LNet: Removed LNI 192.168.203.16@tcp [ 8043.028935] Key type .llcrypt unregistered [ 8043.029994] Key type ._llcrypt unregistered [ 8048.101219] Key type ._llcrypt registered [ 8048.102363] Key type .llcrypt registered [ 8048.602294] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 07:26:10 (1778930770) [ 8049.407606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8049.488913] alg: No test for adler32 (adler32-zlib) [ 8050.342205] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 8050.420407] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 8051.999145] Key type lgssc registered [ 8052.349574] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8068.786928] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8069.885394] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8075.513250] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8081.880310] Lustre: Mounted lustre-client [ 8087.010483] Lustre: lustre-MDT0000-mdc-ffff90f0c7ee0800: Connection to lustre-MDT0000 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8089.289569] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8089.299477] LustreError: 259873:0:(file.c:6098:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 8089.408830] LustreError: 259892:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c7ee0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8089.410857] LustreError: MGC192.168.203.116@tcp: Connection to MGS (at 192.168.203.116@tcp) was lost; in progress operations using this service will fail [ 8089.433564] Lustre: Unmounted lustre-client [ 8099.946015] Key type lgssc unregistered [ 8100.061338] LNet: 260287:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8100.064414] LNetError: 260287:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8100.071271] LNet: Removed LNI 192.168.203.16@tcp [ 8100.275443] Key type .llcrypt unregistered [ 8100.276483] Key type ._llcrypt unregistered [ 8105.171167] Key type ._llcrypt registered [ 8105.172264] Key type .llcrypt registered [ 8105.626257] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 07:27:07 (1778930827) [ 8106.402167] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8106.434910] alg: No test for adler32 (adler32-zlib) [ 8107.291293] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 8107.371539] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 8108.951152] Key type lgssc registered [ 8109.360447] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8126.105665] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8127.245042] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8133.157294] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8148.975980] Lustre: Mounted lustre-client [ 8154.082720] Lustre: lustre-MDT0001-mdc-ffff90f0c5916800: Connection to lustre-MDT0001 (at 192.168.203.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8156.638271] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8156.964046] LustreError: 263371:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5916800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8156.988112] Lustre: Unmounted lustre-client [ 8167.563759] Key type lgssc unregistered [ 8167.673376] LNet: 263765:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8167.675787] LNetError: 263765:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8167.686672] LNet: Removed LNI 192.168.203.16@tcp [ 8167.905543] Key type .llcrypt unregistered [ 8167.906682] Key type ._llcrypt unregistered [ 8173.068559] Key type ._llcrypt registered [ 8173.069603] Key type .llcrypt registered [ 8173.460473] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 07:28:15 (1778930895) [ 8178.767208] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8178.799101] alg: No test for adler32 (adler32-zlib) [ 8179.644684] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 8179.723176] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 8181.303150] Key type lgssc registered [ 8181.665173] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8216.395521] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8217.566197] Lustre: Mounted lustre-client [ 8232.886682] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8243.192939] Lustre: Unmounted lustre-client [ 8260.158739] Key type lgssc unregistered [ 8260.264567] LNet: 269507:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8260.267717] LNetError: 269507:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8260.275412] LNet: Removed LNI 192.168.203.16@tcp [ 8260.497632] Key type .llcrypt unregistered [ 8260.499405] Key type ._llcrypt unregistered [ 8265.483496] Key type ._llcrypt registered [ 8265.484589] Key type .llcrypt registered [ 8265.951093] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 07:29:47 (1778930987) [ 8266.455914] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 8266.981349] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 07:29:48 (1778930988) [ 8267.686513] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 8268.228118] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 07:29:49 (1778930989) [ 8268.736051] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 8269.290261] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 07:29:50 (1778930990) [ 8269.823269] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 8270.410551] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 07:29:52 (1778930992) [ 8270.966462] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 8271.529439] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 07:29:53 (1778930993) [ 8274.453431] Key type .llcrypt unregistered [ 8274.454568] Key type ._llcrypt unregistered [ 8276.741784] Key type ._llcrypt registered [ 8276.745638] Key type .llcrypt registered [ 8276.978565] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8276.985150] alg: No test for adler32 (adler32-zlib) [ 8277.851429] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 8277.941177] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 8279.535114] Key type lgssc registered [ 8279.903677] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8305.282423] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8306.372208] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8313.294733] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8314.461093] Lustre: Mounted lustre-client [ 8314.914832] LustreError: 275083:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c5bc4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8314.943141] Lustre: Unmounted lustre-client [ 8337.767704] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 07:30:59 (1778931059) [ 8347.482906] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8348.671095] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8367.576576] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8367.736664] Lustre: Mounted lustre-client [ 8368.034784] LustreError: 277185:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c8154800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8368.057385] Lustre: Unmounted lustre-client [ 8406.315765] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 07:32:07 (1778931127) [ 8425.439088] LNet: 1 local NIs in recovery (showing 1): 192.168.203.16@tcp [ 8996.355598] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8997.739712] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9017.509474] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9071.337543] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 07:43:12 (1778931792) [ 9075.972132] Key type lgssc unregistered [ 9076.111718] LNet: 282716:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9076.114772] LNetError: 282716:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9076.123491] LNet: Removed LNI 192.168.203.16@tcp [ 9076.375251] Key type .llcrypt unregistered [ 9076.377158] Key type ._llcrypt unregistered [ 9145.199654] Key type ._llcrypt registered [ 9145.200657] Key type .llcrypt registered [ 9145.421259] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9145.426396] alg: No test for adler32 (adler32-zlib) [ 9146.312244] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9146.411771] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9148.007196] Key type lgssc registered [ 9148.636161] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9190.437504] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9192.090394] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9201.456722] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9221.876634] Key type lgssc unregistered [ 9222.028603] LNet: 286302:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9222.034148] LNetError: 286302:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9222.044942] LNet: Removed LNI 192.168.203.16@tcp [ 9222.387701] Key type .llcrypt unregistered [ 9222.390146] Key type ._llcrypt unregistered [ 9238.285085] Key type ._llcrypt registered [ 9238.286089] Key type .llcrypt registered [ 9238.746988] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 07:46:00 (1778931960) [ 9247.795127] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9247.800209] alg: No test for adler32 (adler32-zlib) [ 9248.646660] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9248.731374] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9250.311144] Key type lgssc registered [ 9250.647334] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9273.409639] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 07:46:34 (1778931994) [ 9278.059811] Key type lgssc unregistered [ 9278.166463] LNet: 289845:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9278.169606] LNetError: 289845:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9278.176469] LNet: Removed LNI 192.168.203.16@tcp [ 9278.384262] Key type .llcrypt unregistered [ 9278.385437] Key type ._llcrypt unregistered [ 9282.898534] Key type ._llcrypt registered [ 9282.899780] Key type .llcrypt registered [ 9283.057677] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9283.072943] alg: No test for adler32 (adler32-zlib) [ 9283.925822] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9284.003387] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9285.591162] Key type lgssc registered [ 9286.138572] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9310.462229] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9312.189174] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9321.044166] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9414.625903] LNet: Added LNI 192.168.203.16@tcp50 [8/256/0/180] [ 9415.935655] LNet: Removed LNI 192.168.203.16@tcp [ 9417.528809] Lustre: 294115:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff90f0c4ec2800: config has no valid NIDs, force dynamic NIDs [ 9418.604882] Lustre: Mounted lustre-client [ 9418.649770] LustreError: 294124:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c4ec2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9418.698190] Lustre: Unmounted lustre-client [ 9420.153409] Key type lgssc unregistered [ 9420.365110] LNet: 294374:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9420.370637] LNetError: 294374:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9420.385718] LNet: Removed LNI 192.168.203.16@tcp50 [ 9420.731943] Key type .llcrypt unregistered [ 9420.734319] Key type ._llcrypt unregistered [ 9432.214573] Key type ._llcrypt registered [ 9432.215558] Key type .llcrypt registered [ 9432.470777] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9432.484337] alg: No test for adler32 (adler32-zlib) [ 9433.343596] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9433.433253] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9435.031210] Key type lgssc registered [ 9435.422783] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9463.499328] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9464.883332] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9467.640539] LNet: Added LNI 192.168.203.16@tcp50 [8/256/0/180] [ 9467.936360] LNet: Removed LNI 192.168.203.16@tcp [ 9469.052850] Lustre: 296996:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff90f0c2c4a800: config has no valid NIDs, force dynamic NIDs [ 9470.127120] Lustre: Mounted lustre-client [ 9470.271190] LustreError: 297025:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c2c4a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9470.302864] Lustre: Unmounted lustre-client [ 9490.952623] Key type lgssc unregistered [ 9491.153638] LNet: 297864:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9491.157314] LNetError: 297864:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9491.167669] LNet: Removed LNI 192.168.203.16@tcp50 [ 9491.360834] Key type .llcrypt unregistered [ 9491.362037] Key type ._llcrypt unregistered [ 9495.829672] Key type ._llcrypt registered [ 9495.831375] Key type .llcrypt registered [ 9496.434106] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 07:50:17 (1778932217) [ 9504.403074] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9504.414072] alg: No test for adler32 (adler32-zlib) [ 9505.308365] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9505.412206] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9507.015215] Key type lgssc registered [ 9507.426042] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9539.841348] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9541.109490] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9549.646733] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9580.668512] Key type lgssc unregistered [ 9580.808910] LNet: 302508:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9580.814258] LNetError: 302508:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9580.824755] LNet: Removed LNI 192.168.203.16@tcp [ 9581.190622] Key type .llcrypt unregistered [ 9581.192970] Key type ._llcrypt unregistered [ 9585.530868] Key type ._llcrypt registered [ 9585.532019] Key type .llcrypt registered [ 9586.161470] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 07:51:47 (1778932307) [ 9587.254653] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9587.292869] alg: No test for adler32 (adler32-zlib) [ 9588.152787] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9588.237547] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9589.823196] Key type lgssc registered [ 9590.519810] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9612.479341] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9614.194598] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9622.824126] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9628.157774] Lustre: Mounted lustre-client [ 9654.943089] Lustre: Mounted fs15246-client [ 9661.424644] LustreError: 306652:0:(lov_obd.c:792:lov_cleanup()) fs15246-clilov-ffff90f0c4eea000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9661.453183] Lustre: Unmounted fs15246-client [ 9671.217330] LustreError: 306868:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff90f0c615f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9671.241885] Lustre: Unmounted lustre-client [ 9690.148641] Key type lgssc unregistered [ 9690.282416] LNet: 307271:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9690.285404] LNetError: 307271:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9690.296583] LNet: Removed LNI 192.168.203.16@tcp [ 9690.553571] Key type .llcrypt unregistered [ 9690.555235] Key type ._llcrypt unregistered [ 9694.686427] Key type ._llcrypt registered [ 9694.688452] Key type .llcrypt registered [ 9695.446386] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 07:53:36 (1778932416) [ 9696.095605] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9696.131307] alg: No test for adler32 (adler32-zlib) [ 9697.017222] Lustre: Lustre: Build Version: 2.17.53_3_g0d061c0 [ 9697.136534] LNet: Added LNI 192.168.203.16@tcp [8/256/0/180] [ 9698.759210] Key type lgssc registered [ 9699.428263] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9758.667560] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9760.125960] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9769.305611] Lustre: DEBUG MARKER: oleg316-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9819.359045] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 9537 sec ========== 07:55:40 (1778932540) [ 9820.114165] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 07:55:41 (1778932541) === [ 9821.687227] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 07:55:43 (1778932543) === [ 9837.812624] Key type lgssc unregistered [ 9837.969894] LNet: 316414:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9837.977500] LNetError: 316414:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9837.988979] LNet: Removed LNI 192.168.203.16@tcp [ 9838.403771] Key type .llcrypt unregistered [ 9838.406139] Key type ._llcrypt unregistered