[ 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 627482489 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.002502] x2apic enabled [ 0.003010] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.008528] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010014] pid_max: default: 32768 minimum: 301 [ 0.012043] LSM: Security Framework initializing [ 0.013186] Yama: becoming mindful. [ 0.014029] SELinux: Initializing. [ 0.015072] *** VALIDATE selinux *** [ 0.025400] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.031210] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.032174] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.034000] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.035048] *** VALIDATE tmpfs *** [ 0.038156] *** VALIDATE proc *** [ 0.039315] *** VALIDATE cgroup *** [ 0.040008] *** VALIDATE cgroup2 *** [ 0.042185] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.043141] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.044007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.045021] Spectre V2 : User space: Vulnerable [ 0.046009] Speculative Store Bypass: Vulnerable [ 0.050149] debug: unmapping init [mem 0xffffffff9cc59000-0xffffffff9cc60fff] [ 0.052284] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.053570] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.054035] ... version: 2 [ 0.055026] ... bit width: 48 [ 0.056018] ... generic registers: 4 [ 0.057018] ... value mask: 0000ffffffffffff [ 0.058013] ... max period: 00007fffffffffff [ 0.059014] ... fixed-purpose events: 3 [ 0.060011] ... event mask: 000000070000000f [ 0.061351] rcu: Hierarchical SRCU implementation. [ 0.064716] smp: Bringing up secondary CPUs ... [ 0.065984] x86: Booting SMP configuration: [ 0.066029] .... node #0, CPUs: #1 #2 #3 [ 0.071063] smp: Brought up 1 node, 4 CPUs [ 0.073112] smpboot: Max logical packages: 1 [ 0.074012] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.114071] node 0 deferred pages initialised in 38ms [ 0.119131] devtmpfs: initialized [ 0.120285] x86/mm: Memory block size: 128MB [ 0.123181] gcov: version magic: 0x41383552 [ 0.125642] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.126192] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.127330] pinctrl core: initialized pinctrl subsystem [ 0.128197] [ 0.129009] ************************************************************* [ 0.130013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.131016] ** ** [ 0.132015] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.133014] ** ** [ 0.134014] ** This means that this kernel is built to expose internal ** [ 0.135146] ** IOMMU data structures, which may compromise security on ** [ 0.136027] ** your system. ** [ 0.137013] ** ** [ 0.138014] ** If you see this message and you are not debugging the ** [ 0.139142] ** kernel, report this immediately to your vendor! ** [ 0.141000] ** ** [ 0.141084] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.142016] ************************************************************* [ 0.144609] NET: Registered protocol family 16 [ 0.145820] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.146063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.147066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.149066] cpuidle: using governor menu [ 0.152430] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.157940] PCI: Using configuration type 1 for base access [ 0.162137] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.174106] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.178019] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.184035] cryptd: max_cpu_qlen set to 1000 [ 0.187249] ACPI: Added _OSI(Module Device) [ 0.190042] ACPI: Added _OSI(Processor Device) [ 0.193022] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.196825] ACPI: Added _OSI(Processor Aggregator Device) [ 0.206402] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.215638] ACPI: Interpreter enabled [ 0.216090] ACPI: PM: (supports S0 S3 S4 S5) [ 0.217013] ACPI: Using IOAPIC for interrupt routing [ 0.218137] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.219753] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.233009] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.235045] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.238018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.240202] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.245564] acpiphp: Slot [2] registered [ 0.247162] acpiphp: Slot [5] registered [ 0.248151] acpiphp: Slot [6] registered [ 0.249116] acpiphp: Slot [3] registered [ 0.251122] acpiphp: Slot [4] registered [ 0.253089] acpiphp: Slot [7] registered [ 0.254131] acpiphp: Slot [8] registered [ 0.256669] acpiphp: Slot [9] registered [ 0.258642] acpiphp: Slot [10] registered [ 0.261198] acpiphp: Slot [11] registered [ 0.263477] acpiphp: Slot [12] registered [ 0.264279] acpiphp: Slot [13] registered [ 0.267140] acpiphp: Slot [14] registered [ 0.269170] acpiphp: Slot [15] registered [ 0.271175] acpiphp: Slot [16] registered [ 0.274191] acpiphp: Slot [17] registered [ 0.276104] acpiphp: Slot [18] registered [ 0.278261] acpiphp: Slot [19] registered [ 0.281145] acpiphp: Slot [20] registered [ 0.282185] acpiphp: Slot [21] registered [ 0.284114] acpiphp: Slot [22] registered [ 0.285210] acpiphp: Slot [23] registered [ 0.287106] acpiphp: Slot [24] registered [ 0.288092] acpiphp: Slot [25] registered [ 0.290288] acpiphp: Slot [26] registered [ 0.292113] acpiphp: Slot [27] registered [ 0.294247] acpiphp: Slot [28] registered [ 0.296173] acpiphp: Slot [29] registered [ 0.298155] acpiphp: Slot [30] registered [ 0.300174] acpiphp: Slot [31] registered [ 0.302079] PCI host bridge to bus 0000:00 [ 0.305023] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.309053] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.313032] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.320022] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.324022] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.329052] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.332205] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.390846] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.395636] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.406012] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.411046] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.414026] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.417020] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.421031] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.424577] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.427781] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.431045] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.434882] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.439012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.450012] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.455011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.463174] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.474014] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.483013] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.506015] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.523945] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.534013] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.550031] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.574015] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.623762] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.642621] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.647500] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.661000] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.672310] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.683099] iommu: Default domain type: Passthrough [ 0.687389] SCSI subsystem initialized [ 0.689135] ACPI: bus type USB registered [ 0.691107] usbcore: registered new interface driver usbfs [ 0.695082] usbcore: registered new interface driver hub [ 0.700083] usbcore: registered new device driver usb [ 0.706509] pps_core: LinuxPPS API ver. 1 registered [ 0.709013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.716073] PTP clock support registered [ 0.719452] EDAC MC: Ver: 3.0.0 [ 0.723194] PCI: Using ACPI for IRQ routing [ 0.726113] NetLabel: Initializing [ 0.730012] NetLabel: domain hash size = 128 [ 0.732010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.734124] NetLabel: unlabeled traffic allowed by default [ 0.737516] vgaarb: loaded [ 0.739035] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.740009] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.747159] clocksource: Switched to clocksource kvm-clock [ 0.949155] VFS: Disk quotas dquot_6.6.0 [ 0.957834] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.966559] *** VALIDATE ramfs *** [ 0.972430] *** VALIDATE hugetlbfs *** [ 0.978352] pnp: PnP ACPI init [ 0.991348] pnp: PnP ACPI: found 6 devices [ 1.174654] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 1.178751] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.181430] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.184203] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.188024] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.192680] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 1.197943] NET: Registered protocol family 2 [ 1.207390] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 1.227423] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 1.247857] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 1.286437] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 1.354846] TCP: Hash tables configured (established 65536 bind 65536) [ 1.371864] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 1.389331] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.522312] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.540077] NET: Registered protocol family 1 [ 1.613830] RPC: Registered named UNIX socket transport module. [ 1.616054] RPC: Registered udp transport module. [ 1.617772] RPC: Registered tcp transport module. [ 1.619459] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.621632] NET: Registered protocol family 44 [ 1.623266] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.625376] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.627388] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.629646] PCI: CLS 0 bytes, default 64 [ 1.631979] Unpacking initramfs... [ 5.328330] debug: unmapping init [mem 0xffff9f87bcc64000-0xffff9f87bffcffff] [ 5.345602] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 5.355133] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 5.373316] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 7.103472] Initialise system trusted keyrings [ 7.116272] Key type blacklist registered [ 7.191752] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 7.296223] zbud: loaded [ 7.299530] *** VALIDATE nfs *** [ 7.300833] *** VALIDATE nfs4 *** [ 7.304218] pstore: using deflate compression [ 7.402809] Platform Keyring initialized [ 7.549062] NET: Registered protocol family 38 [ 7.550233] Key type asymmetric registered [ 7.551478] Asymmetric key parser 'x509' registered [ 7.552639] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 7.554487] io scheduler mq-deadline registered [ 7.555403] io scheduler kyber registered [ 7.558365] io scheduler bfq registered [ 7.560488] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 7.564560] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 7.568825] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 7.572777] ACPI: Power Button [PWRF] [ 7.578881] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 7.589743] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 7.598308] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 7.625891] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 7.656022] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 7.663213] Non-volatile memory driver v1.3 [ 7.665870] Linux agpgart interface v0.103 [ 7.720956] virtio_blk virtio1: [vda] 134696 512-byte logical blocks (69.0 MB/65.8 MiB) [ 7.724220] vda: detected capacity change from 0 to 68964352 [ 7.744311] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 7.747442] vdb: detected capacity change from 0 to 1073741824 [ 7.757795] libphy: Fixed MDIO Bus: probed [ 7.767314] usbcore: registered new interface driver usbserial_generic [ 7.769963] usbserial: USB Serial support registered for generic [ 7.772389] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 7.778173] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 7.780173] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 7.782954] mousedev: PS/2 mouse device common for all mice [ 7.787952] rtc_cmos 00:05: RTC can wake from S4 [ 7.811273] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 7.821281] rtc_cmos 00:05: registered as rtc0 [ 7.832321] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 7.837196] intel_pstate: CPU model not supported [ 7.853255] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 7.855377] hid: raw HID events driver (C) Jiri Kosina [ 7.927770] usbcore: registered new interface driver usbhid [ 8.159596] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 8.161124] usbhid: USB HID core driver [ 8.171306] drop_monitor: Initializing network drop monitor service [ 8.174618] Initializing XFRM netlink socket [ 8.177461] NET: Registered protocol family 10 [ 8.183706] Segment Routing with IPv6 [ 8.187891] NET: Registered protocol family 17 [ 8.214940] mpls_gso: MPLS GSO support [ 8.223154] RAS: Correctable Errors collector initialized. [ 8.225823] AVX version of gcm_enc/dec engaged. [ 8.227503] AES CTR mode by8 optimization enabled [ 8.342755] sched_clock: Marking stable (8342594167, 0)->(9750861490, -1408267323) [ 8.349316] registered taskstats version 1 [ 8.353828] Loading compiled-in X.509 certificates [ 8.356785] zswap: loaded using pool lzo/zbud [ 8.391962] Key type big_key registered [ 8.415451] Key type encrypted registered [ 8.417257] ima: No TPM chip found, activating TPM-bypass! [ 8.419439] ima: Allocated hash algorithm: sha1 [ 8.421229] ima: No architecture policies found [ 8.423810] evm: Initialising EVM extended attributes: [ 8.425495] evm: security.selinux [ 8.426976] evm: security.ima [ 8.428216] evm: security.capability [ 8.429771] evm: HMAC attrs: 0x1 [ 8.432432] rtc_cmos 00:05: setting system clock to 2026-03-02 16:35:28 UTC (1772469328) [ 8.439538] debug: unmapping init [mem 0xffffffff9dc03000-0xffffffff9ddfffff] [ 8.443204] debug: unmapping init [mem 0xffffffff9c982000-0xffffffff9cc58fff] [ 8.452173] Write protecting the kernel read-only data: 28672k [ 8.456557] debug: unmapping init [mem 0xffffffff9b003000-0xffffffff9b1fffff] [ 8.460317] debug: unmapping init [mem 0xffffffff9b914000-0xffffffff9b9fffff] [ 8.504613] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 8.516080] systemd[1]: Detected virtualization kvm. [ 8.519407] systemd[1]: Detected architecture x86-64. [ 8.521960] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 8.553376] systemd[1]: No hostname configured. [ 8.555929] systemd[1]: Set hostname to . [ 8.558469] random: systemd: uninitialized urandom read (16 bytes read) [ 8.561764] systemd[1]: Initializing machine ID from random generator. [ 8.839119] random: ln: uninitialized urandom read (6 bytes read) [ 9.092438] random: systemd: uninitialized urandom read (16 bytes read) [ 9.094700] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 9.104581] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 9.112586] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. [ OK ] Reached target Sockets. Starting Journal Service... Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Swap. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 11.565498] device-mapper: uevent: version 1.0.3 [ 11.575469] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ 14.050029] random: fast init done [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 15.032810] virtio_net virtio0 ens2: renamed from eth0 [ 17.724398] scsi host0: ata_piix [ 17.781387] scsi host1: ata_piix [ 18.811982] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 18.822548] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 21.968525] random: crng init done [ 21.993253] random: 7 urandom warning(s) missed due to ratelimiting [ 26.213357] dracut-initqueue[591]: RTNETLINK answers: File exists [ 26.838378] hrtimer: interrupt took 6303730 ns 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. [ 27.973305] 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 31.780904] printk: systemd: 26 output lines suppressed due to ratelimiting [ 33.159948] SELinux: Disabled at runtime. [ 33.434903] 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) [ 33.441441] systemd[1]: Detected virtualization kvm. [ 33.444228] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 36.106373] systemd[1]: initrd-switch-root.service: Succeeded. [ 36.111402] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 36.121660] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 36.131266] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 36.139288] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 36.151834] systemd[1]: Starting Journal Service... Starting Journal Service... [ 36.163140] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting POSIX Message Queue File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on Process Core Dump Socket. Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Apply Kernel Variables... [ OK ] Started Forward Password Requests to Wall Directory Watch. Starting udev Coldplug all Devices... Activating swap /dev/disk/by-label/SWAP... [ 36.712480] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. Mounting Huge Pages File System... [ OK ] Stopped target Initrd Root File System. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Kernel Debug File System... [ OK ] Reached target RPC Port Mapper. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started 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. [ 38.680608] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 40.075976] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 40.117565] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 41.020722] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 41.157086] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit) [ *** ] 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)[ 47.494818] Key type dns_resolver registered [ **] A start job is running for Configur…only root support (11s / no limit)[ 48.621139] NFS: Registering the id_resolver key type [ 48.624320] Key type id_resolver registered [ 48.630176] 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) [ ***] A start job is running for Configur…only root support (13s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg336-client login: [ 105.117088] libcfs: loading out-of-tree module taints kernel. [ 105.260127] Key type ._llcrypt registered [ 105.263353] Key type .llcrypt registered [ 105.797236] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 105.810642] alg: No test for adler32 (adler32-zlib) [ 107.094382] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 107.610666] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 109.279175] Key type lgssc registered [ 110.613447] Lustre: Echo OBD driver; http://www.lustre.org/ [ 277.433667] Lustre: Mounted lustre-client [ 283.277294] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 301.654378] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing check_logdir /tmp/testlogs/ [ 303.071141] Lustre: lustre-OST0000-osc-ffff9f8808939800: disconnect after 23s idle [ 305.931396] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing yml_node [ 310.194676] Lustre: DEBUG MARKER: Client: 2.17.50.195 [ 313.034424] Lustre: DEBUG MARKER: MDS: 2.17.50.195 [ 315.732905] Lustre: DEBUG MARKER: OSS: 2.17.50.195 [ 318.004675] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Mar 2 11:40:36 EST 2026 [ 339.379728] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 341.017720] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 343.682382] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 354.073363] Lustre: Unmounted lustre-client [ 485.267534] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 489.502026] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 517.255796] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 564.671525] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 11:44:43 (1772469883) [ 567.413800] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 569.475409] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 11:44:47 (1772469887) [ 606.562731] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 611.420685] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 634.867387] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 635.681530] Lustre: Mounted lustre-client [ 644.483780] LustreError: 14448:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 644.613749] Lustre: Unmounted lustre-client [ 675.013390] Key type lgssc unregistered [ 675.376582] LNet: 14857:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 675.380941] LNetError: 14857:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 675.401507] LNet: Removed LNI 192.168.203.36@tcp [ 676.116165] Key type .llcrypt unregistered [ 676.117203] Key type ._llcrypt unregistered [ 694.974960] Key type ._llcrypt registered [ 694.977537] Key type .llcrypt registered [ 696.794347] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 11:46:54 (1772470014) [ 698.626283] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 698.639570] alg: No test for adler32 (adler32-zlib) [ 699.773967] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 700.068071] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 701.943177] Key type lgssc registered [ 703.420662] Lustre: Echo OBD driver; http://www.lustre.org/ [ 789.545883] Lustre: Mounted lustre-client [ 881.878449] LustreError: 18174:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88080e6000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 881.957450] Lustre: Unmounted lustre-client [ 916.037679] Key type lgssc unregistered [ 916.332644] LNet: 18640:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 916.356924] LNetError: 18640:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 916.394526] LNet: Removed LNI 192.168.203.36@tcp [ 917.170629] Key type .llcrypt unregistered [ 917.180237] Key type ._llcrypt unregistered [ 929.598365] Key type ._llcrypt registered [ 929.604502] Key type .llcrypt registered [ 931.110776] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 11:50:49 (1772470249) [ 934.175603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 934.282967] alg: No test for adler32 (adler32-zlib) [ 935.377931] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 935.590461] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 937.327168] Key type lgssc registered [ 938.382030] Lustre: Echo OBD driver; http://www.lustre.org/ [ 995.116646] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 999.695877] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1022.069587] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1023.785458] Lustre: Mounted lustre-client [ 1038.701749] LustreError: 21752:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8806a85800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1038.817269] Lustre: Unmounted lustre-client [ 1064.540191] Key type lgssc unregistered [ 1064.974733] LNet: 22155:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1064.983927] LNetError: 22155:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1065.024343] LNet: Removed LNI 192.168.203.36@tcp [ 1065.947698] Key type .llcrypt unregistered [ 1065.951750] Key type ._llcrypt unregistered [ 1079.000990] Key type ._llcrypt registered [ 1079.005842] Key type .llcrypt registered [ 1080.952719] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 11:53:18 (1772470398) [ 1084.070871] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1084.116444] alg: No test for adler32 (adler32-zlib) [ 1085.431983] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 1085.851113] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 1087.551184] Key type lgssc registered [ 1088.977732] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1142.917208] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1147.568731] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1170.095326] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1173.190889] Lustre: Mounted lustre-client [ 1179.505192] LustreError: 24865:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8809f32000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1179.640074] Lustre: Unmounted lustre-client [ 1208.629671] Key type lgssc unregistered [ 1208.945052] LNet: 25269:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1208.951698] LNetError: 25269:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1208.963792] LNet: Removed LNI 192.168.203.36@tcp [ 1209.630572] Key type .llcrypt unregistered [ 1209.634710] Key type ._llcrypt unregistered [ 1225.637330] Key type ._llcrypt registered [ 1225.645057] Key type .llcrypt registered [ 1227.082972] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 11:55:45 (1772470545) [ 1229.580846] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1229.611967] alg: No test for adler32 (adler32-zlib) [ 1230.590613] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 1230.842021] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 1232.601484] Key type lgssc registered [ 1233.662226] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1284.282442] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1288.451297] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1309.639469] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1312.214425] Lustre: Mounted lustre-client [ 1317.364759] Lustre: lustre-MDT0000-mdc-ffff9f8802c52800: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1332.709631] Lustre: lustre-MDT0001-mdc-ffff9f8802c52800: Connection to lustre-MDT0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1336.865940] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1342.943506] Lustre: 26228:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772470647/real 1772470647] req@00000000d9650a6c x1858570079442944/t0(0) o400->MGC192.168.203.136@tcp@192.168.203.136@tcp:26/25 lens 224/224 e 0 to 1 dl 1772470663 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1342.999596] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 1347.298783] Lustre: Unmounted lustre-client [ 1367.165567] Key type lgssc unregistered [ 1367.479855] LNet: 28839:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1367.498766] LNetError: 28839:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1367.522226] LNet: Removed LNI 192.168.203.36@tcp [ 1368.344238] Key type .llcrypt unregistered [ 1368.348333] Key type ._llcrypt unregistered [ 1386.718937] Key type ._llcrypt registered [ 1386.729156] Key type .llcrypt registered [ 1388.550683] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 11:58:26 (1772470706) [ 1391.502692] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1391.604664] alg: No test for adler32 (adler32-zlib) [ 1392.712273] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 1392.983901] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 1394.672218] Key type lgssc registered [ 1396.048588] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1445.777391] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1449.993973] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1469.362046] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1472.068515] Lustre: Mounted lustre-client [ 1477.127175] Lustre: lustre-OST0000-osc-ffff9f8806e35000: Connection to lustre-OST0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1485.220251] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1495.589495] Lustre: Unmounted lustre-client [ 1522.757922] Key type lgssc unregistered [ 1523.049051] LNet: 32366:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1523.058925] LNetError: 32366:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1523.101101] LNet: Removed LNI 192.168.203.36@tcp [ 1523.895956] Key type .llcrypt unregistered [ 1523.898381] Key type ._llcrypt unregistered [ 1539.285380] Key type ._llcrypt registered [ 1539.286978] Key type .llcrypt registered [ 1540.358521] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 12:00:59 (1772470859) [ 1543.436505] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1543.460899] alg: No test for adler32 (adler32-zlib) [ 1544.589436] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 1544.828622] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 1546.551160] Key type lgssc registered [ 1547.935387] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1598.492599] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1602.752906] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1624.436453] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1626.239604] Lustre: Mounted lustre-client [ 1630.096989] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1633.937800] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1646.142306] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-03-0212h02m44s [ 1648.251665] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1651.689680] Lustre: lustre-MDT0000-mdc-ffff9f880cd7a800: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1658.894887] LustreError: 36085:0:(lmv_obd.c:1434:lmv_statfs()) lustre-MDT0000-mdc-ffff9f880cd7a800: can't stat MDS #0: rc = -19 [ 1660.247411] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1669.098648] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 1669.120975] Lustre: Evicted from MGS (at 192.168.203.136@tcp) after server handle changed from 0x8e38ba30b517aed8 to 0x8e38ba30b517b19b [ 1669.131359] Lustre: MGC192.168.203.136@tcp: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 1670.215928] LustreError: lustre-MDT0000-mdc-ffff9f880cd7a800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1670.241470] Lustre: lustre-MDT0000-mdc-ffff9f880cd7a800: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 1674.774675] Lustre: DEBUG MARKER: Wait for df (36085) ... [ 1676.298547] Lustre: DEBUG MARKER: done [ 1678.076471] LustreError: 36703:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd7a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1678.161573] Lustre: Unmounted lustre-client [ 1705.149666] Key type lgssc unregistered [ 1705.449598] LNet: 37107:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1705.454307] LNetError: 37107:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1705.475894] LNet: Removed LNI 192.168.203.36@tcp [ 1706.169202] Key type .llcrypt unregistered [ 1706.171470] Key type ._llcrypt unregistered [ 1737.181939] Key type ._llcrypt registered [ 1737.184977] Key type .llcrypt registered [ 1738.707563] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 12:04:17 (1772471057) [ 1741.517821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1741.558336] alg: No test for adler32 (adler32-zlib) [ 1742.699351] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 1742.909221] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 1744.599243] Key type lgssc registered [ 1745.736920] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1797.170664] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1801.972879] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1823.014316] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1824.771827] Lustre: Mounted lustre-client [ 1830.388817] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-03-0212h05m48s [ 1832.363092] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1839.834828] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1843.144545] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1863.647165] Lustre: 41165:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772471163/real 1772471163] req@00000000b840f415 x1858570616314496/t0(0) o101->lustre-MDT0000-mdc-ffff9f880bc5c000@192.168.203.136@tcp:12/10 lens 576/1152 e 0 to 1 dl 1772471183 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1863.704873] Lustre: lustre-MDT0000-mdc-ffff9f880bc5c000: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1863.759164] Lustre: lustre-MDT0000-mdc-ffff9f880bc5c000: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 1885.508696] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1888.794720] Lustre: DEBUG MARKER: done [ 1893.216858] LustreError: 41649:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880bc5c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1893.321283] Lustre: Unmounted lustre-client [ 1922.505439] Key type lgssc unregistered [ 1922.864299] LNet: 42052:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1922.877456] LNetError: 42052:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1922.904916] LNet: Removed LNI 192.168.203.36@tcp [ 1923.471078] Key type .llcrypt unregistered [ 1923.479631] Key type ._llcrypt unregistered [ 1959.421825] Key type ._llcrypt registered [ 1959.424669] Key type .llcrypt registered [ 1961.064892] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 12:07:59 (1772471279) [ 1962.863359] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1964.931781] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 12:08:03 (1772471283) [ 1969.511211] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1969.687413] alg: No test for adler32 (adler32-zlib) [ 1970.930076] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 1971.272034] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 1973.039248] Key type lgssc registered [ 1974.648685] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2006.851706] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 12:08:45 (1772471325) [ 2040.128446] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2045.354373] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2065.163859] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2067.887680] Lustre: Mounted lustre-client [ 2071.924633] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2075.740898] LustreError: 46402:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8806dc8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2075.839930] Lustre: Unmounted lustre-client [ 2092.669914] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2139.161617] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2143.756842] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2144.639993] Lustre: Mounted lustre-client [ 2149.237540] LustreError: 47672:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2149.379132] Lustre: Unmounted lustre-client [ 2215.351771] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2218.189528] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2218.945148] Lustre: Mounted lustre-client [ 2224.154688] LustreError: 48793:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd79000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2224.269167] Lustre: Unmounted lustre-client [ 2247.191369] Lustre: DEBUG MARKER: files compared the same [ 2270.340747] Key type lgssc unregistered [ 2270.652948] LNet: 49498:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2270.685405] LNetError: 49498:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2270.718053] LNet: Removed LNI 192.168.203.36@tcp [ 2271.493235] Key type .llcrypt unregistered [ 2271.495408] Key type ._llcrypt unregistered [ 2286.358073] Key type ._llcrypt registered [ 2286.361551] Key type .llcrypt registered [ 2288.079722] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 12:13:26 (1772471606) [ 2290.589052] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2290.748153] alg: No test for adler32 (adler32-zlib) [ 2291.948278] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 2292.230385] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 2293.927155] Key type lgssc registered [ 2295.348435] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2348.916411] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2353.152081] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2376.406625] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2378.301165] Lustre: Mounted lustre-client [ 2382.872279] LustreError: 52597:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880a6e9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2382.964972] Lustre: Unmounted lustre-client [ 2421.450097] Key type lgssc unregistered [ 2421.748973] LNet: 53003:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2421.772341] LNetError: 53003:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2421.804800] LNet: Removed LNI 192.168.203.36@tcp [ 2422.852240] Key type .llcrypt unregistered [ 2422.858378] Key type ._llcrypt unregistered [ 2449.208045] Key type ._llcrypt registered [ 2449.209853] Key type .llcrypt registered [ 2451.973316] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 12:16:08 (1772471768) [ 2454.836723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2454.906883] alg: No test for adler32 (adler32-zlib) [ 2456.369640] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 2456.738407] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 2458.439667] Key type lgssc registered [ 2460.507815] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2549.662717] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2591.282272] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2595.576564] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2626.679373] Key type lgssc unregistered [ 2626.943508] LNet: 56406:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2626.952195] LNetError: 56406:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2626.977638] LNet: Removed LNI 192.168.203.36@tcp [ 2627.912655] Key type .llcrypt unregistered [ 2627.916468] Key type ._llcrypt unregistered [ 2645.493248] Key type ._llcrypt registered [ 2645.496692] Key type .llcrypt registered [ 2647.039164] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 12:19:25 (1772471965) [ 2651.031705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2651.055640] alg: No test for adler32 (adler32-zlib) [ 2652.335193] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 2652.709632] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 2654.479729] Key type lgssc registered [ 2656.197457] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2744.540695] Lustre: Mounted lustre-client [ 2752.527922] LustreError: 58899:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2752.665596] Lustre: Unmounted lustre-client [ 2795.633377] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 12:21:54 (1772472114) [ 2930.345664] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2953.813391] Lustre: Mounted lustre-client [ 2962.403762] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2962.415723] LustreError: 62867:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff9f880cd7a000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2962.464151] Lustre: 57392:0:(llite_lib.c:4187:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.136@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2972.853187] Lustre: Unmounted lustre-client [ 3021.807402] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 12:25:40 (1772472340) [ 3038.543168] Key type lgssc unregistered [ 3038.998671] LNet: 64080:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3039.017081] LNetError: 64080:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3040.060293] LNet: Removed LNI 192.168.203.36@tcp [ 3041.252901] Key type .llcrypt unregistered [ 3041.260847] Key type ._llcrypt unregistered [ 3058.639898] Key type ._llcrypt registered [ 3058.647829] Key type .llcrypt registered [ 3058.975996] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3058.986618] alg: No test for adler32 (adler32-zlib) [ 3059.994333] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 3060.250072] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 3062.007437] Key type lgssc registered [ 3063.119961] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3114.215552] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3118.706803] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3140.132437] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3142.202639] Lustre: Mounted lustre-client [ 3147.039630] LustreError: 66610:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880a6e8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3147.120390] Lustre: Unmounted lustre-client [ 3177.028519] Key type lgssc unregistered [ 3177.512825] LNet: 67014:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3177.527838] LNetError: 67014:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3177.553124] LNet: Removed LNI 192.168.203.36@tcp [ 3178.460828] Key type .llcrypt unregistered [ 3178.465811] Key type ._llcrypt unregistered [ 3192.931867] Key type ._llcrypt registered [ 3192.935045] Key type .llcrypt registered [ 3193.918789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3193.931160] alg: No test for adler32 (adler32-zlib) [ 3195.152289] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 3195.597161] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 3197.432967] Key type lgssc registered [ 3199.455721] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3327.046446] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3331.968593] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3355.805210] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3357.681649] Lustre: Mounted lustre-client [ 3365.318358] LustreError: 69964:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8802c53000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3365.469128] Lustre: Unmounted lustre-client [ 3396.918877] Key type lgssc unregistered [ 3397.202504] LNet: 70373:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3397.207049] LNetError: 70373:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3397.221053] LNet: Removed LNI 192.168.203.36@tcp [ 3397.881325] Key type .llcrypt unregistered [ 3397.883587] Key type ._llcrypt unregistered [ 3416.501665] Key type ._llcrypt registered [ 3416.507706] Key type .llcrypt registered [ 3418.016938] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 12:32:16 (1772472736) [ 3420.672694] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3420.799788] alg: No test for adler32 (adler32-zlib) [ 3422.115695] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 3422.579661] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 3424.328348] Key type lgssc registered [ 3426.119549] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3477.831467] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3482.305650] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3505.028540] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3507.848255] Lustre: Mounted lustre-client [ 3512.338391] LustreError: 73499:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8807a08000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3512.410143] Lustre: Unmounted lustre-client [ 3512.802351] Lustre: Mounted lustre-client [ 3515.471276] LustreError: 73576:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd3b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3515.548418] Lustre: Unmounted lustre-client [ 3544.102343] Key type lgssc unregistered [ 3544.470825] LNet: 73979:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3544.479863] LNetError: 73979:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3544.490555] LNet: Removed LNI 192.168.203.36@tcp [ 3545.331512] Key type .llcrypt unregistered [ 3545.335330] Key type ._llcrypt unregistered [ 3558.036653] Key type ._llcrypt registered [ 3558.037874] Key type .llcrypt registered [ 3558.463215] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3558.490119] alg: No test for adler32 (adler32-zlib) [ 3559.620535] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 3560.058320] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 3561.791173] Key type lgssc registered [ 3563.456440] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3612.130481] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3616.261278] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3639.167561] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3641.115971] Lustre: Mounted lustre-client [ 3647.670672] LustreError: 76526:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8806dcc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3647.831517] Lustre: Unmounted lustre-client [ 3676.479336] Key type lgssc unregistered [ 3676.927472] LNet: 76929:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3676.940771] LNetError: 76929:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3676.976687] LNet: Removed LNI 192.168.203.36@tcp [ 3677.827638] Key type .llcrypt unregistered [ 3677.830262] Key type ._llcrypt unregistered [ 3694.821304] Key type ._llcrypt registered [ 3694.824642] Key type .llcrypt registered [ 3696.229485] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 12:36:54 (1772473014) [ 3699.569608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3699.630495] alg: No test for adler32 (adler32-zlib) [ 3700.820389] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 3701.022608] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 3702.751572] Key type lgssc registered [ 3703.928573] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3765.295640] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3769.912311] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3792.018316] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3795.208196] Lustre: Mounted lustre-client [ 3806.232660] Lustre: lustre: root_squash is set to 0:0 [ 3806.269495] Lustre: lustre: nosquash_nids is cleared [ 3814.881684] Lustre: lustre: root_squash is set to 500:500 [ 3822.109972] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.36@tcp 192.168.0.[2,10]@tcp [ 3828.644785] Lustre: lustre: nosquash_nids set to 192.168.203.36/24@tcp [ 3836.225994] LustreError: 80361:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd38800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3836.358480] Lustre: Unmounted lustre-client [ 3866.560315] Key type lgssc unregistered [ 3866.882241] LNet: 80764:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3866.895399] LNetError: 80764:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3867.942337] LNet: Removed LNI 192.168.203.36@tcp [ 3868.844842] Key type .llcrypt unregistered [ 3868.846921] Key type ._llcrypt unregistered [ 3890.277768] Key type ._llcrypt registered [ 3890.286884] Key type .llcrypt registered [ 3892.738285] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 12:40:09 (1772473209) [ 3897.561371] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3900.517786] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 12:40:18 (1772473218) [ 3905.004781] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3905.068207] alg: No test for adler32 (adler32-zlib) [ 3906.321333] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 3906.622257] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 3908.479174] Key type lgssc registered [ 3909.616765] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3961.907795] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3966.215649] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3990.390318] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3992.062797] Lustre: lustre: root_squash is set to 500:500 [ 3992.088584] Lustre: lustre: nosquash_nids set to 192.168.203.36/24@tcp [ 3993.296058] Lustre: Mounted lustre-client [ 3999.688771] LustreError: 84244:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88058eb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3999.795976] Lustre: Unmounted lustre-client [ 4039.418342] Key type lgssc unregistered [ 4039.689342] LNet: 84650:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4039.698779] LNetError: 84650:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4039.715519] LNet: Removed LNI 192.168.203.36@tcp [ 4040.343777] Key type .llcrypt unregistered [ 4040.345875] Key type ._llcrypt unregistered [ 4056.885402] Key type ._llcrypt registered [ 4056.887987] Key type .llcrypt registered [ 4058.116842] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4060.114238] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 12:42:58 (1772473378) [ 4079.572330] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4079.597090] alg: No test for adler32 (adler32-zlib) [ 4080.811425] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 4081.040406] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 4082.775197] Key type lgssc registered [ 4084.481490] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4165.774142] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4169.709521] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4189.325937] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4256.246767] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4260.027966] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4275.526293] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4285.844323] Lustre: Mounted lustre-client [ 4311.170125] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9f880b67e000.ost_server_uuid 50 [ 4312.634635] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9f880b67e000.ost_server_uuid in FULL state after 0 sec [ 4313.160554] Lustre: Mounted lustre-client [ 4316.525157] LustreError: 91554:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd7e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4316.610383] Lustre: Unmounted lustre-client [ 4318.232866] LustreError: 91575:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4318.238165] LustreError: 91575:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4318.337274] Lustre: Unmounted lustre-client [ 4365.936395] Key type lgssc unregistered [ 4366.127962] LNet: 92130:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4366.135644] LNetError: 92130:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4366.145471] LNet: Removed LNI 192.168.203.36@tcp [ 4366.619813] Key type .llcrypt unregistered [ 4366.621844] Key type ._llcrypt unregistered [ 4387.330834] Key type ._llcrypt registered [ 4387.335504] Key type .llcrypt registered [ 4388.100390] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 12:48:27 (1772473707) [ 4400.567902] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4400.585627] alg: No test for adler32 (adler32-zlib) [ 4401.653028] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 4401.847203] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 4403.487200] Key type lgssc registered [ 4404.266430] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4466.385306] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4469.320727] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4485.187610] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4487.697224] Lustre: Mounted lustre-client [ 4508.128581] Lustre: 93493:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772473812/real 1772473812] req@00000000c566e4e4 x1858573404476672/t0(0) o400->lustre-OST0000-osc-ffff9f8802c51800@192.168.203.136@tcp:28/4 lens 224/224 e 0 to 1 dl 1772473828 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4508.143146] Lustre: lustre-OST0000-osc-ffff9f8802c51800: Connection to lustre-OST0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4511.992704] Lustre: lustre-OST0000-osc-ffff9f8802c51800: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 4513.253392] Lustre: 93494:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772473817/real 1772473817] req@000000006986ffcb x1858573404477184/t0(0) o400->lustre-OST0000-osc-ffff9f8802c51800@192.168.203.136@tcp:28/4 lens 224/224 e 0 to 1 dl 1772473833 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4518.382619] Lustre: lustre-MDT0000-mdc-ffff9f8802c51800: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4519.393464] Lustre: 93494:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772473823/real 1772473823] req@0000000091671eb9 x1858573404477696/t0(0) o400->lustre-OST0000-osc-ffff9f8802c51800@192.168.203.136@tcp:28/4 lens 224/224 e 0 to 1 dl 1772473839 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4533.740553] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 4533.772424] Lustre: Evicted from MGS (at 192.168.203.136@tcp) after server handle changed from 0xb9dbd14dff14a63c to 0xb9dbd14dff14a8ce [ 4533.779844] Lustre: MGC192.168.203.136@tcp: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 4538.618153] Lustre: lustre-MDT0000-mdc-ffff9f8802c51800: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 4542.115865] LustreError: 97312:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8802c51800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4542.214473] Lustre: Unmounted lustre-client [ 4572.042163] Key type lgssc unregistered [ 4572.264861] LNet: 97716:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4572.272398] LNetError: 97716:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4572.301707] LNet: Removed LNI 192.168.203.36@tcp [ 4572.846671] Key type .llcrypt unregistered [ 4572.848558] Key type ._llcrypt unregistered [ 4585.209780] Key type ._llcrypt registered [ 4585.211089] Key type .llcrypt registered [ 4586.273933] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 12:51:45 (1772473905) [ 4599.967900] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4600.019987] alg: No test for adler32 (adler32-zlib) [ 4601.024146] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 4601.165617] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 4602.791932] Key type lgssc registered [ 4603.665171] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4631.216103] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4703.393635] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4706.228544] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4722.241360] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4725.024652] Lustre: Mounted lustre-client [ 4726.739386] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4728.065867] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 12:54:07 (1772474047) [ 4897.666466] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4907.985209] Lustre: Unmounted lustre-client [ 4986.253446] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4988.868163] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5003.211667] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5042.957468] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 12:59:22 (1772474362) [ 5096.666590] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5099.059502] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5110.984962] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5111.341664] Lustre: Mounted lustre-client [ 5113.804106] LustreError: 115887:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8809f32800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5113.861923] Lustre: Unmounted lustre-client [ 5137.510188] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:00:56 (1772474456) [ 5185.353783] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5187.326527] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5199.671467] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5205.514951] Lustre: Mounted lustre-client [ 5207.277411] LustreError: 119945:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b679000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5207.316486] Lustre: Unmounted lustre-client [ 5227.945294] Key type lgssc unregistered [ 5228.094851] LNet: 120347:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5228.099781] LNetError: 120347:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5228.117476] LNet: Removed LNI 192.168.203.36@tcp [ 5228.482377] Key type .llcrypt unregistered [ 5228.483604] Key type ._llcrypt unregistered [ 5236.367828] Key type ._llcrypt registered [ 5236.368931] Key type .llcrypt registered [ 5237.058790] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 13:02:36 (1772474556) [ 5238.400114] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5238.408290] alg: No test for adler32 (adler32-zlib) [ 5239.351674] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 5239.521439] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 5241.175405] Key type lgssc registered [ 5241.785416] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5265.046463] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5266.774919] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5275.346153] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5280.771658] Lustre: Mounted lustre-client [ 5292.056790] LustreError: 123446:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88077cc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5292.119125] Lustre: Unmounted lustre-client [ 5311.633229] Key type lgssc unregistered [ 5311.766453] LNet: 123848:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5311.770458] LNetError: 123848:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5311.782222] LNet: Removed LNI 192.168.203.36@tcp [ 5312.069373] Key type .llcrypt unregistered [ 5312.071155] Key type ._llcrypt unregistered [ 5318.901790] Key type ._llcrypt registered [ 5318.903375] Key type .llcrypt registered [ 5319.564885] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 13:03:58 (1772474638) [ 5320.589596] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5320.604091] alg: No test for adler32 (adler32-zlib) [ 5321.490524] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 5321.579100] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 5323.167134] Key type lgssc registered [ 5323.656610] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5346.316240] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5348.128351] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5358.084566] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5363.723978] Lustre: Mounted lustre-client [ 5368.806765] Lustre: lustre-OST0000-osc-ffff9f88080ef800: Connection to lustre-OST0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5375.416126] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9f88080ef800.ost_server_uuid 50 [ 5376.169453] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5385.895094] LustreError: 127379:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88080ef800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5385.941699] Lustre: Unmounted lustre-client [ 5399.389982] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 13:05:18 (1772474718) [ 5413.032153] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5414.857159] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5423.243385] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5433.697387] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5434.049530] Lustre: Mounted lustre-client [ 5439.463256] Lustre: lustre-OST0000-osc-ffff9f88079e3000: Connection to lustre-OST0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5465.152331] LustreError: 130028:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88079e3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5465.212847] Lustre: Unmounted lustre-client [ 5495.321262] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 13:06:54 (1772474814) [ 5511.458466] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5513.342931] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5523.885653] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5534.148847] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5534.451359] Lustre: Mounted lustre-client [ 5539.813504] Lustre: lustre-OST0000-osc-ffff9f8803749000: Connection to lustre-OST0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5551.959317] LustreError: 132784:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8803749000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5551.964965] LustreError: 132784:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 5552.007969] Lustre: Unmounted lustre-client [ 5589.377535] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 13:08:28 (1772474908) [ 5630.084575] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5631.639416] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5641.042748] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5678.838872] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5680.671210] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5690.705165] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5710.968916] Lustre: Mounted lustre-client [ 5740.263931] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5740.921219] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5741.246480] LustreError: 139372:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8806877800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5741.251554] LustreError: 139372:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 5741.281148] Lustre: Unmounted lustre-client [ 5753.347512] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 13:11:12 (1772475072) [ 5766.046091] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5767.833100] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5776.591605] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5793.392456] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5808.829257] Lustre: Mounted lustre-client [ 5838.306619] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5838.926203] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5839.846637] Lustre: lustre-OST0001-osc-ffff9f8807a09000: Connection to lustre-OST0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5847.204273] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5857.464820] Lustre: Unmounted lustre-client [ 5899.402229] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 13:13:38 (1772475218) [ 5912.096854] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5913.588360] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5921.872462] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5927.421246] Lustre: Mounted lustre-client [ 5936.064394] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5936.699867] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5941.497232] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9f8803556800.ost_server_uuid 50 [ 5942.092390] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9f8803556800.ost_server_uuid in FULL state after 0 sec [ 5942.887899] LustreError: 146364:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8803556800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5942.934192] Lustre: Unmounted lustre-client [ 5943.062521] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5943.065406] Lustre: Skipped 3 previous similar messages [ 5943.586249] LustreError: 146428:0:(sec.c:410:import_sec_validate_get()) import 0000000047731675 (NEW) with no sec [ 5978.656744] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 13:14:58 (1772475298) [ 5992.933755] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5994.406060] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6002.110775] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6009.533432] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6009.726359] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6009.779646] Lustre: Mounted lustre-client [ 6009.780929] Lustre: Skipped 1 previous similar message [ 6017.674494] LustreError: 149266:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880457b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6017.679135] LustreError: 149266:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6017.720876] Lustre: Unmounted lustre-client [ 6017.722401] Lustre: Skipped 1 previous similar message [ 6043.789274] Key type lgssc unregistered [ 6043.910731] LNet: 149715:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6043.913560] LNetError: 149715:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6043.924706] LNet: Removed LNI 192.168.203.36@tcp [ 6044.185411] Key type .llcrypt unregistered [ 6044.186947] Key type ._llcrypt unregistered [ 6050.092396] Key type ._llcrypt registered [ 6050.094365] Key type .llcrypt registered [ 6050.683180] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 13:16:10 (1772475370) [ 6051.079163] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6051.111070] alg: No test for adler32 (adler32-zlib) [ 6052.003648] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6052.106232] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6053.703615] Key type lgssc registered [ 6054.156501] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6074.938933] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6076.283954] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6083.359970] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6090.156912] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6091.335488] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6092.400110] Lustre: Mounted lustre-client [ 6095.356928] LustreError: lustre-MDT0001-mdc-ffff9f8807a0a000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6095.367497] Lustre: lustre-MDT0001-mdc-ffff9f8807a0a000: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 6097.531099] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6098.261923] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6111.727850] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6112.620076] LustreError: 153927:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8807a0a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6112.656187] Lustre: Unmounted lustre-client [ 6133.929557] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 13:17:33 (1772475453) [ 6171.666127] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6173.076867] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6181.800417] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6186.996805] Lustre: Mounted lustre-client [ 6198.703942] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6199.385652] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6213.603821] Lustre: lustre-OST0001-osc-ffff9f8802c51800: Connection to lustre-OST0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6215.595063] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6225.852184] Lustre: Unmounted lustre-client [ 6258.299079] Key type lgssc unregistered [ 6258.418532] LNet: 159065:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6258.420918] LNetError: 159065:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6258.428603] LNet: Removed LNI 192.168.203.36@tcp [ 6258.679922] Key type .llcrypt unregistered [ 6258.681468] Key type ._llcrypt unregistered [ 6269.442276] Key type ._llcrypt registered [ 6269.443377] Key type .llcrypt registered [ 6269.924199] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 13:19:49 (1772475589) [ 6270.672892] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6270.703509] alg: No test for adler32 (adler32-zlib) [ 6271.562247] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6271.651866] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6273.239142] Key type lgssc registered [ 6273.635390] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6291.409514] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6292.721081] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6299.191493] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6301.382809] Lustre: Mounted lustre-client [ 6338.423449] LustreError: 162341:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6338.453789] Lustre: Unmounted lustre-client [ 6355.285787] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6355.482382] Lustre: Mounted lustre-client [ 6387.493236] LustreError: 162993:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8805bd0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6387.525167] Lustre: Unmounted lustre-client [ 6404.855674] Key type lgssc unregistered [ 6404.969437] LNet: 163401:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6404.972257] LNetError: 163401:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6404.980578] LNet: Removed LNI 192.168.203.36@tcp [ 6405.218814] Key type .llcrypt unregistered [ 6405.220060] Key type ._llcrypt unregistered [ 6410.113124] Key type ._llcrypt registered [ 6410.114339] Key type .llcrypt registered [ 6410.562880] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 13:22:10 (1772475730) [ 6411.261223] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6411.303222] alg: No test for adler32 (adler32-zlib) [ 6412.153955] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6412.228797] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6413.807164] Key type lgssc registered [ 6414.172184] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6431.647348] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6432.830774] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6438.875979] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6454.772128] Lustre: Mounted lustre-client [ 6461.775417] LustreError: 166654:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880bc5c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6461.805894] Lustre: Unmounted lustre-client [ 6479.306440] Key type lgssc unregistered [ 6479.434743] LNet: 167057:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6479.438196] LNetError: 167057:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6479.445475] LNet: Removed LNI 192.168.203.36@tcp [ 6479.676922] Key type .llcrypt unregistered [ 6479.679921] Key type ._llcrypt unregistered [ 6483.746627] Key type ._llcrypt registered [ 6483.748174] Key type .llcrypt registered [ 6483.925322] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6483.948726] alg: No test for adler32 (adler32-zlib) [ 6484.809332] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6484.899724] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6486.487162] Key type lgssc registered [ 6486.930698] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6504.653449] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6505.857734] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6512.273208] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6522.868072] Lustre: Mounted lustre-client [ 6525.776084] LustreError: 169626:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8809581000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6525.807849] Lustre: Unmounted lustre-client [ 6535.194193] Key type lgssc unregistered [ 6535.325588] LNet: 170026:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6535.328950] LNetError: 170026:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6535.337850] LNet: Removed LNI 192.168.203.36@tcp [ 6535.579991] Key type .llcrypt unregistered [ 6535.581148] Key type ._llcrypt unregistered [ 6540.773470] Key type ._llcrypt registered [ 6540.774869] Key type .llcrypt registered [ 6541.246825] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 13:24:20 (1772475860) [ 6542.087021] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6542.093486] alg: No test for adler32 (adler32-zlib) [ 6542.960027] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6543.049104] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6544.631126] Key type lgssc registered [ 6545.030719] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6563.568738] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6564.863488] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6571.865619] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6583.282088] Lustre: Mounted lustre-client [ 6590.541222] LustreError: 173282:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8802fe3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6590.569442] Lustre: Unmounted lustre-client [ 6616.396932] Key type lgssc unregistered [ 6616.535551] LNet: 173686:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6616.538428] LNetError: 173686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6616.545675] LNet: Removed LNI 192.168.203.36@tcp [ 6616.793261] Key type .llcrypt unregistered [ 6616.795101] Key type ._llcrypt unregistered [ 6621.661525] Key type ._llcrypt registered [ 6621.665879] Key type .llcrypt registered [ 6621.866515] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6621.872537] alg: No test for adler32 (adler32-zlib) [ 6622.795372] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6622.942245] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6624.543153] Key type lgssc registered [ 6624.951549] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6643.989208] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6645.346469] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6652.173714] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6662.645470] Lustre: Mounted lustre-client [ 6665.578673] LustreError: 176255:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88058eb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6665.611140] Lustre: Unmounted lustre-client [ 6683.146272] Key type lgssc unregistered [ 6683.275566] LNet: 176657:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6683.278704] LNetError: 176657:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6683.287939] LNet: Removed LNI 192.168.203.36@tcp [ 6683.527335] Key type .llcrypt unregistered [ 6683.528821] Key type ._llcrypt unregistered [ 6688.976153] Key type ._llcrypt registered [ 6688.977688] Key type .llcrypt registered [ 6689.455480] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 13:26:48 (1772476008) [ 6697.167210] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6697.207300] alg: No test for adler32 (adler32-zlib) [ 6698.086782] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6698.180098] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6699.767169] Key type lgssc registered [ 6700.155924] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6730.518552] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6731.741805] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6739.758585] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6761.200171] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 13:28:00 (1772476080) [ 6771.616677] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6772.918501] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6779.466298] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6791.155250] Lustre: Mounted lustre-client [ 6793.241599] LustreError: 183154:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8806870000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6793.279702] Lustre: Unmounted lustre-client [ 6811.123642] Key type lgssc unregistered [ 6811.248600] LNet: 183557:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6811.251380] LNetError: 183557:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6811.260548] LNet: Removed LNI 192.168.203.36@tcp [ 6811.500846] Key type .llcrypt unregistered [ 6811.502760] Key type ._llcrypt unregistered [ 6817.110971] Key type ._llcrypt registered [ 6817.112123] Key type .llcrypt registered [ 6817.615947] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 6818.221610] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 13:28:57 (1772476137) [ 6824.938181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6824.983565] alg: No test for adler32 (adler32-zlib) [ 6825.884702] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 6825.995872] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 6827.583191] Key type lgssc registered [ 6828.021486] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6863.616261] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6864.928945] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6873.211995] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 6880.299717] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 6881.501519] Lustre: Mounted lustre-client [ 6887.945554] LustreError: 189083:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880bc59000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 6887.979130] Lustre: Unmounted lustre-client [ 6952.658343] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6954.009408] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6962.044481] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6980.263299] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 13:31:39 (1772476299) [ 6980.869729] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 6981.514893] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 13:31:41 (1772476301) [ 7001.320346] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7002.802770] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7037.020355] Key type lgssc unregistered [ 7037.147387] LNet: 195245:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7037.150660] LNetError: 195245:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7037.158512] LNet: Removed LNI 192.168.203.36@tcp [ 7037.414917] Key type .llcrypt unregistered [ 7037.416412] Key type ._llcrypt unregistered [ 7042.608750] Key type ._llcrypt registered [ 7042.609816] Key type .llcrypt registered [ 7043.069884] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 13:32:42 (1772476362) [ 7076.929376] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7076.977190] alg: No test for adler32 (adler32-zlib) [ 7077.841964] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7077.932202] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7079.519138] Key type lgssc registered [ 7079.902287] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7094.996048] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7096.282689] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7113.900486] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7125.351947] Key type lgssc unregistered [ 7125.469318] LNet: 198881:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7125.471601] LNetError: 198881:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7125.482281] LNet: Removed LNI 192.168.203.36@tcp [ 7125.704638] Key type .llcrypt unregistered [ 7125.705666] Key type ._llcrypt unregistered [ 7130.704123] Key type ._llcrypt registered [ 7130.705410] Key type .llcrypt registered [ 7131.147120] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 13:34:10 (1772476450) [ 7132.035873] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7132.044343] alg: No test for adler32 (adler32-zlib) [ 7132.925542] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7133.001958] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7134.583187] Key type lgssc registered [ 7135.014325] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7152.546142] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7153.769452] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7159.987840] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7175.665249] Lustre: Mounted lustre-client [ 7180.770116] Lustre: lustre-MDT0000-mdc-ffff9f8804707000: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7185.890286] Lustre: lustre-MDT0001-mdc-ffff9f8804707000: Connection to lustre-MDT0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7201.247130] Lustre: 199869:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1772476505/real 1772476505] req@00000000ab917182 x1858576269263488/t0(0) o400->MGC192.168.203.136@tcp@192.168.203.136@tcp:26/25 lens 224/224 e 0 to 1 dl 1772476521 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7201.261447] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 7211.489336] Lustre: Evicted from MGS (at 192.168.203.136@tcp) after server handle changed from 0x52d5f8cb1e46a41c to 0x52d5f8cb1e46bf0b [ 7211.493350] Lustre: MGC192.168.203.136@tcp: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 7218.515253] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7226.852260] LustreError: lustre-MDT0000-mdc-ffff9f8804707000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7226.871977] Lustre: lustre-MDT0000-mdc-ffff9f8804707000: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 7228.222495] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 9 sec [ 7229.446976] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7230.008647] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7230.650237] LustreError: 203350:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8804707000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7230.678533] Lustre: Unmounted lustre-client [ 7248.046550] Key type lgssc unregistered [ 7248.172592] LNet: 203752:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7248.175394] LNetError: 203752:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7248.183767] LNet: Removed LNI 192.168.203.36@tcp [ 7248.425756] Key type .llcrypt unregistered [ 7248.426744] Key type ._llcrypt unregistered [ 7253.635312] Key type ._llcrypt registered [ 7253.636827] Key type .llcrypt registered [ 7254.139782] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 13:36:13 (1772476573) [ 7254.976140] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7254.983702] alg: No test for adler32 (adler32-zlib) [ 7255.854923] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7255.943758] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7257.535205] Key type lgssc registered [ 7257.949363] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7274.802846] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7275.982150] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7297.405452] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7298.624503] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7308.796913] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7315.715622] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7345.062127] Key type lgssc unregistered [ 7345.183386] LNet: 208850:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7345.185719] LNetError: 208850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7345.197292] LNet: Removed LNI 192.168.203.36@tcp [ 7345.442628] Key type .llcrypt unregistered [ 7345.444245] Key type ._llcrypt unregistered [ 7366.969714] Key type ._llcrypt registered [ 7366.970780] Key type .llcrypt registered [ 7367.487793] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 13:38:06 (1772476686) [ 7379.688667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7379.698542] alg: No test for adler32 (adler32-zlib) [ 7380.554702] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7380.649086] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7382.239188] Key type lgssc registered [ 7382.628065] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7412.300671] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7413.461487] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7420.615764] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7450.329816] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 13:39:29 (1772476769) [ 7453.013159] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 13:39:32 (1772476772) [ 7463.195719] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7464.448715] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7470.427528] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7481.839415] Lustre: Mounted lustre-client [ 7484.993525] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 7485.730585] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7486.258847] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7486.775317] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 7492.065989] Lustre: lustre-MDT0000-mdc-ffff9f880ccbc800: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7502.306667] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 7502.313459] Lustre: Evicted from MGS (at 192.168.203.136@tcp) after server handle changed from 0xc87d2423e991e65f to 0xc87d2423e991e8f1 [ 7502.317288] Lustre: MGC192.168.203.136@tcp: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 7505.623073] Lustre: lustre-MDT0000-mdc-ffff9f880ccbc800: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 7506.740198] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7507.251725] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7509.085626] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 7512.546026] Lustre: lustre-MDT0000-mdc-ffff9f880ccbc800: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7522.785704] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 7522.790990] Lustre: 216532:0:(mgc_request.c:1911:mgc_process_log()) MGC192.168.203.136@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 7522.792467] Lustre: Evicted from MGS (at 192.168.203.136@tcp) after server handle changed from 0xc87d2423e991e8f1 to 0xc87d2423e991ebe5 [ 7522.798124] Lustre: MGC192.168.203.136@tcp: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 7528.143375] Lustre: lustre-MDT0000-mdc-ffff9f880ccbc800: Connection restored to 192.168.203.136@tcp (at 192.168.203.136@tcp) [ 7529.272850] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7529.836819] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7531.386851] LustreError: 218978:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880ccbc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7531.415283] Lustre: Unmounted lustre-client [ 7562.038831] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7563.218836] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7569.034754] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7574.513649] Lustre: Mounted lustre-client [ 7574.825435] LustreError: 220590:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88049db800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7574.855253] Lustre: Unmounted lustre-client [ 7591.957952] Key type lgssc unregistered [ 7592.081591] LNet: 220994:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7592.083935] LNetError: 220994:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7592.091494] LNet: Removed LNI 192.168.203.36@tcp [ 7592.312514] Key type .llcrypt unregistered [ 7592.313782] Key type ._llcrypt unregistered [ 7597.579627] Key type ._llcrypt registered [ 7597.580935] Key type .llcrypt registered [ 7598.158226] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 13:41:57 (1772476917) [ 7599.743444] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7599.765170] alg: No test for adler32 (adler32-zlib) [ 7600.618914] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7600.694588] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7602.279161] Key type lgssc registered [ 7602.683282] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7619.785600] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7620.935271] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7626.414863] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7642.101802] Lustre: Mounted lustre-client [ 7645.131497] LustreError: 224159:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8805b76800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7645.166078] Lustre: Unmounted lustre-client [ 7676.424391] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7677.611755] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7683.631042] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7694.322579] Lustre: Mounted lustre-client [ 7700.478467] LustreError: 225755:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88049d8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7700.506145] Lustre: Unmounted lustre-client [ 7732.071622] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7733.227218] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7739.156585] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7744.497963] Lustre: Mounted lustre-client [ 7744.794854] LustreError: 227367:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88080ee000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7744.822345] Lustre: Unmounted lustre-client [ 7761.764393] Key type lgssc unregistered [ 7761.887549] LNet: 227771:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7761.890643] LNetError: 227771:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7761.897483] LNet: Removed LNI 192.168.203.36@tcp [ 7762.124172] Key type .llcrypt unregistered [ 7762.125330] Key type ._llcrypt unregistered [ 7767.293640] Key type ._llcrypt registered [ 7767.294618] Key type .llcrypt registered [ 7767.755807] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 13:44:47 (1772477087) [ 7768.812620] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7768.852110] alg: No test for adler32 (adler32-zlib) [ 7769.717138] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7769.801903] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7771.383148] Key type lgssc registered [ 7771.763730] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7787.507733] Key type lgssc unregistered [ 7787.635336] LNet: 230089:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7787.638161] LNetError: 230089:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7787.650465] LNet: Removed LNI 192.168.203.36@tcp [ 7787.927565] Key type .llcrypt unregistered [ 7787.928817] Key type ._llcrypt unregistered [ 7797.088170] Key type ._llcrypt registered [ 7797.089687] Key type .llcrypt registered [ 7797.246464] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7797.252307] alg: No test for adler32 (adler32-zlib) [ 7798.109527] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7798.194179] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7799.775161] Key type lgssc registered [ 7800.128587] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7827.631280] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7828.702741] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7835.791254] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7852.539078] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 7853.051115] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 13:46:12 (1772477172) [ 7862.219148] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7863.469078] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7869.876348] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7877.092834] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7878.255554] Lustre: Mounted lustre-client [ 7883.746149] Lustre: lustre-OST0001-osc-ffff9f88049df000: Connection to lustre-OST0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7885.808688] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7896.121162] Lustre: Unmounted lustre-client [ 7919.709222] Key type lgssc unregistered [ 7919.825590] LNet: 236978:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7919.828497] LNetError: 236978:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7919.840947] LNet: Removed LNI 192.168.203.36@tcp [ 7920.074594] Key type .llcrypt unregistered [ 7920.076499] Key type ._llcrypt unregistered [ 7930.621167] Key type ._llcrypt registered [ 7930.622131] Key type .llcrypt registered [ 7931.098952] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 13:47:30 (1772477250) [ 7935.573838] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7935.580878] alg: No test for adler32 (adler32-zlib) [ 7936.440443] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 7936.535075] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 7938.119141] Key type lgssc registered [ 7938.511027] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7956.344099] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7957.593986] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7977.161596] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 13:48:16 (1772477296) [ 7986.788888] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7987.940834] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7993.842678] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8000.473076] Lustre: Mounted lustre-client [ 8009.703170] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 8014.265123] Lustre: Unmounted lustre-client [ 8062.394494] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8063.522522] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8096.784556] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8107.504099] Lustre: Mounted lustre-client [ 8107.887897] LustreError: 244093:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880585f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8107.915132] Lustre: Unmounted lustre-client [ 8116.752843] Key type lgssc unregistered [ 8116.872396] LNet: 244495:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8116.874508] LNetError: 244495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8116.882740] LNet: Removed LNI 192.168.203.36@tcp [ 8117.106113] Key type .llcrypt unregistered [ 8117.107149] Key type ._llcrypt unregistered [ 8125.503536] Key type ._llcrypt registered [ 8125.504886] Key type .llcrypt registered [ 8125.678773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8125.683147] alg: No test for adler32 (adler32-zlib) [ 8126.539222] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8126.620419] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8128.199150] Key type lgssc registered [ 8128.542677] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8155.763471] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8156.905191] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8164.083421] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8184.615689] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 8185.107657] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 13:51:44 (1772477504) [ 8193.890129] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8194.946422] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8200.597991] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8202.628746] Lustre: Mounted lustre-client [ 8203.249676] LustreError: 250527:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880585e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8203.277861] Lustre: Unmounted lustre-client [ 8228.453794] Key type lgssc unregistered [ 8228.578433] LNet: 250931:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8228.581433] LNetError: 250931:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8228.590755] LNet: Removed LNI 192.168.203.36@tcp [ 8228.834522] Key type .llcrypt unregistered [ 8228.835757] Key type ._llcrypt unregistered [ 8234.023989] Key type ._llcrypt registered [ 8234.025109] Key type .llcrypt registered [ 8234.498611] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 8235.075105] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 13:52:34 (1772477554) [ 8238.119521] Key type .llcrypt unregistered [ 8238.120709] Key type ._llcrypt unregistered [ 8240.937122] Key type ._llcrypt registered [ 8240.938685] Key type .llcrypt registered [ 8241.118654] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8241.123936] alg: No test for adler32 (adler32-zlib) [ 8241.980267] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8242.054707] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8243.631154] Key type lgssc registered [ 8243.966759] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8261.073324] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8266.507162] Lustre: Mounted lustre-client [ 8266.972492] LustreError: 253951:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8266.998062] Lustre: Unmounted lustre-client [ 8284.190685] Key type lgssc unregistered [ 8284.312527] LNet: 254354:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8284.314702] LNetError: 254354:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8284.324915] LNet: Removed LNI 192.168.203.36@tcp [ 8284.579291] Key type .llcrypt unregistered [ 8284.580489] Key type ._llcrypt unregistered [ 8289.732487] Key type ._llcrypt registered [ 8289.733415] Key type .llcrypt registered [ 8290.190932] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 13:53:29 (1772477609) [ 8290.833031] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8290.877919] alg: No test for adler32 (adler32-zlib) [ 8291.734479] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8291.816690] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8293.391165] Key type lgssc registered [ 8293.743111] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8352.506258] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8362.461844] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8363.696025] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8364.866339] Lustre: Mounted lustre-client [ 8365.321299] LustreError: 257396:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88080e9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8365.347132] Lustre: Unmounted lustre-client [ 8382.534338] Key type lgssc unregistered [ 8382.640547] LNet: 257800:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8382.642919] LNetError: 257800:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8382.652740] LNet: Removed LNI 192.168.203.36@tcp [ 8382.862831] Key type .llcrypt unregistered [ 8382.864224] Key type ._llcrypt unregistered [ 8387.653312] Key type ._llcrypt registered [ 8387.654876] Key type .llcrypt registered [ 8388.089459] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 13:55:07 (1772477707) [ 8388.903893] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8388.910769] alg: No test for adler32 (adler32-zlib) [ 8389.757141] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8389.834360] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8391.423161] Key type lgssc registered [ 8391.774723] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8407.564101] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8408.705549] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8414.117240] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8415.255168] Lustre: Mounted lustre-client [ 8420.321856] Lustre: lustre-MDT0000-mdc-ffff9f880cd7e800: Connection to lustre-MDT0000 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8422.570567] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8422.580227] LustreError: 260861:0:(file.c:6093:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 8422.667709] LustreError: 260880:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd7e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8422.673201] LustreError: MGC192.168.203.136@tcp: Connection to MGS (at 192.168.203.136@tcp) was lost; in progress operations using this service will fail [ 8422.691026] Lustre: Unmounted lustre-client [ 8433.177298] Key type lgssc unregistered [ 8433.283332] LNet: 261274:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8433.285325] LNetError: 261274:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8433.293278] LNet: Removed LNI 192.168.203.36@tcp [ 8433.509389] Key type .llcrypt unregistered [ 8433.510911] Key type ._llcrypt unregistered [ 8438.559949] Key type ._llcrypt registered [ 8438.561347] Key type .llcrypt registered [ 8439.004344] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 13:55:58 (1772477758) [ 8439.775715] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8439.796144] alg: No test for adler32 (adler32-zlib) [ 8440.659074] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8440.743859] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8442.335141] Key type lgssc registered [ 8442.724340] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8459.714532] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8460.836425] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8466.202605] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8467.348844] Lustre: Mounted lustre-client [ 8472.546205] Lustre: lustre-MDT0001-mdc-ffff9f880cd7a800: Connection to lustre-MDT0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8474.684546] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8474.997176] LustreError: 264364:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd7a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8475.023970] Lustre: Unmounted lustre-client [ 8485.246859] Key type lgssc unregistered [ 8485.355482] LNet: 264759:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8485.357538] LNetError: 264759:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8485.364378] LNet: Removed LNI 192.168.203.36@tcp [ 8485.578393] Key type .llcrypt unregistered [ 8485.579323] Key type ._llcrypt unregistered [ 8490.264891] Key type ._llcrypt registered [ 8490.265658] Key type .llcrypt registered [ 8490.684619] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 13:56:50 (1772477810) [ 8495.968046] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8495.989862] alg: No test for adler32 (adler32-zlib) [ 8496.853080] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8496.946565] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8498.535213] Key type lgssc registered [ 8499.006751] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8536.445706] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8537.610529] Lustre: Mounted lustre-client [ 8556.008519] Lustre: lustre-MDT0001-mdc-ffff9f8805b76000: Connection to lustre-MDT0001 (at 192.168.203.136@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8559.218046] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8569.529966] Lustre: Unmounted lustre-client [ 8586.627038] Key type lgssc unregistered [ 8586.741626] LNet: 270494:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8586.744179] LNetError: 270494:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8586.750676] LNet: Removed LNI 192.168.203.36@tcp [ 8586.988058] Key type .llcrypt unregistered [ 8586.989880] Key type ._llcrypt unregistered [ 8592.304095] Key type ._llcrypt registered [ 8592.305391] Key type .llcrypt registered [ 8592.763567] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 13:58:32 (1772477912) [ 8593.306421] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 8593.879222] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 13:58:33 (1772477913) [ 8594.434365] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 8594.961921] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 13:58:34 (1772477914) [ 8595.523341] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 8596.130310] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 13:58:35 (1772477915) [ 8596.669817] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 8597.232858] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 13:58:36 (1772477916) [ 8597.793024] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 8598.347451] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 13:58:37 (1772477917) [ 8601.343385] Key type .llcrypt unregistered [ 8601.344511] Key type ._llcrypt unregistered [ 8603.563832] Key type ._llcrypt registered [ 8603.565182] Key type .llcrypt registered [ 8603.822590] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8603.833839] alg: No test for adler32 (adler32-zlib) [ 8604.710300] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 8604.810523] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 8606.407171] Key type lgssc registered [ 8606.794785] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8632.654738] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8633.951637] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8641.229179] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8642.389768] Lustre: Mounted lustre-client [ 8642.858767] LustreError: 276077:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880cd38000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8642.892292] Lustre: Unmounted lustre-client [ 8665.954814] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 13:59:45 (1772477985) [ 8675.504429] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8676.542104] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8693.089178] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8698.354696] Lustre: Mounted lustre-client [ 8698.719372] LustreError: 278184:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8802c50000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8698.753388] Lustre: Unmounted lustre-client [ 8736.361464] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 14:00:55 (1772478055) [ 8753.311278] LNet: 1 local NIs in recovery (showing 1): 192.168.203.36@tcp [ 9322.868332] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9324.023757] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9341.046885] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9381.716101] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 14:11:41 (1772478701) [ 9385.500414] Key type lgssc unregistered [ 9385.613533] LNet: 283725:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9385.615803] LNetError: 283725:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9385.628814] LNet: Removed LNI 192.168.203.36@tcp [ 9385.854451] Key type .llcrypt unregistered [ 9385.856131] Key type ._llcrypt unregistered [ 9467.237289] Key type ._llcrypt registered [ 9467.238743] Key type .llcrypt registered [ 9467.496440] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9467.506086] alg: No test for adler32 (adler32-zlib) [ 9468.381580] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 9468.467948] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 9470.047175] Key type lgssc registered [ 9470.447632] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9500.867652] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9502.020514] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9509.170928] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9527.593797] Key type lgssc unregistered [ 9527.711403] LNet: 287313:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9527.713903] LNetError: 287313:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9527.720420] LNet: Removed LNI 192.168.203.36@tcp [ 9527.942550] Key type .llcrypt unregistered [ 9527.943718] Key type ._llcrypt unregistered [ 9542.654646] Key type ._llcrypt registered [ 9542.656334] Key type .llcrypt registered [ 9543.093494] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 14:14:22 (1772478862) [ 9549.458049] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9549.466309] alg: No test for adler32 (adler32-zlib) [ 9550.321943] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 9550.398548] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 9551.983144] Key type lgssc registered [ 9552.409824] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9569.387928] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 14:14:48 (1772478888) [ 9573.237791] Key type lgssc unregistered [ 9573.353372] LNet: 290855:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9573.355493] LNetError: 290855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9573.365360] LNet: Removed LNI 192.168.203.36@tcp [ 9573.599656] Key type .llcrypt unregistered [ 9573.601479] Key type ._llcrypt unregistered [ 9577.270273] Key type ._llcrypt registered [ 9577.271251] Key type .llcrypt registered [ 9577.397149] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9577.402081] alg: No test for adler32 (adler32-zlib) [ 9578.260726] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 9578.338732] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 9579.919104] Key type lgssc registered [ 9580.284766] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9600.226724] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9601.416096] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9608.333351] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9685.367014] LNet: Added LNI 192.168.203.36@tcp50 [8/256/0/180] [ 9686.068949] LNet: Removed LNI 192.168.203.36@tcp [ 9687.403736] Lustre: 295119:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff9f880b67b800: config has no valid NIDs, force dynamic NIDs [ 9688.446524] Lustre: Mounted lustre-client [ 9688.466431] LustreError: 295134:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f880b67b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9688.494620] Lustre: Unmounted lustre-client [ 9689.385496] Key type lgssc unregistered [ 9689.534324] LNet: 295383:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9689.536767] LNetError: 295383:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9689.546348] LNet: Removed LNI 192.168.203.36@tcp50 [ 9689.746960] Key type .llcrypt unregistered [ 9689.748029] Key type ._llcrypt unregistered [ 9699.453534] Key type ._llcrypt registered [ 9699.454441] Key type .llcrypt registered [ 9699.697319] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9699.702444] alg: No test for adler32 (adler32-zlib) [ 9700.567299] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 9700.648655] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 9702.239142] Key type lgssc registered [ 9702.610422] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9715.716500] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9716.792927] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9718.983656] LNet: Added LNI 192.168.203.36@tcp50 [8/256/0/180] [ 9719.232492] LNet: Removed LNI 192.168.203.36@tcp [ 9720.299490] Lustre: 298006:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff9f88034d2000: config has no valid NIDs, force dynamic NIDs [ 9721.348749] Lustre: Mounted lustre-client [ 9721.475588] LustreError: 298041:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f88034d2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9721.508170] Lustre: Unmounted lustre-client [ 9748.518539] Key type lgssc unregistered [ 9748.662796] LNet: 298880:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9748.665321] LNetError: 298880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9748.681633] LNet: Removed LNI 192.168.203.36@tcp50 [ 9748.866300] Key type .llcrypt unregistered [ 9748.867349] Key type ._llcrypt unregistered [ 9752.541873] Key type ._llcrypt registered [ 9752.542771] Key type .llcrypt registered [ 9752.960130] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 14:17:52 (1772479072) [ 9753.734899] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9753.743214] alg: No test for adler32 (adler32-zlib) [ 9754.594812] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 9754.668734] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 9756.247085] Key type lgssc registered [ 9756.617787] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9772.634151] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9773.742407] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9779.313754] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9795.053738] Lustre: Mounted lustre-client [ 9814.319866] Lustre: Mounted fs15246-client [ 9818.794841] LustreError: 303005:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffff9f880bc5c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9818.818601] Lustre: Unmounted fs15246-client [ 9831.245226] LustreError: 303222:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9f8808035000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9831.268635] Lustre: Unmounted lustre-client [ 9856.487483] Key type lgssc unregistered [ 9856.598539] LNet: 303625:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9856.600867] LNetError: 303625:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9856.608628] LNet: Removed LNI 192.168.203.36@tcp [ 9856.834098] Key type .llcrypt unregistered [ 9856.835105] Key type ._llcrypt unregistered [ 9860.039713] Key type ._llcrypt registered [ 9860.040658] Key type .llcrypt registered [ 9860.489230] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 14:19:40 (1772479180) [ 9860.945569] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9860.978109] alg: No test for adler32 (adler32-zlib) [ 9861.829893] Lustre: Lustre: Build Version: 2.17.50_195_gf35968a [ 9861.902802] LNet: Added LNI 192.168.203.36@tcp [8/256/0/180] [ 9863.479110] Key type lgssc registered [ 9863.795531] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9905.123188] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9906.230279] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9913.111125] Lustre: DEBUG MARKER: oleg336-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9950.682302] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 9632 sec ========== 14:21:10 (1772479270) [ 9951.200253] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 14:21:10 (1772479270) === [ 9952.234535] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 14:21:11 (1772479271) === [ 9962.708888] Key type lgssc unregistered [ 9962.823476] LNet: 312764:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9962.825551] LNetError: 312764:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9962.836504] LNet: Removed LNI 192.168.203.36@tcp [ 9963.063353] Key type .llcrypt unregistered [ 9963.064431] Key type ._llcrypt unregistered