[ 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 527703386 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.001012] APIC: Switch to symmetric I/O mode setup [ 0.002375] x2apic enabled [ 0.003007] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008011] pid_max: default: 32768 minimum: 301 [ 0.010019] LSM: Security Framework initializing [ 0.012046] Yama: becoming mindful. [ 0.013034] SELinux: Initializing. [ 0.014060] *** VALIDATE selinux *** [ 0.022401] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027368] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028163] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029134] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030113] *** VALIDATE tmpfs *** [ 0.032131] *** VALIDATE proc *** [ 0.033287] *** VALIDATE cgroup *** [ 0.034010] *** VALIDATE cgroup2 *** [ 0.036117] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037180] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039036] Spectre V2 : User space: Vulnerable [ 0.040010] Speculative Store Bypass: Vulnerable [ 0.043761] debug: unmapping init [mem 0xffffffffb6859000-0xffffffffb6860fff] [ 0.045395] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046759] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047029] ... version: 2 [ 0.048017] ... bit width: 48 [ 0.049018] ... generic registers: 4 [ 0.050015] ... value mask: 0000ffffffffffff [ 0.051010] ... max period: 00007fffffffffff [ 0.052011] ... fixed-purpose events: 3 [ 0.053012] ... event mask: 000000070000000f [ 0.054457] rcu: Hierarchical SRCU implementation. [ 0.056741] smp: Bringing up secondary CPUs ... [ 0.057755] x86: Booting SMP configuration: [ 0.058027] .... node #0, CPUs: #1 #2 #3 [ 0.068140] smp: Brought up 1 node, 4 CPUs [ 0.070013] smpboot: Max logical packages: 1 [ 0.071023] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.119446] node 0 deferred pages initialised in 46ms [ 0.121101] devtmpfs: initialized [ 0.122304] x86/mm: Memory block size: 128MB [ 0.125697] gcov: version magic: 0x41383552 [ 0.129397] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.132295] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.136681] pinctrl core: initialized pinctrl subsystem [ 0.139303] [ 0.140009] ************************************************************* [ 0.143110] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.146017] ** ** [ 0.149018] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.154015] ** ** [ 0.158022] ** This means that this kernel is built to expose internal ** [ 0.162014] ** IOMMU data structures, which may compromise security on ** [ 0.164016] ** your system. ** [ 0.167018] ** ** [ 0.172016] ** If you see this message and you are not debugging the ** [ 0.174016] ** kernel, report this immediately to your vendor! ** [ 0.176017] ** ** [ 0.179014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.182013] ************************************************************* [ 0.185754] NET: Registered protocol family 16 [ 0.187607] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.190131] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.195065] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.199136] cpuidle: using governor menu [ 0.200884] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.203491] PCI: Using configuration type 1 for base access [ 0.206139] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.214085] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.215020] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.216521] cryptd: max_cpu_qlen set to 1000 [ 0.219994] ACPI: Added _OSI(Module Device) [ 0.220090] ACPI: Added _OSI(Processor Device) [ 0.221013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.222018] ACPI: Added _OSI(Processor Aggregator Device) [ 0.227954] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.235190] ACPI: Interpreter enabled [ 0.236087] ACPI: PM: (supports S0 S3 S4 S5) [ 0.237014] ACPI: Using IOAPIC for interrupt routing [ 0.239126] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.243532] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.257940] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.260043] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.262019] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.265076] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.272116] acpiphp: Slot [2] registered [ 0.273123] acpiphp: Slot [5] registered [ 0.275241] acpiphp: Slot [6] registered [ 0.277118] acpiphp: Slot [3] registered [ 0.279104] acpiphp: Slot [4] registered [ 0.281269] acpiphp: Slot [7] registered [ 0.284269] acpiphp: Slot [8] registered [ 0.286104] acpiphp: Slot [9] registered [ 0.289136] acpiphp: Slot [10] registered [ 0.290122] acpiphp: Slot [11] registered [ 0.295126] acpiphp: Slot [12] registered [ 0.297133] acpiphp: Slot [13] registered [ 0.298100] acpiphp: Slot [14] registered [ 0.300140] acpiphp: Slot [15] registered [ 0.304326] acpiphp: Slot [16] registered [ 0.307121] acpiphp: Slot [17] registered [ 0.309123] acpiphp: Slot [18] registered [ 0.312112] acpiphp: Slot [19] registered [ 0.314682] acpiphp: Slot [20] registered [ 0.316301] acpiphp: Slot [21] registered [ 0.317000] acpiphp: Slot [22] registered [ 0.386120] acpiphp: Slot [23] registered [ 0.387148] acpiphp: Slot [24] registered [ 0.389070] acpiphp: Slot [25] registered [ 0.390000] acpiphp: Slot [26] registered [ 0.390000] acpiphp: Slot [27] registered [ 0.390000] acpiphp: Slot [28] registered [ 0.390000] acpiphp: Slot [29] registered [ 0.390000] acpiphp: Slot [30] registered [ 0.390000] acpiphp: Slot [31] registered [ 0.390000] PCI host bridge to bus 0000:00 [ 0.390000] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.390000] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.390000] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.390000] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.390000] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.390000] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.390000] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.390000] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.390000] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.390000] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.390000] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.390000] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.390000] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.390000] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.390000] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.390000] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.390000] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.393911] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.398017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.407015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.412013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.418324] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.557017] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.588026] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.603024] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.613055] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.618030] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.621027] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.630026] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.637968] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.639401] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.642493] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.644389] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.645190] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.650057] iommu: Default domain type: Passthrough [ 0.651502] SCSI subsystem initialized [ 0.652196] ACPI: bus type USB registered [ 0.653225] usbcore: registered new interface driver usbfs [ 0.654088] usbcore: registered new interface driver hub [ 0.655137] usbcore: registered new device driver usb [ 0.656244] pps_core: LinuxPPS API ver. 1 registered [ 0.657010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.658072] PTP clock support registered [ 0.659274] EDAC MC: Ver: 3.0.0 [ 0.660000] PCI: Using ACPI for IRQ routing [ 0.660009] NetLabel: Initializing [ 0.660883] NetLabel: domain hash size = 128 [ 0.661000] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.663156] NetLabel: unlabeled traffic allowed by default [ 0.665332] vgaarb: loaded [ 0.666644] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.668011] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.676588] clocksource: Switched to clocksource kvm-clock [ 0.827860] VFS: Disk quotas dquot_6.6.0 [ 0.831189] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.834327] *** VALIDATE ramfs *** [ 0.835223] *** VALIDATE hugetlbfs *** [ 0.836499] pnp: PnP ACPI init [ 0.838659] pnp: PnP ACPI: found 6 devices [ 0.853628] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.856193] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.858131] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.859833] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.861898] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.863961] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.866317] NET: Registered protocol family 2 [ 0.868773] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.873618] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.877501] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.882090] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.884661] TCP: Hash tables configured (established 65536 bind 65536) [ 0.887416] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.890062] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.892146] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.895407] NET: Registered protocol family 1 [ 0.898055] RPC: Registered named UNIX socket transport module. [ 0.900154] RPC: Registered udp transport module. [ 0.901695] RPC: Registered tcp transport module. [ 0.903606] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.905605] NET: Registered protocol family 44 [ 0.906677] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.912842] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.922081] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.939375] pci 0000:00:01.0: quirk_isa_dma_hangs+0x0/0x20 took 16771 usecs [ 0.945573] PCI: CLS 0 bytes, default 64 [ 0.947665] Unpacking initramfs... [ 5.419485] debug: unmapping init [mem 0xffff8eed7cc64000-0xffff8eed7ffcffff] [ 5.426706] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 5.431953] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 5.437671] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 7.693541] Initialise system trusted keyrings [ 7.695358] Key type blacklist registered [ 7.765462] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 7.998282] zbud: loaded [ 8.015553] *** VALIDATE nfs *** [ 8.023167] *** VALIDATE nfs4 *** [ 8.035041] pstore: using deflate compression [ 8.100619] Platform Keyring initialized [ 8.281751] NET: Registered protocol family 38 [ 8.285361] Key type asymmetric registered [ 8.286835] Asymmetric key parser 'x509' registered [ 8.289481] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 8.292314] io scheduler mq-deadline registered [ 8.294239] io scheduler kyber registered [ 8.295818] io scheduler bfq registered [ 8.297565] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 8.300345] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 8.303310] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 8.320710] hrtimer: interrupt took 3728416 ns [ 8.349573] ACPI: Power Button [PWRF] [ 8.359772] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 8.368640] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 8.408427] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 8.472147] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 8.539418] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 8.609710] Non-volatile memory driver v1.3 [ 8.611630] Linux agpgart interface v0.103 [ 8.647787] virtio_blk virtio1: [vda] 134192 512-byte logical blocks (68.7 MB/65.5 MiB) [ 8.652902] vda: detected capacity change from 0 to 68706304 [ 8.789672] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 8.792339] vdb: detected capacity change from 0 to 1073741824 [ 8.834241] libphy: Fixed MDIO Bus: probed [ 8.844701] usbcore: registered new interface driver usbserial_generic [ 8.847559] usbserial: USB Serial support registered for generic [ 8.850720] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 8.856498] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 8.858872] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 8.862461] mousedev: PS/2 mouse device common for all mice [ 8.867824] rtc_cmos 00:05: RTC can wake from S4 [ 8.875297] rtc_cmos 00:05: registered as rtc0 [ 8.922840] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 8.925238] intel_pstate: CPU model not supported [ 9.070256] hpet1: lost 11 rtc interrupts [ 9.072845] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 9.073316] hid: raw HID events driver (C) Jiri Kosina [ 9.080057] usbcore: registered new interface driver usbhid [ 9.082311] usbhid: USB HID core driver [ 9.084215] drop_monitor: Initializing network drop monitor service [ 9.087159] Initializing XFRM netlink socket [ 9.089982] NET: Registered protocol family 10 [ 9.093548] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 9.094326] Segment Routing with IPv6 [ 9.118406] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 9.127283] NET: Registered protocol family 17 [ 9.131828] mpls_gso: MPLS GSO support [ 9.302844] RAS: Correctable Errors collector initialized. [ 9.312964] AVX version of gcm_enc/dec engaged. [ 9.327200] AES CTR mode by8 optimization enabled [ 9.913919] sched_clock: Marking stable (9913836498, 0)->(11964698430, -2050861932) [ 9.917841] registered taskstats version 1 [ 9.923539] Loading compiled-in X.509 certificates [ 9.925783] zswap: loaded using pool lzo/zbud [ 9.986716] Key type big_key registered [ 10.182975] Key type encrypted registered [ 10.208232] ima: No TPM chip found, activating TPM-bypass! [ 10.222961] ima: Allocated hash algorithm: sha1 [ 10.245020] ima: No architecture policies found [ 10.256641] evm: Initialising EVM extended attributes: [ 10.277218] evm: security.selinux [ 10.287876] evm: security.ima [ 10.302969] evm: security.capability [ 10.322190] evm: HMAC attrs: 0x1 [ 10.362979] rtc_cmos 00:05: setting system clock to 2026-01-22 04:01:58 UTC (1769054518) [ 10.460385] debug: unmapping init [mem 0xffffffffb7803000-0xffffffffb79fffff] [ 10.510103] debug: unmapping init [mem 0xffffffffb6582000-0xffffffffb6858fff] [ 10.535989] Write protecting the kernel read-only data: 28672k [ 10.578773] debug: unmapping init [mem 0xffffffffb4c03000-0xffffffffb4dfffff] [ 10.613739] debug: unmapping init [mem 0xffffffffb5514000-0xffffffffb55fffff] [ 11.108905] 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) [ 11.116806] systemd[1]: Detected virtualization kvm. [ 11.118457] systemd[1]: Detected architecture x86-64. [ 11.120352] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 11.145644] systemd[1]: No hostname configured. [ 11.147745] systemd[1]: Set hostname to . [ 11.149919] random: systemd: uninitialized urandom read (16 bytes read) [ 11.152431] systemd[1]: Initializing machine ID from random generator. [ 11.283944] random: ln: uninitialized urandom read (6 bytes read) [ 12.312729] random: systemd: uninitialized urandom read (16 bytes read) [ 12.321575] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 12.327559] random: systemd: uninitialized urandom read (16 bytes read) [ 12.334545] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st…ce nodes for the current kernel... [ 12.345961] random: systemd: uninitialized urandom read (16 bytes read) [ 12.349145] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. Starting Setup Virtual Console... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Timers. [ OK ] Listening on udev Kernel Socket. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Slices. [ OK ] Reached target Sockets. [ OK ] Reached target Local Encrypted Volumes. Starting Journal Service... [ 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. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 17.164845] device-mapper: uevent: version 1.0.3 [ 17.168750] 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... [ OK ] Started udev Coldplug all Devices. [ OK [ 19.634653] random: fast init done ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ 20.602918] virtio_net virtio0 ens2: renamed from eth0 [ 25.270769] scsi host0: ata_piix [ 25.316184] scsi host1: ata_piix [ 25.323323] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 25.329888] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 27.868781] random: crng init done [ 27.877863] random: 5 urandom warning(s) missed due to ratelimiting [ 31.943983] dracut-initqueue[578]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 34.616170] 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 38.464496] printk: systemd: 26 output lines suppressed due to ratelimiting [ 39.687378] SELinux: Disabled at runtime. [ 39.943349] 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) [ 39.975473] systemd[1]: Detected virtualization kvm. [ 39.977341] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 42.894287] systemd[1]: initrd-switch-root.service: Succeeded. [ 42.908619] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 42.984411] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 43.016803] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 43.031654] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 43.077849] systemd[1]: Starting Journal Service... Starting Journal Service... [ 43.111981] systemd[1]: Starting Remount Root and Kernel File Systems... Starting Remount Root and Kernel File Systems... Mounting POSIX Message Queue File System... [ OK ] Listening on RPCbind Server Activation Socket. Mounting Kernel Debug File System... Activating swap /dev/disk/by-label/SWAP... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice system-getty.slice. [ OK ] Reached target RPC Port Mapper. Mounting Huge Pages File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on udev Kernel Socket. [ 43.616309] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Apply Kernel Variables... [ OK ] Listening on udev Control Socket. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-serial\x2dgetty.slice. Starting udev Coldplug all Devices... [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Started Journal Service. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 45.793888] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 47.903653] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 48.076678] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 49.022604] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 49.196186] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (9s / no limit) [** ] A start job is running for Configur…only root support (10s / no limit) [*** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit)[ 54.410302] Key type dns_resolver registered [ *** ] A start job is running for Configur…only root support (11s / no limit) [ ***] A start job is running for Configur…only root support (12s / no limit)[ 55.490667] NFS: Registering the id_resolver key type [ 55.505967] Key type id_resolver registered [ 55.511074] Key type id_legacy registered [ **] A start job is running for Configur…only root support (12s / no limit) [ *] A start job is running for Configur…only root support (13s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Basic System. Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Daily Cleanup of Temporary Directories. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started irqbalance daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started OpenSSH server daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg448-client login: [ 132.598421] libcfs: loading out-of-tree module taints kernel. [ 132.883269] Key type ._llcrypt registered [ 132.885187] Key type .llcrypt registered [ 133.243808] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 133.260665] alg: No test for adler32 (adler32-zlib) [ 134.607347] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 135.509143] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 137.247296] Key type lgssc registered [ 139.349801] Lustre: Echo OBD driver; http://www.lustre.org/ [ 265.557741] Lustre: Mounted lustre-client [ 269.367479] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 289.740173] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing check_logdir /tmp/testlogs/ [ 291.298189] Lustre: lustre-OST0000-osc-ffff8eedcba2f800: disconnect after 24s idle [ 293.256410] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing yml_node [ 296.475757] Lustre: DEBUG MARKER: Client: 2.17.50.63 [ 298.550811] Lustre: DEBUG MARKER: MDS: 2.17.50.63 [ 300.511616] Lustre: DEBUG MARKER: OSS: 2.17.50.63 [ 301.675987] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Jan 21 23:06:48 EST 2026 [ 314.351608] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 315.495517] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 317.007981] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 327.288368] LustreError: 9001:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 327.329852] Lustre: Unmounted lustre-client [ 476.966993] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 481.150975] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 502.820737] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 552.953923] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 23:10:59 (1769055059) [ 555.519810] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 557.614824] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 23:11:04 (1769055064) [ 589.916722] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 594.496219] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 614.847695] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 615.609618] Lustre: Mounted lustre-client [ 620.841411] LustreError: 14462:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc3fa6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 620.876522] LustreError: 14462:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 620.879073] LustreError: 14462:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 620.967835] Lustre: Unmounted lustre-client [ 650.455936] Key type lgssc unregistered [ 650.828675] LNet: 14871:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 650.836579] LNetError: 14871:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 650.857700] LNet: Removed LNI 192.168.204.48@tcp [ 651.559232] Key type .llcrypt unregistered [ 651.561550] Key type ._llcrypt unregistered [ 667.388190] Key type ._llcrypt registered [ 667.390583] Key type .llcrypt registered [ 668.734379] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 23:12:55 (1769055175) [ 670.250855] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 670.269802] alg: No test for adler32 (adler32-zlib) [ 671.385590] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 671.628861] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 673.319841] Key type lgssc registered [ 674.266707] Lustre: Echo OBD driver; http://www.lustre.org/ [ 752.647278] Lustre: Mounted lustre-client [ 851.589881] LustreError: 18186:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07f9800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 851.613334] LustreError: 18186:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 851.636972] Lustre: Unmounted lustre-client [ 883.195834] Key type lgssc unregistered [ 883.500851] LNet: 18651:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 883.513871] LNetError: 18651:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 883.535417] LNet: Removed LNI 192.168.204.48@tcp [ 884.656236] Key type .llcrypt unregistered [ 884.661655] Key type ._llcrypt unregistered [ 897.068668] Key type ._llcrypt registered [ 897.070249] Key type .llcrypt registered [ 898.578546] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 23:16:44 (1769055404) [ 901.513698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 901.566882] alg: No test for adler32 (adler32-zlib) [ 902.732696] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 903.070675] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 904.873070] Key type lgssc registered [ 906.892354] Lustre: Echo OBD driver; http://www.lustre.org/ [ 959.883044] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 965.048828] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 987.521397] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 989.642985] Lustre: Mounted lustre-client [ 1001.851769] LustreError: 21761:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc688d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1001.873489] LustreError: 21761:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1001.945421] Lustre: Unmounted lustre-client [ 1028.125339] Key type lgssc unregistered [ 1028.368386] LNet: 22164:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1028.377163] LNetError: 22164:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1028.399441] LNet: Removed LNI 192.168.204.48@tcp [ 1029.163274] Key type .llcrypt unregistered [ 1029.166251] Key type ._llcrypt unregistered [ 1041.673938] Key type ._llcrypt registered [ 1041.677849] Key type .llcrypt registered [ 1043.744619] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 23:19:09 (1769055549) [ 1046.253683] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1046.488714] alg: No test for adler32 (adler32-zlib) [ 1047.597216] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 1047.935399] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1049.665912] Key type lgssc registered [ 1051.108029] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1102.010584] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1106.311821] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1126.241812] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1129.645085] Lustre: Mounted lustre-client [ 1136.484843] LustreError: 24864:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd003a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1136.504473] LustreError: 24864:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1136.557763] Lustre: Unmounted lustre-client [ 1166.928334] Key type lgssc unregistered [ 1167.238534] LNet: 25266:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1167.256792] LNetError: 25266:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1167.271283] LNet: Removed LNI 192.168.204.48@tcp [ 1167.970235] Key type .llcrypt unregistered [ 1167.972342] Key type ._llcrypt unregistered [ 1184.386531] Key type ._llcrypt registered [ 1184.388633] Key type .llcrypt registered [ 1185.727240] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 23:21:32 (1769055692) [ 1188.078758] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1188.306149] alg: No test for adler32 (adler32-zlib) [ 1189.365465] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 1189.558778] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1191.271181] Key type lgssc registered [ 1192.562161] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1243.152761] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1246.690304] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1264.915904] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1268.142888] Lustre: Mounted lustre-client [ 1273.333905] Lustre: lustre-MDT0000-mdc-ffff8eedc333f000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1283.571358] Lustre: lustre-MDT0001-mdc-ffff8eedc333f000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1291.613691] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1298.911304] Lustre: 26224:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769055791/real 1769055791] req@000000009764486b x1854989346543616/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1769055807 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1298.938536] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 1301.940987] LustreError: 28448:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1302.031515] Lustre: Unmounted lustre-client [ 1323.114457] Key type lgssc unregistered [ 1323.355700] LNet: 28840:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1323.366544] LNetError: 28840:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1323.389142] LNet: Removed LNI 192.168.204.48@tcp [ 1324.210990] Key type .llcrypt unregistered [ 1324.214116] Key type ._llcrypt unregistered [ 1342.376718] Key type ._llcrypt registered [ 1342.378759] Key type .llcrypt registered [ 1343.803227] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 23:24:10 (1769055850) [ 1346.049119] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1346.157058] alg: No test for adler32 (adler32-zlib) [ 1347.386201] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 1347.724114] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1349.511288] Key type lgssc registered [ 1350.976397] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1403.237881] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1407.200702] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1428.553832] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1430.303757] Lustre: Mounted lustre-client [ 1435.648957] Lustre: lustre-OST0000-osc-ffff8eedcba28000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1443.932932] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1454.207900] LustreError: 31969:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1454.292786] Lustre: Unmounted lustre-client [ 1499.092587] Key type lgssc unregistered [ 1499.324807] LNet: 32373:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1499.335860] LNetError: 32373:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1499.362666] LNet: Removed LNI 192.168.204.48@tcp [ 1500.127317] Key type .llcrypt unregistered [ 1500.130076] Key type ._llcrypt unregistered [ 1515.047731] Key type ._llcrypt registered [ 1515.049967] Key type .llcrypt registered [ 1516.689347] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 23:27:03 (1769056023) [ 1519.280409] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1519.303665] alg: No test for adler32 (adler32-zlib) [ 1520.366390] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 1520.640065] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1522.319171] Key type lgssc registered [ 1523.671741] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1577.364578] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1581.611815] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1603.638646] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1605.512634] Lustre: Mounted lustre-client [ 1609.528913] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1612.755463] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1625.176917] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-01-2123h28m51s [ 1627.643850] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1631.215043] Lustre: lustre-MDT0000-mdc-ffff8eedc3fa3000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1647.444449] LustreError: 36080:0:(lmv_obd.c:1435:lmv_statfs()) lustre-MDT0000-mdc-ffff8eedc3fa3000: can't stat MDS #0: rc = -19 [ 1649.566208] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1660.902779] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 1660.945183] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xc90aed025f64fc6 to 0xc90aed025f65289 [ 1660.964387] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1661.998213] LustreError: lustre-MDT0000-mdc-ffff8eedc3fa3000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1662.026069] Lustre: lustre-MDT0000-mdc-ffff8eedc3fa3000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1668.060549] Lustre: DEBUG MARKER: Wait for df (36080) ... [ 1670.390188] Lustre: DEBUG MARKER: done [ 1673.262275] LustreError: 36700:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc3fa3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1673.270506] LustreError: 36700:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1673.318269] Lustre: Unmounted lustre-client [ 1702.377749] Key type lgssc unregistered [ 1702.761149] LNet: 37102:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1702.779062] LNetError: 37102:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1702.796970] LNet: Removed LNI 192.168.204.48@tcp [ 1703.642380] Key type .llcrypt unregistered [ 1703.644433] Key type ._llcrypt unregistered [ 1738.343524] Key type ._llcrypt registered [ 1738.346707] Key type .llcrypt registered [ 1739.579726] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 23:30:46 (1769056246) [ 1742.870739] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1742.921633] alg: No test for adler32 (adler32-zlib) [ 1744.200694] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 1744.514485] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1746.312565] Key type lgssc registered [ 1747.889203] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1803.996983] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1809.800570] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1832.576308] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1835.352321] Lustre: Mounted lustre-client [ 1841.226166] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-01-2123h32m27s [ 1843.558251] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1852.775871] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1855.551549] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1875.937102] Lustre: 41177:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769056363/real 1769056363] req@00000000764f808c x1854989928503936/t0(0) o101->lustre-MDT0000-mdc-ffff8eedc5b1b000@192.168.204.148@tcp:12/10 lens 576/1152 e 0 to 1 dl 1769056383 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1875.980885] Lustre: lustre-MDT0000-mdc-ffff8eedc5b1b000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1876.024891] Lustre: lustre-MDT0000-mdc-ffff8eedc5b1b000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1898.103326] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1902.641378] Lustre: DEBUG MARKER: done [ 1906.807613] LustreError: 41650:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc5b1b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1906.840874] LustreError: 41650:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1906.909946] Lustre: Unmounted lustre-client [ 1945.580682] Key type lgssc unregistered [ 1945.888517] LNet: 42054:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1945.902430] LNetError: 42054:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1945.933811] LNet: Removed LNI 192.168.204.48@tcp [ 1946.984147] Key type .llcrypt unregistered [ 1946.988676] Key type ._llcrypt unregistered [ 1979.707830] Key type ._llcrypt registered [ 1979.712217] Key type .llcrypt registered [ 1980.857534] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 23:34:47 (1769056487) [ 1982.635847] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1984.887859] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 23:34:51 (1769056491) [ 1989.790885] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1989.888609] alg: No test for adler32 (adler32-zlib) [ 1991.048433] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 1991.313594] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1992.991882] Key type lgssc registered [ 1994.971915] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2027.400901] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 23:35:33 (1769056533) [ 2064.510931] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2071.107847] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2093.119676] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2095.867901] Lustre: Mounted lustre-client [ 2099.884374] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2103.374850] LustreError: 46418:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc3fa2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2103.428503] LustreError: 46418:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2103.515427] Lustre: Unmounted lustre-client [ 2123.004810] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2168.067353] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2172.223815] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2172.956903] Lustre: Mounted lustre-client [ 2177.322620] LustreError: 47677:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedcb82d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2177.369651] LustreError: 47677:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2177.377399] LustreError: 47677:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2177.449936] Lustre: Unmounted lustre-client [ 2247.165149] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2251.975574] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2252.801326] Lustre: Mounted lustre-client [ 2255.142055] LustreError: 48801:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07c1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2255.171447] LustreError: 48801:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2255.177889] LustreError: 48801:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2255.259370] Lustre: Unmounted lustre-client [ 2275.692881] Lustre: DEBUG MARKER: files compared the same [ 2300.009625] Key type lgssc unregistered [ 2300.270849] LNet: 49507:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2300.282195] LNetError: 49507:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2301.360121] LNet: Removed LNI 192.168.204.48@tcp [ 2302.331610] Key type .llcrypt unregistered [ 2302.334547] Key type ._llcrypt unregistered [ 2321.070365] Key type ._llcrypt registered [ 2321.072551] Key type .llcrypt registered [ 2322.791992] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 23:40:29 (1769056829) [ 2325.434600] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2325.583263] alg: No test for adler32 (adler32-zlib) [ 2326.610596] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 2326.845617] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2328.607179] Key type lgssc registered [ 2330.113449] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2387.978645] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2393.380781] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2415.398568] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2418.374670] Lustre: Mounted lustre-client [ 2427.208862] LustreError: 52611:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc414e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2427.240444] LustreError: 52611:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2427.332370] Lustre: Unmounted lustre-client [ 2458.014767] Key type lgssc unregistered [ 2458.217931] LNet: 53014:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2458.232724] LNetError: 53014:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2458.250879] LNet: Removed LNI 192.168.204.48@tcp [ 2458.793418] Key type .llcrypt unregistered [ 2458.795459] Key type ._llcrypt unregistered [ 2478.396874] Key type ._llcrypt registered [ 2478.398851] Key type .llcrypt registered [ 2479.800379] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 23:43:06 (1769056986) [ 2482.311851] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2482.402477] alg: No test for adler32 (adler32-zlib) [ 2483.580932] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 2483.815598] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2485.578062] Key type lgssc registered [ 2487.220758] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2576.189432] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2610.169298] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2614.659896] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2644.220863] Key type lgssc unregistered [ 2644.621611] LNet: 56413:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2644.627464] LNetError: 56413:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2644.650935] LNet: Removed LNI 192.168.204.48@tcp [ 2645.688553] Key type .llcrypt unregistered [ 2645.690666] Key type ._llcrypt unregistered [ 2660.727410] Key type ._llcrypt registered [ 2660.729868] Key type .llcrypt registered [ 2661.992257] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 23:46:08 (1769057168) [ 2665.331457] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2665.412706] alg: No test for adler32 (adler32-zlib) [ 2666.523395] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 2666.684997] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2668.319675] Key type lgssc registered [ 2669.618351] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2737.627712] Lustre: Mounted lustre-client [ 2744.235108] LustreError: 58907:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc688f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2744.261363] LustreError: 58907:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2744.309677] Lustre: Unmounted lustre-client [ 2789.973995] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 23:48:16 (1769057296) [ 2898.427710] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2918.946070] Lustre: Mounted lustre-client [ 2925.773162] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2925.777483] LustreError: 62869:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff8eedcba08000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2925.802604] Lustre: 57395:0:(llite_lib.c:4195:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.148@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2936.056173] LustreError: 62869:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2936.068377] LustreError: 62869:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2936.110071] Lustre: Unmounted lustre-client [ 2975.760153] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 23:51:22 (1769057482) [ 2984.875971] Key type lgssc unregistered [ 2985.069041] LNet: 64081:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2985.074111] LNetError: 64081:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2985.089234] LNet: Removed LNI 192.168.204.48@tcp [ 2985.736713] Key type .llcrypt unregistered [ 2985.739501] Key type ._llcrypt unregistered [ 2995.258803] Key type ._llcrypt registered [ 2995.262773] Key type .llcrypt registered [ 2995.840263] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2995.855524] alg: No test for adler32 (adler32-zlib) [ 2997.018050] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 2997.259423] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2998.975175] Key type lgssc registered [ 2999.920740] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3063.028350] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3067.289948] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3089.309672] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3100.753884] Lustre: Mounted lustre-client [ 3106.313621] LustreError: 66609:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca70c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3106.334598] LustreError: 66609:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3106.429612] Lustre: Unmounted lustre-client [ 3137.036454] Key type lgssc unregistered [ 3137.438874] LNet: 67013:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3137.447460] LNetError: 67013:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3138.470544] LNet: Removed LNI 192.168.204.48@tcp [ 3139.197522] Key type .llcrypt unregistered [ 3139.202446] Key type ._llcrypt unregistered [ 3153.261060] Key type ._llcrypt registered [ 3153.269711] Key type .llcrypt registered [ 3153.696193] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3153.736690] alg: No test for adler32 (adler32-zlib) [ 3154.737216] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 3154.980368] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3156.623166] Key type lgssc registered [ 3158.974251] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3283.788597] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3287.802783] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3309.986345] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3311.822539] Lustre: Mounted lustre-client [ 3314.925973] LustreError: 69960:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedcba0f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3314.973266] LustreError: 69960:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3315.130250] Lustre: Unmounted lustre-client [ 3363.088945] Key type lgssc unregistered [ 3363.414578] LNet: 70367:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3363.433153] LNetError: 70367:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3363.451797] LNet: Removed LNI 192.168.204.48@tcp [ 3364.265614] Key type .llcrypt unregistered [ 3364.269994] Key type ._llcrypt unregistered [ 3383.227822] Key type ._llcrypt registered [ 3383.233197] Key type .llcrypt registered [ 3385.003925] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 23:58:11 (1769057891) [ 3388.550822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3388.616076] alg: No test for adler32 (adler32-zlib) [ 3389.773902] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 3390.048178] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3391.823560] Key type lgssc registered [ 3393.334780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3452.833450] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3457.005453] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3479.945429] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3481.888500] Lustre: Mounted lustre-client [ 3491.721055] LustreError: 73498:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc79eb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3491.763687] LustreError: 73498:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3491.869637] Lustre: Unmounted lustre-client [ 3492.555280] Lustre: Mounted lustre-client [ 3495.864382] LustreError: 73577:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca4c6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3495.898676] LustreError: 73577:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3495.913492] LustreError: 73577:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3495.991772] Lustre: Unmounted lustre-client [ 3534.618029] Key type lgssc unregistered [ 3535.150203] LNet: 73980:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3535.164626] LNetError: 73980:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3536.237038] LNet: Removed LNI 192.168.204.48@tcp [ 3537.572991] Key type .llcrypt unregistered [ 3537.578533] Key type ._llcrypt unregistered [ 3552.773820] Key type ._llcrypt registered [ 3552.781805] Key type .llcrypt registered [ 3553.572224] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3553.605576] alg: No test for adler32 (adler32-zlib) [ 3554.866914] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 3555.154124] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3556.913444] Key type lgssc registered [ 3558.672354] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3614.704227] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3619.043594] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3642.076306] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3644.978456] Lustre: Mounted lustre-client [ 3650.305257] LustreError: 76551:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedcba0f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3650.330265] LustreError: 76551:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3650.410185] Lustre: Unmounted lustre-client [ 3681.125032] Key type lgssc unregistered [ 3681.402448] LNet: 76954:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3681.408618] LNetError: 76954:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3681.430959] LNet: Removed LNI 192.168.204.48@tcp [ 3682.210183] Key type .llcrypt unregistered [ 3682.220137] Key type ._llcrypt unregistered [ 3702.220347] Key type ._llcrypt registered [ 3702.223553] Key type .llcrypt registered [ 3704.486482] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 00:03:30 (1769058210) [ 3707.525324] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3707.543321] alg: No test for adler32 (adler32-zlib) [ 3708.808325] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 3709.047363] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3710.776455] Key type lgssc registered [ 3711.980069] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3777.427170] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3782.323565] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3804.287901] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3816.601110] Lustre: Mounted lustre-client [ 3830.400765] Lustre: lustre: root_squash is set to 0:0 [ 3830.465431] Lustre: lustre: nosquash_nids is cleared [ 3843.125805] Lustre: lustre: root_squash is set to 500:500 [ 3854.403424] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.48@tcp 192.168.0.[2,10]@tcp [ 3872.883963] Lustre: lustre: nosquash_nids set to 192.168.204.48/24@tcp [ 3876.849968] LustreError: 80465:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc8a64000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3876.882413] LustreError: 80465:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3876.943162] Lustre: Unmounted lustre-client [ 3915.502576] Key type lgssc unregistered [ 3915.712867] LNet: 80869:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3915.725575] LNetError: 80869:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3915.742609] LNet: Removed LNI 192.168.204.48@tcp [ 3916.651268] Key type .llcrypt unregistered [ 3916.652811] Key type ._llcrypt unregistered [ 3934.681939] Key type ._llcrypt registered [ 3934.683455] Key type .llcrypt registered [ 3936.136992] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 00:07:22 (1769058442) [ 3938.749451] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3940.390498] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 00:07:27 (1769058447) [ 3943.240933] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3943.270638] alg: No test for adler32 (adler32-zlib) [ 3944.462974] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 3944.851647] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3946.551172] Key type lgssc registered [ 3948.144712] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4003.247110] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4007.220288] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4029.546656] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4030.463143] Lustre: lustre: root_squash is set to 500:500 [ 4030.520557] Lustre: lustre: nosquash_nids set to 192.168.204.48/24@tcp [ 4031.648187] Lustre: Mounted lustre-client [ 4040.387267] LustreError: 84342:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc5b1f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4040.404949] LustreError: 84342:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 4040.450729] Lustre: Unmounted lustre-client [ 4069.394580] Key type lgssc unregistered [ 4069.731266] LNet: 84744:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4069.738116] LNetError: 84744:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4069.752857] LNet: Removed LNI 192.168.204.48@tcp [ 4070.430803] Key type .llcrypt unregistered [ 4070.433716] Key type ._llcrypt unregistered [ 4088.404846] Key type ._llcrypt registered [ 4088.407633] Key type .llcrypt registered [ 4089.950326] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4092.009733] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 00:09:58 (1769058598) [ 4113.246909] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4113.271353] alg: No test for adler32 (adler32-zlib) [ 4114.492404] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 4114.780057] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4116.488207] Key type lgssc registered [ 4117.794565] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4199.983777] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4205.232155] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4226.238275] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4292.205462] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4296.324571] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4314.599629] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4327.458727] Lustre: Mounted lustre-client [ 4359.318615] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8eedc4290000.ost_server_uuid 50 [ 4360.860901] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8eedc4290000.ost_server_uuid in FULL state after 0 sec [ 4361.284318] Lustre: Mounted lustre-client [ 4365.359123] LustreError: 91654:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc5b1e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4365.392280] LustreError: 91654:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 4365.471934] Lustre: Unmounted lustre-client [ 4367.435049] LustreError: 91674:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc4290000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4367.458715] LustreError: 91674:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4367.477702] LustreError: 91674:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4367.483971] LustreError: 91674:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 4367.578130] Lustre: Unmounted lustre-client [ 4407.904172] Key type lgssc unregistered [ 4408.206152] LNet: 92227:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4408.211442] LNetError: 92227:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4408.237479] LNet: Removed LNI 192.168.204.48@tcp [ 4408.803418] Key type .llcrypt unregistered [ 4408.804884] Key type ._llcrypt unregistered [ 4439.899315] Key type ._llcrypt registered [ 4439.901319] Key type .llcrypt registered [ 4441.402933] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 00:15:47 (1769058947) [ 4459.648102] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4459.656903] alg: No test for adler32 (adler32-zlib) [ 4460.802751] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 4461.107972] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4462.775291] Key type lgssc registered [ 4463.939834] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4548.409289] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4551.810529] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4572.997042] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4574.653518] Lustre: Mounted lustre-client [ 4595.167273] Lustre: 93591:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769059087/real 1769059087] req@00000000be952384 x1854992777483392/t0(0) o400->lustre-OST0000-osc-ffff8eedc5b1a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1769059103 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4595.198458] Lustre: lustre-OST0000-osc-ffff8eedc5b1a000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4601.375264] Lustre: 93591:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769059093/real 1769059093] req@000000001ef06e1b x1854992777483904/t0(0) o400->lustre-OST0000-osc-ffff8eedc5b1a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1769059109 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4605.478908] Lustre: lustre-OST0000-osc-ffff8eedc5b1a000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4606.496684] Lustre: 93591:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769059098/real 1769059098] req@000000000a0d72d8 x1854992777484416/t0(0) o400->lustre-OST0000-osc-ffff8eedc5b1a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1769059114 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4610.544619] Lustre: lustre-MDT0000-mdc-ffff8eedc5b1a000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4611.556163] Lustre: 93590:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769059103/real 1769059103] req@000000005eec219b x1854992777484928/t0(0) o400->lustre-OST0000-osc-ffff8eedc5b1a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1769059119 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4622.303175] Lustre: 96679:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769059114/real 1769059114] req@00000000f117492a x1854992777486336/t0(0) o101->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 328/344 e 0 to 1 dl 1769059130 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4622.340981] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 4622.354641] Lustre: 96679:0:(mgc_request.c:1911:mgc_process_log()) MGC192.168.204.148@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 4630.399017] Lustre: lustre-MDT0000-mdc-ffff8eedc5b1a000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4632.617734] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0x834791f4a212db18 to 0x834791f4a212df24 [ 4632.649191] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4636.082149] LustreError: 97411:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc5b1a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4636.120166] LustreError: 97411:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4636.201025] Lustre: Unmounted lustre-client [ 4662.324597] Key type lgssc unregistered [ 4662.652100] LNet: 97815:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4662.657079] LNetError: 97815:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4662.677967] LNet: Removed LNI 192.168.204.48@tcp [ 4663.436474] Key type .llcrypt unregistered [ 4663.439130] Key type ._llcrypt unregistered [ 4679.387544] Key type ._llcrypt registered [ 4679.390254] Key type .llcrypt registered [ 4680.571151] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 00:19:47 (1769059187) [ 4695.267283] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4695.419079] alg: No test for adler32 (adler32-zlib) [ 4696.561417] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 4696.866838] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4698.543527] Key type lgssc registered [ 4700.171506] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4737.033147] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4830.208600] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4834.865545] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4856.681083] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4858.303738] Lustre: Mounted lustre-client [ 4860.055530] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4861.824868] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 00:22:48 (1769059368) [ 5040.425803] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5050.761191] LustreError: 108588:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5050.785766] Lustre: Unmounted lustre-client [ 5169.011851] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5172.620694] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5191.446285] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5236.643779] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 00:29:03 (1769059743) [ 5332.604373] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5339.371122] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5369.051226] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5369.603662] Lustre: Mounted lustre-client [ 5374.690295] LustreError: 116015:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07fc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5374.725273] LustreError: 116015:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5374.728175] LustreError: 116015:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5374.797026] Lustre: Unmounted lustre-client [ 5408.931473] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 00:31:55 (1769059915) [ 5510.672660] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5514.101827] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5536.749287] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5537.621398] Lustre: Mounted lustre-client [ 5541.789407] LustreError: 120069:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc4296000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5541.817408] LustreError: 120069:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5541.828195] LustreError: 120069:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5541.907718] Lustre: Unmounted lustre-client [ 5577.819674] Key type lgssc unregistered [ 5578.097475] LNet: 120472:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5578.105784] LNetError: 120472:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5578.125586] LNet: Removed LNI 192.168.204.48@tcp [ 5578.830771] Key type .llcrypt unregistered [ 5578.832837] Key type ._llcrypt unregistered [ 5595.408624] Key type ._llcrypt registered [ 5595.410285] Key type .llcrypt registered [ 5596.719502] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 00:35:03 (1769060103) [ 5598.871861] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5599.021778] alg: No test for adler32 (adler32-zlib) [ 5600.217995] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 5600.492223] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5602.167193] Key type lgssc registered [ 5603.572601] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5658.116345] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5661.426629] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5679.870842] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5681.507707] Lustre: Mounted lustre-client [ 5694.854788] LustreError: 123579:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc7e14000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5694.882875] LustreError: 123579:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5694.918199] Lustre: Unmounted lustre-client [ 5722.103557] Key type lgssc unregistered [ 5722.548232] LNet: 123981:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5722.561346] LNetError: 123981:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5722.594362] LNet: Removed LNI 192.168.204.48@tcp [ 5723.452112] Key type .llcrypt unregistered [ 5723.454170] Key type ._llcrypt unregistered [ 5739.510916] Key type ._llcrypt registered [ 5739.516878] Key type .llcrypt registered [ 5740.664323] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 00:37:27 (1769060247) [ 5743.058519] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5743.071381] alg: No test for adler32 (adler32-zlib) [ 5744.141319] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 5744.342431] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5746.007244] Key type lgssc registered [ 5747.388819] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5794.678365] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5797.940485] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5816.343673] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5818.986968] Lustre: Mounted lustre-client [ 5823.976631] Lustre: lustre-OST0000-osc-ffff8eedcba2a800: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5834.128681] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8eedcba2a800.ost_server_uuid 50 [ 5835.776630] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5847.933854] LustreError: 127519:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedcba2a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5847.949808] LustreError: 127519:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5848.008827] Lustre: Unmounted lustre-client [ 5869.425881] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 00:39:36 (1769060376) [ 5898.579070] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5901.324561] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5918.457682] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5939.433156] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5940.015646] Lustre: Mounted lustre-client [ 5945.317936] Lustre: lustre-OST0000-osc-ffff8eedc7e12800: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5971.312939] LustreError: 130174:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc7e12800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5971.338335] LustreError: 130174:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 5971.344318] LustreError: 130174:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5971.408262] Lustre: Unmounted lustre-client [ 6027.772724] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 00:42:14 (1769060534) [ 6059.188322] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6062.278982] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6079.482755] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6095.365203] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6096.008661] Lustre: Mounted lustre-client [ 6100.973184] Lustre: lustre-OST0000-osc-ffff8eedc50b0800: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6116.089270] LustreError: 132942:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc50b0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6116.098624] LustreError: 132942:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 6116.108038] LustreError: 132942:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6116.115983] LustreError: 132942:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6116.181315] Lustre: Unmounted lustre-client [ 6160.345868] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 00:44:27 (1769060667) [ 6244.422709] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6250.825440] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6281.798931] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6359.671306] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6366.039113] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6388.942854] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6421.765486] Lustre: Mounted lustre-client [ 6465.986431] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6467.657851] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6470.144987] LustreError: 139554:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc4294800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6470.165838] LustreError: 139554:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 6470.202044] LustreError: 139554:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6470.211498] LustreError: 139554:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6470.303493] Lustre: Unmounted lustre-client [ 6503.173974] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 00:50:09 (1769061009) [ 6539.516701] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6543.774497] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6566.597470] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6604.090232] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6639.534834] Lustre: Mounted lustre-client [ 6682.733638] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6684.785492] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6697.400757] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6707.698375] LustreError: 143142:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6707.708437] LustreError: 143142:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6707.762482] Lustre: Unmounted lustre-client [ 6761.364667] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 00:54:28 (1769061268) [ 6794.238428] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6798.180697] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6818.298720] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6819.392875] Lustre: Mounted lustre-client [ 6841.566337] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6843.340978] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6858.536059] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8eedc73a4000.ost_server_uuid 50 [ 6860.271323] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8eedc73a4000.ost_server_uuid in IDLE state after 0 sec [ 6863.017303] LustreError: 146574:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc73a4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6863.034441] LustreError: 146574:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6863.037324] LustreError: 146574:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6863.108056] Lustre: Unmounted lustre-client [ 6863.608925] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6863.614841] Lustre: Skipped 3 previous similar messages [ 6863.801851] Lustre: Mounted lustre-client [ 6865.031471] LustreError: 146638:0:(sec.c:410:import_sec_validate_get()) import 0000000082af8d8d (NEW) with no sec [ 6920.340541] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 00:57:07 (1769061427) [ 6947.480768] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6950.529287] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6966.593846] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6981.989862] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6982.516226] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6982.705810] Lustre: Mounted lustre-client [ 6996.613079] LustreError: 149492:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc73a7000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6996.623421] LustreError: 149492:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6996.641360] LustreError: 149492:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6996.645126] LustreError: 149492:0:(obd_class.h:479:obd_check_dev()) Skipped 18 previous similar messages [ 6996.705846] Lustre: Unmounted lustre-client [ 6996.708529] Lustre: Skipped 1 previous similar message [ 7041.807439] Key type lgssc unregistered [ 7042.047333] LNet: 149940:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7042.071235] LNetError: 149940:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7042.097197] LNet: Removed LNI 192.168.204.48@tcp [ 7042.682624] Key type .llcrypt unregistered [ 7042.684763] Key type ._llcrypt unregistered [ 7056.414589] Key type ._llcrypt registered [ 7056.418655] Key type .llcrypt registered [ 7057.575848] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 00:59:24 (1769061564) [ 7058.532740] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7058.614510] alg: No test for adler32 (adler32-zlib) [ 7059.617293] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 7059.829605] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7061.503169] Key type lgssc registered [ 7062.461528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7103.538779] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7106.576687] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7124.655962] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7143.142319] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7143.632507] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7144.763971] Lustre: Mounted lustre-client [ 7152.137376] LustreError: lustre-MDT0001-mdc-ffff8eedd0430800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7152.153378] Lustre: lustre-MDT0001-mdc-ffff8eedd0430800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 7155.468296] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7156.795034] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7173.631246] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7176.093378] LustreError: 154172:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd0430800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7176.099833] LustreError: 154172:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7176.143151] Lustre: Unmounted lustre-client [ 7203.708399] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 01:01:50 (1769061710) [ 7283.878155] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7287.195570] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7303.034734] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7303.494550] Lustre: Mounted lustre-client [ 7321.917342] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7323.412879] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7330.285418] Lustre: lustre-OST0001-osc-ffff8eedcb82e000: Connection to lustre-OST0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7330.706377] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7340.989522] LustreError: 158905:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7340.999367] LustreError: 158905:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 7341.047309] Lustre: Unmounted lustre-client [ 7371.979534] Key type lgssc unregistered [ 7372.150856] LNet: 159309:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7372.157547] LNetError: 159309:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7372.180991] LNet: Removed LNI 192.168.204.48@tcp [ 7372.693266] Key type .llcrypt unregistered [ 7372.695271] Key type ._llcrypt unregistered [ 7397.461152] Key type ._llcrypt registered [ 7397.463251] Key type .llcrypt registered [ 7398.406706] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 01:05:05 (1769061905) [ 7399.939458] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7399.965778] alg: No test for adler32 (adler32-zlib) [ 7400.935485] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 7401.110022] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7402.767714] Key type lgssc registered [ 7403.623023] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7441.184716] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7444.225130] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7458.591351] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7465.473617] Lustre: Mounted lustre-client [ 7508.912950] LustreError: 162574:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca042000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7508.940597] LustreError: 162574:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7508.995479] Lustre: Unmounted lustre-client [ 7540.820846] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7541.433207] Lustre: Mounted lustre-client [ 7577.105340] LustreError: 163231:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc4292800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7577.126806] LustreError: 163231:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7577.131458] LustreError: 163231:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 7577.227837] Lustre: Unmounted lustre-client [ 7602.437956] Key type lgssc unregistered [ 7602.675034] LNet: 163636:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7602.681635] LNetError: 163636:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7602.705813] LNet: Removed LNI 192.168.204.48@tcp [ 7603.297596] Key type .llcrypt unregistered [ 7603.300455] Key type ._llcrypt unregistered [ 7614.679945] Key type ._llcrypt registered [ 7614.682235] Key type .llcrypt registered [ 7615.733111] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 01:08:42 (1769062122) [ 7617.712098] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7617.762032] alg: No test for adler32 (adler32-zlib) [ 7618.802677] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 7619.018150] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7620.663582] Key type lgssc registered [ 7621.559671] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7660.024745] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7662.724928] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7677.015690] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7689.257538] Lustre: Mounted lustre-client [ 7702.933371] LustreError: 166897:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc8de3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7702.948182] LustreError: 166897:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7703.011598] Lustre: Unmounted lustre-client [ 7725.935487] Key type lgssc unregistered [ 7726.172422] LNet: 167297:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7726.175768] LNetError: 167297:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7726.184428] LNet: Removed LNI 192.168.204.48@tcp [ 7726.633328] Key type .llcrypt unregistered [ 7726.635858] Key type ._llcrypt unregistered [ 7734.318282] Key type ._llcrypt registered [ 7734.319955] Key type .llcrypt registered [ 7734.513200] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7734.525132] alg: No test for adler32 (adler32-zlib) [ 7735.513962] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 7735.753095] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7737.391170] Key type lgssc registered [ 7738.269802] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7774.620812] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7777.539403] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7792.955755] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7803.946573] Lustre: Mounted lustre-client [ 7810.112213] LustreError: 169881:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc798f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7810.131172] LustreError: 169881:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7810.179851] Lustre: Unmounted lustre-client [ 7834.436535] Key type lgssc unregistered [ 7834.640217] LNet: 170281:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7834.644483] LNetError: 170281:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7834.659482] LNet: Removed LNI 192.168.204.48@tcp [ 7835.196798] Key type .llcrypt unregistered [ 7835.199084] Key type ._llcrypt unregistered [ 7846.139677] Key type ._llcrypt registered [ 7846.143698] Key type .llcrypt registered [ 7847.179377] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 01:12:34 (1769062354) [ 7849.137301] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7849.146541] alg: No test for adler32 (adler32-zlib) [ 7850.215505] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 7850.409757] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7852.071197] Key type lgssc registered [ 7853.036522] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7897.325414] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7900.548426] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7916.672798] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7923.792321] Lustre: Mounted lustre-client [ 7940.489819] LustreError: 173540:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca046000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7940.507566] LustreError: 173540:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7940.571801] Lustre: Unmounted lustre-client [ 7966.723679] Key type lgssc unregistered [ 7966.949589] LNet: 173943:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7966.966181] LNetError: 173943:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7966.986354] LNet: Removed LNI 192.168.204.48@tcp [ 7967.534632] Key type .llcrypt unregistered [ 7967.536809] Key type ._llcrypt unregistered [ 7977.918808] Key type ._llcrypt registered [ 7977.924433] Key type .llcrypt registered [ 7978.257278] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7978.272796] alg: No test for adler32 (adler32-zlib) [ 7979.247676] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 7979.443479] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7981.095392] Key type lgssc registered [ 7982.293833] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8027.266815] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8031.155893] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8048.837423] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8054.840224] Lustre: Mounted lustre-client [ 8061.399041] LustreError: 176516:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc4294000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8061.425145] LustreError: 176516:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8061.471193] Lustre: Unmounted lustre-client [ 8086.403981] Key type lgssc unregistered [ 8086.692416] LNet: 176919:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8086.719426] LNetError: 176919:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8086.744965] LNet: Removed LNI 192.168.204.48@tcp [ 8087.419606] Key type .llcrypt unregistered [ 8087.423092] Key type ._llcrypt unregistered [ 8100.937698] Key type ._llcrypt registered [ 8100.941114] Key type .llcrypt registered [ 8102.104968] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 01:16:48 (1769062608) [ 8119.951629] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8119.980643] alg: No test for adler32 (adler32-zlib) [ 8121.042146] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 8121.281584] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8123.008995] Key type lgssc registered [ 8124.325232] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8193.029620] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8196.829528] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8213.073427] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8256.680792] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 01:19:23 (1769062763) [ 8280.191278] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8282.940427] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8296.897568] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8299.404788] Lustre: Mounted lustre-client [ 8302.705732] LustreError: 183432:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd012e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8302.722755] LustreError: 183432:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8302.761173] Lustre: Unmounted lustre-client [ 8320.603875] Key type lgssc unregistered [ 8320.824341] LNet: 183832:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8320.830020] LNetError: 183832:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8320.848987] LNet: Removed LNI 192.168.204.48@tcp [ 8321.432869] Key type .llcrypt unregistered [ 8321.435661] Key type ._llcrypt unregistered [ 8333.951482] Key type ._llcrypt registered [ 8333.954745] Key type .llcrypt registered [ 8335.012635] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8336.350573] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 01:20:43 (1769062843) [ 8350.222447] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8350.239500] alg: No test for adler32 (adler32-zlib) [ 8351.244627] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 8351.453420] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8353.119264] Key type lgssc registered [ 8353.995181] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8416.422345] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8418.974419] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8432.270524] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 8444.130592] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 8445.434166] Lustre: Mounted lustre-client [ 8455.619704] LustreError: 189362:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc5ad8800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 8455.636675] LustreError: 189362:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8455.671663] Lustre: Unmounted lustre-client [ 8535.511911] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8537.030572] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8547.915308] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8573.855776] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 01:24:41 (1769063081) [ 8574.628766] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8575.423091] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 01:24:42 (1769063082) [ 8599.552189] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8601.275114] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8629.586605] Key type lgssc unregistered [ 8629.719514] LNet: 195534:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8629.725340] LNetError: 195534:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8629.750457] LNet: Removed LNI 192.168.204.48@tcp [ 8630.092995] Key type .llcrypt unregistered [ 8630.095627] Key type ._llcrypt unregistered [ 8637.278030] Key type ._llcrypt registered [ 8637.279694] Key type .llcrypt registered [ 8637.914314] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 01:25:45 (1769063145) [ 8676.085461] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8676.094524] alg: No test for adler32 (adler32-zlib) [ 8677.027197] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 8677.156619] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8678.767180] Key type lgssc registered [ 8679.459848] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8700.587518] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8702.622209] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8722.237547] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8735.430675] Key type lgssc unregistered [ 8735.565565] LNet: 199164:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8735.570337] LNetError: 199164:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8735.579512] LNet: Removed LNI 192.168.204.48@tcp [ 8735.867289] Key type .llcrypt unregistered [ 8735.868774] Key type ._llcrypt unregistered [ 8744.343452] Key type ._llcrypt registered [ 8744.345395] Key type .llcrypt registered [ 8745.207088] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 01:27:32 (1769063252) [ 8746.667221] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8746.693543] alg: No test for adler32 (adler32-zlib) [ 8747.605095] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 8747.719060] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8749.327170] Key type lgssc registered [ 8749.884166] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8773.585420] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8775.214415] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8784.095345] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8789.492400] Lustre: Mounted lustre-client [ 8794.597446] Lustre: lustre-MDT0000-mdc-ffff8eedca70c800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8799.716963] Lustre: lustre-MDT0001-mdc-ffff8eedca70c800: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8815.071157] Lustre: 200149:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769063307/real 1769063307] req@000000009296e708 x1854997271756544/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1769063323 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8815.083658] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 8815.104615] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xb027425757adb70a to 0xb027425757add06a [ 8815.110819] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 8835.065763] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8835.618728] LustreError: lustre-MDT0000-mdc-ffff8eedca70c800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8835.648241] Lustre: lustre-MDT0000-mdc-ffff8eedca70c800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 8836.908489] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 1 sec [ 8838.557750] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8839.292242] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8840.197674] LustreError: 203577:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca70c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8840.213143] LustreError: 203577:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8840.243517] Lustre: Unmounted lustre-client [ 8858.838325] Key type lgssc unregistered [ 8858.968368] LNet: 203978:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8858.972811] LNetError: 203978:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8858.985332] LNet: Removed LNI 192.168.204.48@tcp [ 8859.284278] Key type .llcrypt unregistered [ 8859.285665] Key type ._llcrypt unregistered [ 8865.601779] Key type ._llcrypt registered [ 8865.603161] Key type .llcrypt registered [ 8866.171812] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 01:29:33 (1769063373) [ 8867.217669] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8867.248085] alg: No test for adler32 (adler32-zlib) [ 8868.144564] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 8868.261325] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8869.863203] Key type lgssc registered [ 8870.386673] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8890.962170] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8892.537202] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8917.628859] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8919.463738] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8931.331260] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8940.425871] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 8963.726291] Key type lgssc unregistered [ 8963.866635] LNet: 209088:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8963.872471] LNetError: 209088:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8963.887487] LNet: Removed LNI 192.168.204.48@tcp [ 8964.157712] Key type .llcrypt unregistered [ 8964.160384] Key type ._llcrypt unregistered [ 8988.331740] Key type ._llcrypt registered [ 8988.333104] Key type .llcrypt registered [ 8988.971072] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 01:31:36 (1769063496) [ 9008.486424] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9008.498533] alg: No test for adler32 (adler32-zlib) [ 9009.436521] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9009.558085] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9011.159657] Key type lgssc registered [ 9011.743034] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9054.431728] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9056.475549] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9069.661264] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9097.227563] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 01:33:24 (1769063604) [ 9101.255816] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 01:33:28 (1769063608) [ 9114.131258] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9115.738365] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9123.805645] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9130.537662] Lustre: Mounted lustre-client [ 9134.237923] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9135.269484] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9135.976431] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9136.712491] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9140.708616] Lustre: lustre-MDT0000-mdc-ffff8eedc6ad2000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9156.064803] Lustre: 210976:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769063648/real 1769063648] req@0000000038497eb9 x1854997546411264/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1769063664 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9156.071833] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 9156.099532] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xc944de0b89519b2b to 0xc944de0b89519da1 [ 9156.105701] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 9156.977640] Lustre: lustre-MDT0000-mdc-ffff8eedc6ad2000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 9158.935580] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9159.816151] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9162.077759] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9166.310325] Lustre: lustre-MDT0000-mdc-ffff8eedc6ad2000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9180.639207] Lustre: 216774:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769063672/real 1769063672] req@00000000af85d5f7 x1854997546416384/t0(0) o101->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 328/344 e 0 to 1 dl 1769063688 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9180.656789] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 9180.664723] Lustre: 216774:0:(mgc_request.c:1911:mgc_process_log()) MGC192.168.204.148@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 9180.675163] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xc944de0b89519da1 to 0xc944de0b8951a095 [ 9180.685944] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 9183.086251] Lustre: lustre-MDT0000-mdc-ffff8eedc6ad2000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 9184.671572] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9185.411033] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9187.382747] LustreError: 219214:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc6ad2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9187.397869] LustreError: 219214:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9187.424551] Lustre: Unmounted lustre-client [ 9226.688815] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9228.340584] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9236.260463] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9246.739941] Lustre: Mounted lustre-client [ 9247.242628] LustreError: 220827:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07c3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9247.249912] LustreError: 220827:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9247.252342] LustreError: 220827:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9247.281474] Lustre: Unmounted lustre-client [ 9265.653944] Key type lgssc unregistered [ 9265.776567] LNet: 221230:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9265.779719] LNetError: 221230:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9265.792074] LNet: Removed LNI 192.168.204.48@tcp [ 9266.060778] Key type .llcrypt unregistered [ 9266.062361] Key type ._llcrypt unregistered [ 9272.024824] Key type ._llcrypt registered [ 9272.026262] Key type .llcrypt registered [ 9272.569574] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 01:36:20 (1769063780) [ 9274.342814] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9274.424747] alg: No test for adler32 (adler32-zlib) [ 9275.308996] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9275.410182] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9276.999226] Key type lgssc registered [ 9277.467410] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9297.995445] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9299.738806] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9307.528157] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9313.778987] Lustre: Mounted lustre-client [ 9316.926397] LustreError: 224397:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07fd000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9316.939615] LustreError: 224397:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9316.968165] Lustre: Unmounted lustre-client [ 9350.066595] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9351.629371] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9359.128584] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9369.599156] Lustre: Mounted lustre-client [ 9375.786576] LustreError: 225991:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca4c4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9375.794464] LustreError: 225991:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9375.796705] LustreError: 225991:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9375.822505] Lustre: Unmounted lustre-client [ 9411.414430] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9413.001636] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9420.890362] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9431.548385] Lustre: Mounted lustre-client [ 9431.937666] LustreError: 227605:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc856b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9431.951643] LustreError: 227605:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9431.955306] LustreError: 227605:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9431.985434] Lustre: Unmounted lustre-client [ 9458.577278] Key type lgssc unregistered [ 9458.699528] LNet: 228009:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9458.702862] LNetError: 228009:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9458.715158] LNet: Removed LNI 192.168.204.48@tcp [ 9459.015051] Key type .llcrypt unregistered [ 9459.016824] Key type ._llcrypt unregistered [ 9464.659483] Key type ._llcrypt registered [ 9464.660770] Key type .llcrypt registered [ 9465.167254] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 01:39:32 (1769063972) [ 9466.324380] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9466.333896] alg: No test for adler32 (adler32-zlib) [ 9467.202588] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9467.290966] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9468.879175] Key type lgssc registered [ 9469.250718] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9486.386524] Key type lgssc unregistered [ 9486.531616] LNet: 230319:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9486.535559] LNetError: 230319:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9486.544600] LNet: Removed LNI 192.168.204.48@tcp [ 9486.809056] Key type .llcrypt unregistered [ 9486.810518] Key type ._llcrypt unregistered [ 9497.870204] Key type ._llcrypt registered [ 9497.871781] Key type .llcrypt registered [ 9498.072143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9498.080118] alg: No test for adler32 (adler32-zlib) [ 9498.964938] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9499.058975] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9500.647258] Key type lgssc registered [ 9501.078548] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9532.003165] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9533.406811] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9541.927934] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9560.943642] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 9561.534872] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 01:41:09 (1769064069) [ 9572.635473] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9573.890966] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9580.603529] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9588.680654] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 9589.955769] Lustre: Mounted lustre-client [ 9595.366376] Lustre: lustre-OST0001-osc-ffff8eedc688d800: Connection to lustre-OST0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9597.743682] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9608.039527] LustreError: 236797:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9608.056437] Lustre: Unmounted lustre-client [ 9631.815177] Key type lgssc unregistered [ 9631.960629] LNet: 237201:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9631.966096] LNetError: 237201:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9631.973808] LNet: Removed LNI 192.168.204.48@tcp [ 9632.218771] Key type .llcrypt unregistered [ 9632.220088] Key type ._llcrypt unregistered [ 9643.498052] Key type ._llcrypt registered [ 9643.499270] Key type .llcrypt registered [ 9643.997607] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 01:42:31 (1769064151) [ 9648.844889] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9648.912922] alg: No test for adler32 (adler32-zlib) [ 9649.782147] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9649.868763] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9651.455152] Key type lgssc registered [ 9651.850407] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9669.607098] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9670.737080] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9690.585695] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 01:43:18 (1769064198) [ 9700.222527] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9701.435586] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9707.401445] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9708.579714] Lustre: Mounted lustre-client [ 9714.541893] LustreError: 242191:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07fc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9714.547771] LustreError: 242191:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9714.566724] Lustre: Unmounted lustre-client [ 9763.547708] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9764.698123] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9800.646545] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9811.445430] Lustre: Mounted lustre-client [ 9811.908051] LustreError: 244278:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedca046800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9811.919303] LustreError: 244278:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9811.921097] LustreError: 244278:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9811.945115] Lustre: Unmounted lustre-client [ 9821.443271] Key type lgssc unregistered [ 9821.565627] LNet: 244679:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9821.568614] LNetError: 244679:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9821.581752] LNet: Removed LNI 192.168.204.48@tcp [ 9821.818173] Key type .llcrypt unregistered [ 9821.819340] Key type ._llcrypt unregistered [ 9831.277357] Key type ._llcrypt registered [ 9831.279129] Key type .llcrypt registered [ 9831.462023] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9831.474318] alg: No test for adler32 (adler32-zlib) [ 9832.335264] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9832.421810] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9834.000270] Key type lgssc registered [ 9834.421188] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9862.974633] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9864.091430] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9871.393152] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9888.595410] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 9889.252405] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 01:46:36 (1769064396) [ 9900.100738] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9901.406928] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9907.867551] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9919.471285] Lustre: Mounted lustre-client [ 9920.308389] LustreError: 250711:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07fa000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9920.315873] LustreError: 250711:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9920.336237] Lustre: Unmounted lustre-client [ 9945.817832] Key type lgssc unregistered [ 9945.929598] LNet: 251114:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9945.932316] LNetError: 251114:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9945.940703] LNet: Removed LNI 192.168.204.48@tcp [ 9946.161670] Key type .llcrypt unregistered [ 9946.162895] Key type ._llcrypt unregistered [ 9951.031965] Key type ._llcrypt registered [ 9951.033379] Key type .llcrypt registered [ 9951.490626] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 9952.003473] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 01:47:39 (1769064459) [ 9954.923313] Key type .llcrypt unregistered [ 9954.924512] Key type ._llcrypt unregistered [ 9957.481801] Key type ._llcrypt registered [ 9957.483143] Key type .llcrypt registered [ 9957.629908] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9957.635936] alg: No test for adler32 (adler32-zlib) [ 9958.490982] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [ 9958.572966] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9960.159126] Key type lgssc registered [ 9960.553312] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9978.681243] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9984.195081] Lustre: Mounted lustre-client [ 9984.664083] LustreError: 254116:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc7e11000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9984.671409] LustreError: 254116:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9984.693117] Lustre: Unmounted lustre-client [10002.064894] Key type lgssc unregistered [10002.186614] LNet: 254518:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10002.189229] LNetError: 254518:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10002.203902] LNet: Removed LNI 192.168.204.48@tcp [10002.440931] Key type .llcrypt unregistered [10002.442511] Key type ._llcrypt unregistered [10007.576202] Key type ._llcrypt registered [10007.577396] Key type .llcrypt registered [10008.041281] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 01:48:35 (1769064515) [10008.835874] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10008.881798] alg: No test for adler32 (adler32-zlib) [10009.736703] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [10009.814373] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10011.391166] Key type lgssc registered [10011.793179] Lustre: Echo OBD driver; http://www.lustre.org/ [10071.459433] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10080.848486] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10082.024631] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10083.167958] Lustre: Mounted lustre-client [10083.561911] LustreError: 257554:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc3fa0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10083.567574] LustreError: 257554:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10083.585143] Lustre: Unmounted lustre-client [10100.568233] Key type lgssc unregistered [10100.681535] LNet: 257956:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10100.683660] LNetError: 257956:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10100.693678] LNet: Removed LNI 192.168.204.48@tcp [10100.915773] Key type .llcrypt unregistered [10100.916871] Key type ._llcrypt unregistered [10105.800731] Key type ._llcrypt registered [10105.802215] Key type .llcrypt registered [10106.238672] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 01:50:13 (1769064613) [10107.012443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10107.017947] alg: No test for adler32 (adler32-zlib) [10107.868806] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [10107.951414] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10109.535134] Key type lgssc registered [10109.889594] Lustre: Echo OBD driver; http://www.lustre.org/ [10126.312973] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10127.456994] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10133.260497] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10134.438716] Lustre: Mounted lustre-client [10139.618030] Lustre: lustre-MDT0000-mdc-ffff8eedc6ee1000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10141.815403] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10141.823615] LustreError: 261015:0:(file.c:6147:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10141.914247] LustreError: 261034:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc6ee1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10141.915073] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [10141.920120] LustreError: 261034:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10141.936723] Lustre: Unmounted lustre-client [10152.464619] Key type lgssc unregistered [10152.576316] LNet: 261427:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10152.579103] LNetError: 261427:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10152.589279] LNet: Removed LNI 192.168.204.48@tcp [10152.800054] Key type .llcrypt unregistered [10152.800917] Key type ._llcrypt unregistered [10157.890346] Key type ._llcrypt registered [10157.891361] Key type .llcrypt registered [10158.350249] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 01:51:05 (1769064665) [10159.114300] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10159.121805] alg: No test for adler32 (adler32-zlib) [10159.967648] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [10160.043020] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10161.623149] Key type lgssc registered [10161.983148] Lustre: Echo OBD driver; http://www.lustre.org/ [10179.330568] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10180.538483] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10186.597590] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10196.977116] Lustre: Mounted lustre-client [10202.082765] Lustre: lustre-MDT0001-mdc-ffff8eedcb82a000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10204.689689] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10204.995150] LustreError: 264513:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedcb82a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10205.002883] LustreError: 264513:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10205.020152] Lustre: Unmounted lustre-client [10215.638068] Key type lgssc unregistered [10215.750509] LNet: 264906:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10215.753525] LNetError: 264906:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10215.762684] LNet: Removed LNI 192.168.204.48@tcp [10215.973693] Key type .llcrypt unregistered [10215.975061] Key type ._llcrypt unregistered [10221.218278] Key type ._llcrypt registered [10221.219824] Key type .llcrypt registered [10221.686812] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 01:52:09 (1769064729) [10227.888991] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10227.902250] alg: No test for adler32 (adler32-zlib) [10228.768200] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [10228.857752] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10230.439144] Key type lgssc registered [10230.831348] Lustre: Echo OBD driver; http://www.lustre.org/ [10266.811817] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10267.964162] Lustre: Mounted lustre-client [10285.539632] Lustre: lustre-MDT0001-mdc-ffff8eedd07c5000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10288.603746] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10298.857136] LustreError: 270236:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [10298.875506] Lustre: Unmounted lustre-client [10315.855839] Key type lgssc unregistered [10315.966555] LNet: 270635:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10315.969108] LNetError: 270635:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10315.977301] LNet: Removed LNI 192.168.204.48@tcp [10316.187506] Key type .llcrypt unregistered [10316.188695] Key type ._llcrypt unregistered [10321.102079] Key type ._llcrypt registered [10321.103109] Key type .llcrypt registered [10321.557736] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 01:53:49 (1769064829) [10322.087442] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10322.706385] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 01:53:50 (1769064830) [10323.223078] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10323.740154] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 01:53:51 (1769064831) [10324.246491] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10324.773920] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 01:53:52 (1769064832) [10325.256080] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10325.801290] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 01:53:53 (1769064833) [10326.328274] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10326.931730] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 01:53:54 (1769064834) [10329.970287] Key type .llcrypt unregistered [10329.971415] Key type ._llcrypt unregistered [10332.525100] Key type ._llcrypt registered [10332.531516] Key type .llcrypt registered [10332.736996] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10332.746134] alg: No test for adler32 (adler32-zlib) [10333.609278] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [10333.701754] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10335.287163] Key type lgssc registered [10335.712073] Lustre: Echo OBD driver; http://www.lustre.org/ [10361.133455] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10362.473747] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10369.649846] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10370.837436] Lustre: Mounted lustre-client [10371.252858] LustreError: 276213:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc3fa4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10371.261897] LustreError: 276213:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10371.286150] Lustre: Unmounted lustre-client [10394.662485] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 01:55:02 (1769064902) [10404.617000] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10405.710883] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10422.222823] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10422.374460] Lustre: Mounted lustre-client [10422.659886] LustreError: 278321:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedd07c1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10422.666337] LustreError: 278321:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10422.668145] LustreError: 278321:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [10422.683611] Lustre: Unmounted lustre-client [10451.738722] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 01:55:59 (1769064959) [10482.207388] LNet: 1 local NIs in recovery (showing 1): 192.168.204.48@tcp [11039.043757] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11040.299374] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11057.563691] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11097.549030] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 02:06:45 (1769065605) [11101.221501] Key type lgssc unregistered [11101.333544] LNet: 283858:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11101.336462] LNetError: 283858:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11101.345789] LNet: Removed LNI 192.168.204.48@tcp [11101.562324] Key type .llcrypt unregistered [11101.563627] Key type ._llcrypt unregistered [11183.854761] Key type ._llcrypt registered [11183.856274] Key type .llcrypt registered [11184.013960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11184.018606] alg: No test for adler32 (adler32-zlib) [11184.858523] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [11184.933683] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11186.511159] Key type lgssc registered [11186.863808] Lustre: Echo OBD driver; http://www.lustre.org/ [11216.466153] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11217.652383] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11224.690432] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11243.332944] Key type lgssc unregistered [11243.452401] LNet: 287440:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11243.454853] LNetError: 287440:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11243.464334] LNet: Removed LNI 192.168.204.48@tcp [11243.690726] Key type .llcrypt unregistered [11243.692242] Key type ._llcrypt unregistered [11262.530672] Key type ._llcrypt registered [11262.531910] Key type .llcrypt registered [11262.984298] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 02:09:30 (1769065770) [11270.008692] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11270.032334] alg: No test for adler32 (adler32-zlib) [11270.897369] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [11270.999730] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11272.599194] Key type lgssc registered [11273.000566] Lustre: Echo OBD driver; http://www.lustre.org/ [11290.512624] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 02:09:58 (1769065798) [11294.451392] Key type lgssc unregistered [11294.564423] LNet: 290980:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11294.566620] LNetError: 290980:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11294.575477] LNet: Removed LNI 192.168.204.48@tcp [11294.788726] Key type .llcrypt unregistered [11294.789915] Key type ._llcrypt unregistered [11298.209601] Key type ._llcrypt registered [11298.211821] Key type .llcrypt registered [11298.444764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11298.449302] alg: No test for adler32 (adler32-zlib) [11299.293432] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [11299.376206] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11300.959150] Key type lgssc registered [11301.303895] Lustre: Echo OBD driver; http://www.lustre.org/ [11320.876859] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11322.035804] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11328.989661] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11405.476120] LNet: Added LNI 192.168.204.48@tcp50 [8/256/0/180] [11406.163636] LNet: Removed LNI 192.168.204.48@tcp [11407.529402] Lustre: 295241:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8eedcba2f800: config has no valid NIDs, force dynamic NIDs [11408.570563] Lustre: Mounted lustre-client [11408.596928] LustreError: 295256:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedcba2f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11408.602598] LustreError: 295256:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11408.620105] Lustre: Unmounted lustre-client [11409.466048] Key type lgssc unregistered [11409.605152] LNet: 295505:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11409.608422] LNetError: 295505:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11409.617516] LNet: Removed LNI 192.168.204.48@tcp50 [11409.808918] Key type .llcrypt unregistered [11409.809804] Key type ._llcrypt unregistered [11419.424539] Key type ._llcrypt registered [11419.426045] Key type .llcrypt registered [11419.581332] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11419.586955] alg: No test for adler32 (adler32-zlib) [11420.427931] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [11420.500049] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11422.079129] Key type lgssc registered [11422.436689] Lustre: Echo OBD driver; http://www.lustre.org/ [11435.393303] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11436.545224] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11438.817896] LNet: Added LNI 192.168.204.48@tcp50 [8/256/0/180] [11439.055524] LNet: Removed LNI 192.168.204.48@tcp [11440.107250] Lustre: 298125:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8eedc6ee5000: config has no valid NIDs, force dynamic NIDs [11441.151315] Lustre: Mounted lustre-client [11441.278223] LustreError: 298160:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc6ee5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11441.284312] LustreError: 298160:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11441.303122] Lustre: Unmounted lustre-client [11459.726522] Key type lgssc unregistered [11459.854475] LNet: 298999:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11459.857517] LNetError: 298999:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11459.868394] LNet: Removed LNI 192.168.204.48@tcp50 [11460.050322] Key type .llcrypt unregistered [11460.051808] Key type ._llcrypt unregistered [11463.269913] Key type ._llcrypt registered [11463.271335] Key type .llcrypt registered [11463.698447] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 02:12:51 (1769065971) [11464.544310] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11464.557928] alg: No test for adler32 (adler32-zlib) [11465.416629] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [11465.498898] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11467.079162] Key type lgssc registered [11467.440873] Lustre: Echo OBD driver; http://www.lustre.org/ [11483.703927] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11484.813711] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11490.497631] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11491.654888] Lustre: Mounted lustre-client [11510.813278] Lustre: Mounted fs15246-client [11515.136061] LustreError: 303120:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffff8eedc8133000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11515.141639] LustreError: 303120:0:(obd_class.h:479:obd_check_dev()) Device 8 not setup [11515.152159] Lustre: Unmounted fs15246-client [11527.357066] LustreError: 303337:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff8eedc688d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11527.362310] LustreError: 303337:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11527.364682] LustreError: 303337:0:(obd_class.h:479:obd_check_dev()) Skipped 3 previous similar messages [11527.385642] Lustre: Unmounted lustre-client [11544.067119] Key type lgssc unregistered [11544.172375] LNet: 303739:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11544.174427] LNetError: 303739:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11544.183472] LNet: Removed LNI 192.168.204.48@tcp [11544.381829] Key type .llcrypt unregistered [11544.382822] Key type ._llcrypt unregistered [11547.485653] Key type ._llcrypt registered [11547.486788] Key type .llcrypt registered [11547.900906] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 02:14:15 (1769066055) [11548.401075] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11548.408491] alg: No test for adler32 (adler32-zlib) [11549.264083] Lustre: Lustre: Build Version: 2.17.50_63_ge38b609 [11549.344565] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11550.927151] Key type lgssc registered [11551.266588] Lustre: Echo OBD driver; http://www.lustre.org/ [11593.969097] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11595.210719] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11602.625533] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11650.612636] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11348 sec ========= 02:15:58 (1769066158) [11651.169206] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 02:15:58 (1769066158) === [11652.268627] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 02:15:59 (1769066159) === [11663.833579] Key type lgssc unregistered [11663.948476] LNet: 312877:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11663.952515] LNetError: 312877:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11663.962416] LNet: Removed LNI 192.168.204.48@tcp [11664.235483] Key type .llcrypt unregistered [11664.236919] Key type ._llcrypt unregistered