[ 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 750496843 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001014] APIC: Switch to symmetric I/O mode setup [ 0.002000] x2apic enabled [ 0.002000] Switched APIC routing to physical x2apic. [ 0.002000] kvm-guest: setup PV IPIs [ 0.002000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.002000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.002023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.004014] pid_max: default: 32768 minimum: 301 [ 0.005151] LSM: Security Framework initializing [ 0.006079] Yama: becoming mindful. [ 0.007098] SELinux: Initializing. [ 0.008065] *** VALIDATE selinux *** [ 0.019127] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024715] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028021] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029152] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030169] *** VALIDATE tmpfs *** [ 0.031549] *** VALIDATE proc *** [ 0.033115] *** VALIDATE cgroup *** [ 0.035006] *** VALIDATE cgroup2 *** [ 0.036270] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037268] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039026] Spectre V2 : User space: Vulnerable [ 0.040006] Speculative Store Bypass: Vulnerable [ 0.043610] debug: unmapping init [mem 0xffffffff9f459000-0xffffffff9f460fff] [ 0.046261] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048318] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049028] ... version: 2 [ 0.050011] ... bit width: 48 [ 0.051010] ... generic registers: 4 [ 0.052020] ... value mask: 0000ffffffffffff [ 0.053015] ... max period: 00007fffffffffff [ 0.054010] ... fixed-purpose events: 3 [ 0.055014] ... event mask: 000000070000000f [ 0.056334] rcu: Hierarchical SRCU implementation. [ 0.058901] smp: Bringing up secondary CPUs ... [ 0.059534] x86: Booting SMP configuration: [ 0.060019] .... node #0, CPUs: #1 #2 #3 [ 0.072076] smp: Brought up 1 node, 4 CPUs [ 0.074009] smpboot: Max logical packages: 1 [ 0.075027] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.112905] node 0 deferred pages initialised in 35ms [ 0.116420] devtmpfs: initialized [ 0.117218] x86/mm: Memory block size: 128MB [ 0.120273] gcov: version magic: 0x41383552 [ 0.122465] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.123089] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.124253] pinctrl core: initialized pinctrl subsystem [ 0.125197] [ 0.125771] ************************************************************* [ 0.126017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.127084] ** ** [ 0.128012] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.129013] ** ** [ 0.130014] ** This means that this kernel is built to expose internal ** [ 0.131015] ** IOMMU data structures, which may compromise security on ** [ 0.132011] ** your system. ** [ 0.133015] ** ** [ 0.134010] ** If you see this message and you are not debugging the ** [ 0.135152] ** kernel, report this immediately to your vendor! ** [ 0.136023] ** ** [ 0.137019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.138016] ************************************************************* [ 0.140871] NET: Registered protocol family 16 [ 0.141560] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.142068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.143087] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.145127] cpuidle: using governor menu [ 0.150000] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.153654] PCI: Using configuration type 1 for base access [ 0.157124] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.192445] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.194019] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.197548] cryptd: max_cpu_qlen set to 1000 [ 0.204439] ACPI: Added _OSI(Module Device) [ 0.206010] ACPI: Added _OSI(Processor Device) [ 0.207008] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.210013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.219772] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.228847] ACPI: Interpreter enabled [ 0.234472] ACPI: PM: (supports S0 S3 S4 S5) [ 0.241018] ACPI: Using IOAPIC for interrupt routing [ 0.243138] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.251533] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.266569] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.269031] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.272016] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.275078] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.280456] acpiphp: Slot [2] registered [ 0.282095] acpiphp: Slot [5] registered [ 0.283071] acpiphp: Slot [6] registered [ 0.284149] acpiphp: Slot [3] registered [ 0.286064] acpiphp: Slot [4] registered [ 0.287091] acpiphp: Slot [7] registered [ 0.288068] acpiphp: Slot [8] registered [ 0.289063] acpiphp: Slot [9] registered [ 0.291183] acpiphp: Slot [10] registered [ 0.292096] acpiphp: Slot [11] registered [ 0.293067] acpiphp: Slot [12] registered [ 0.295077] acpiphp: Slot [13] registered [ 0.296069] acpiphp: Slot [14] registered [ 0.297064] acpiphp: Slot [15] registered [ 0.298123] acpiphp: Slot [16] registered [ 0.300061] acpiphp: Slot [17] registered [ 0.302076] acpiphp: Slot [18] registered [ 0.303064] acpiphp: Slot [19] registered [ 0.304075] acpiphp: Slot [20] registered [ 0.306135] acpiphp: Slot [21] registered [ 0.307058] acpiphp: Slot [22] registered [ 0.308081] acpiphp: Slot [23] registered [ 0.310074] acpiphp: Slot [24] registered [ 0.311061] acpiphp: Slot [25] registered [ 0.312065] acpiphp: Slot [26] registered [ 0.313072] acpiphp: Slot [27] registered [ 0.315086] acpiphp: Slot [28] registered [ 0.317094] acpiphp: Slot [29] registered [ 0.319077] acpiphp: Slot [30] registered [ 0.320100] acpiphp: Slot [31] registered [ 0.321087] PCI host bridge to bus 0000:00 [ 0.322011] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.324016] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.327023] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.330025] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.332014] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.334017] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.336142] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.338038] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.341201] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.349012] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.354452] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.357013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.359013] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.361017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.363649] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.366806] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.369040] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.372030] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.375702] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.388014] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.392012] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.398595] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.407000] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.412014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.432014] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.464154] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.467861] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.474872] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.488013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.506041] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.507275] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.509309] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.513415] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.515172] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.521086] iommu: Default domain type: Passthrough [ 0.525108] SCSI subsystem initialized [ 0.526126] ACPI: bus type USB registered [ 0.528151] usbcore: registered new interface driver usbfs [ 0.530067] usbcore: registered new interface driver hub [ 0.532072] usbcore: registered new device driver usb [ 0.534160] pps_core: LinuxPPS API ver. 1 registered [ 0.536011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.539079] PTP clock support registered [ 0.541282] EDAC MC: Ver: 3.0.0 [ 0.542626] PCI: Using ACPI for IRQ routing [ 0.544847] NetLabel: Initializing [ 0.546010] NetLabel: domain hash size = 128 [ 0.547007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.550079] NetLabel: unlabeled traffic allowed by default [ 0.552267] vgaarb: loaded [ 0.554037] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.556012] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.561544] clocksource: Switched to clocksource kvm-clock [ 0.698122] VFS: Disk quotas dquot_6.6.0 [ 0.699356] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.701819] *** VALIDATE ramfs *** [ 0.703198] *** VALIDATE hugetlbfs *** [ 0.704885] pnp: PnP ACPI init [ 0.707361] pnp: PnP ACPI: found 6 devices [ 0.724279] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.728073] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.730656] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.733118] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.735986] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.739043] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.747404] NET: Registered protocol family 2 [ 0.750756] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.757904] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.761699] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.768458] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.773823] TCP: Hash tables configured (established 65536 bind 65536) [ 0.780959] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.788194] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.792454] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.797647] NET: Registered protocol family 1 [ 0.800754] RPC: Registered named UNIX socket transport module. [ 0.804205] RPC: Registered udp transport module. [ 0.805952] RPC: Registered tcp transport module. [ 0.807553] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.809474] NET: Registered protocol family 44 [ 0.811131] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.813733] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.816341] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.819272] PCI: CLS 0 bytes, default 64 [ 0.821324] Unpacking initramfs... [ 5.169369] debug: unmapping init [mem 0xffff8ccb3cc64000-0xffff8ccb3ffcffff] [ 5.177120] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 5.250580] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 5.270337] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 6.703816] Initialise system trusted keyrings [ 6.709725] Key type blacklist registered [ 6.715493] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 6.753430] zbud: loaded [ 6.770881] *** VALIDATE nfs *** [ 6.775505] *** VALIDATE nfs4 *** [ 6.778696] pstore: using deflate compression [ 6.800463] Platform Keyring initialized [ 6.952514] NET: Registered protocol family 38 [ 6.954169] Key type asymmetric registered [ 6.955378] Asymmetric key parser 'x509' registered [ 6.957493] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 6.960693] io scheduler mq-deadline registered [ 6.962682] io scheduler kyber registered [ 6.964704] io scheduler bfq registered [ 6.966838] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 6.970565] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 6.975191] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.978367] ACPI: Power Button [PWRF] [ 6.988368] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 7.011971] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 7.044285] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 7.077443] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 7.140653] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 7.145706] Non-volatile memory driver v1.3 [ 7.147657] Linux agpgart interface v0.103 [ 7.180182] virtio_blk virtio1: [vda] 133944 512-byte logical blocks (68.6 MB/65.4 MiB) [ 7.184579] vda: detected capacity change from 0 to 68579328 [ 7.237422] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 7.240674] vdb: detected capacity change from 0 to 1073741824 [ 7.280327] libphy: Fixed MDIO Bus: probed [ 7.324206] usbcore: registered new interface driver usbserial_generic [ 7.327339] usbserial: USB Serial support registered for generic [ 7.329637] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 7.336290] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 7.338737] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 7.341778] mousedev: PS/2 mouse device common for all mice [ 7.345296] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 7.345841] rtc_cmos 00:05: RTC can wake from S4 [ 7.358307] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 7.360586] rtc_cmos 00:05: registered as rtc0 [ 7.367432] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 7.369234] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 7.369279] intel_pstate: CPU model not supported [ 7.375393] hid: raw HID events driver (C) Jiri Kosina [ 7.384416] usbcore: registered new interface driver usbhid [ 7.386904] usbhid: USB HID core driver [ 7.399643] drop_monitor: Initializing network drop monitor service [ 7.402754] Initializing XFRM netlink socket [ 7.405535] NET: Registered protocol family 10 [ 7.412301] Segment Routing with IPv6 [ 7.414208] NET: Registered protocol family 17 [ 7.417342] mpls_gso: MPLS GSO support [ 7.423655] RAS: Correctable Errors collector initialized. [ 7.425877] AVX version of gcm_enc/dec engaged. [ 7.427685] AES CTR mode by8 optimization enabled [ 7.548704] sched_clock: Marking stable (7548534354, 0)->(8837511128, -1288976774) [ 7.557678] registered taskstats version 1 [ 7.561840] Loading compiled-in X.509 certificates [ 7.565763] zswap: loaded using pool lzo/zbud [ 7.662583] Key type big_key registered [ 7.690653] Key type encrypted registered [ 7.693862] ima: No TPM chip found, activating TPM-bypass! [ 7.701290] ima: Allocated hash algorithm: sha1 [ 7.704802] ima: No architecture policies found [ 7.707959] evm: Initialising EVM extended attributes: [ 7.713255] evm: security.selinux [ 7.715506] evm: security.ima [ 7.716870] evm: security.capability [ 7.719309] evm: HMAC attrs: 0x1 [ 7.724697] rtc_cmos 00:05: setting system clock to 2026-04-10 14:38:48 UTC (1775831928) [ 7.744365] debug: unmapping init [mem 0xffffffffa0403000-0xffffffffa05fffff] [ 7.754699] debug: unmapping init [mem 0xffffffff9f182000-0xffffffff9f458fff] [ 7.799712] Write protecting the kernel read-only data: 28672k [ 7.809695] debug: unmapping init [mem 0xffffffff9d803000-0xffffffff9d9fffff] [ 7.816409] debug: unmapping init [mem 0xffffffff9e114000-0xffffffff9e1fffff] [ 7.872559] 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) [ 7.884213] systemd[1]: Detected virtualization kvm. [ 7.886654] systemd[1]: Detected architecture x86-64. [ 7.889349] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 7.930680] systemd[1]: No hostname configured. [ 7.932589] systemd[1]: Set hostname to . [ 7.935294] random: systemd: uninitialized urandom read (16 bytes read) [ 7.938561] systemd[1]: Initializing machine ID from random generator. [ 8.051807] random: ln: uninitialized urandom read (6 bytes read) [ 8.223842] random: systemd: uninitialized urandom read (16 bytes read) [ 8.227271] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 8.234443] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 8.238750] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket. Starting Journal Service... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Initrd Root Device. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Timers. Starting Apply Kernel Variables... [ OK ] Started Setup Virtual Console. [ OK ] Started Journal Service. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 9.550578] device-mapper: uevent: version 1.0.3 [ 9.553272] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ 11.436835] virtio_net virtio0 ens2: renamed from eth0 [ 20.378379] scsi host0: ata_piix [ 20.543775] random: crng init done [ 20.553114] random: 7 urandom warning(s) missed due to ratelimiting [ 20.567461] scsi host1: ata_piix [ 20.573772] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 20.589324] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 25.273499] dracut-initqueue[575]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 27.719812] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 33.525829] printk: systemd: 19 output lines suppressed due to ratelimiting [ 35.412988] SELinux: Disabled at runtime. [ 35.508788] 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) [ 35.726590] systemd[1]: Detected virtualization kvm. [ 35.735765] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 39.458580] systemd[1]: initrd-switch-root.service: Succeeded. [ 39.465242] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 39.481683] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 39.487358] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 39.492533] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 39.504986] systemd[1]: Starting Journal Service... Starting Journal Service... [ 39.515987] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. Mounting Kernel Debug File System... Mounting Huge Pages File System... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Slices. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-sshd\x2dkeygen.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on udev Kernel Socket. Starting Remount Root and Kernel File Systems... [ OK [0[ 40.471640] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS m] Stopped target Initrd Root File System. [ 40.936757] systemd[1]: Listening on Process Core Dump Socket. [ OK ] Listening on Process Core Dump Socket. [ 40.964972] systemd[1]: Starting Apply Kernel Variables... Starting Apply Kernel Variables... [ 40.973676] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 40.987142] systemd[1]: Starting udev Coldplug all Devices... Starting udev Coldplug all Devices... [ 40.997553] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 41.005626] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ 41.035901] systemd[1]: sysroot-var-lib-nfs-rpc_pipefs.mount: Succeeded. [ 41.040166] systemd[1]: sysroot.mount: Succeeded. [ 41.051419] systemd[1]: Mounted Kernel Debug File System. [ OK ] Mounted Kernel Debug File System. [ 41.065420] systemd[1]: Mounted Huge Pages File System. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Reached target Swap. [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 ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting Flush Journal to Persistent Storage... [ OK ] Mounted /mnt. [ OK ] Started Flush Journal to Persistent Storage. [ 44.130286] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 45.451633] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 46.004903] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 46.403779] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 46.650220] EDAC sbridge: Ver: 1.1.2 [* ] 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)[ 50.963243] hrtimer: interrupt took 4308194 ns [*** ] A start job is running for Configur…only root support (11s / no limit) [ *** ] A start job is running for Configur…only root support (12s / no limit) [ *** ] 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)[ 52.950269] Key type dns_resolver registered [ **] A start job is running for Configur…only root support (14s / no limit) [ *] A start job is running for Configur…only root support (14s / no limit)[ 54.177669] NFS: Registering the id_resolver key type [ 54.200102] Key type id_resolver registered [ 54.204576] Key type id_legacy registered [ **] A start job is running for Configur…only root support (15s / no limit) [ ***] A start job is running for Configur…only root support (15s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting 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 update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... 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 Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg448-client login: [ 115.239399] libcfs: loading out-of-tree module taints kernel. [ 115.316836] Key type ._llcrypt registered [ 115.320946] Key type .llcrypt registered [ 115.737609] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 115.750502] alg: No test for adler32 (adler32-zlib) [ 116.924711] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 117.473089] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 119.167181] Key type lgssc registered [ 120.276645] Lustre: Echo OBD driver; http://www.lustre.org/ [ 240.365262] Lustre: Mounted lustre-client [ 243.773210] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 256.400240] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing check_logdir /tmp/testlogs/ [ 260.143933] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing yml_node [ 264.260991] Lustre: DEBUG MARKER: Client: 2.17.51.75 [ 266.211854] Lustre: lustre-OST0000-osc-ffff8ccb892d9800: disconnect after 24s idle [ 266.533731] Lustre: DEBUG MARKER: MDS: 2.17.51.75 [ 268.519803] Lustre: DEBUG MARKER: OSS: 2.17.51.75 [ 270.190942] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Apr 10 10:43:09 EDT 2026 [ 283.787259] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 284.985464] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 286.960347] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 297.278504] Lustre: Unmounted lustre-client [ 383.744201] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 385.941485] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 402.068093] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 437.118986] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 10:45:57 (1775832357) [ 438.359824] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 439.388150] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 10:45:59 (1775832359) [ 455.413856] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 457.290811] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 466.472087] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 472.090568] Lustre: Mounted lustre-client [ 477.976330] LustreError: 14387:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8c101800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 478.027233] Lustre: Unmounted lustre-client [ 506.134415] Key type lgssc unregistered [ 506.294480] LNet: 14796:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 506.298833] LNetError: 14796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 506.311859] LNet: Removed LNI 192.168.204.48@tcp [ 506.700415] Key type .llcrypt unregistered [ 506.703132] Key type ._llcrypt unregistered [ 513.784474] Key type ._llcrypt registered [ 513.786401] Key type .llcrypt registered [ 514.445661] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 10:47:14 (1775832434) [ 515.215458] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 515.225304] alg: No test for adler32 (adler32-zlib) [ 516.136446] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 516.261424] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 517.863247] Key type lgssc registered [ 518.550937] Lustre: Echo OBD driver; http://www.lustre.org/ [ 562.659578] Lustre: Mounted lustre-client [ 641.688445] LustreError: 18180:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b330000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 641.714157] Lustre: Unmounted lustre-client [ 657.814418] Key type lgssc unregistered [ 657.936848] LNet: 18644:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 657.940620] LNetError: 18644:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 657.949675] LNet: Removed LNI 192.168.204.48@tcp [ 658.252157] Key type .llcrypt unregistered [ 658.254335] Key type ._llcrypt unregistered [ 662.332606] Key type ._llcrypt registered [ 662.334276] Key type .llcrypt registered [ 662.896811] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 10:49:43 (1775832583) [ 663.920580] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 663.945539] alg: No test for adler32 (adler32-zlib) [ 664.841381] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 664.946860] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 666.543211] Key type lgssc registered [ 667.022583] Lustre: Echo OBD driver; http://www.lustre.org/ [ 688.838678] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 690.387997] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 698.816952] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 704.502560] Lustre: Mounted lustre-client [ 708.917976] LustreError: 21747:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb87ded800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 708.953974] Lustre: Unmounted lustre-client [ 727.921750] Key type lgssc unregistered [ 728.071599] LNet: 22150:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 728.076452] LNetError: 22150:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 728.097943] LNet: Removed LNI 192.168.204.48@tcp [ 728.381972] Key type .llcrypt unregistered [ 728.383721] Key type ._llcrypt unregistered [ 732.534516] Key type ._llcrypt registered [ 732.536283] Key type .llcrypt registered [ 733.182989] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 10:50:53 (1775832653) [ 734.177723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 734.251515] alg: No test for adler32 (adler32-zlib) [ 735.150328] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 735.252411] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 736.855166] Key type lgssc registered [ 737.336486] Lustre: Echo OBD driver; http://www.lustre.org/ [ 758.813680] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 760.385293] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 768.075454] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 774.649055] Lustre: Mounted lustre-client [ 777.780200] LustreError: 24844:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b334800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 777.818501] Lustre: Unmounted lustre-client [ 788.589138] Key type lgssc unregistered [ 788.735993] LNet: 25245:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 788.741412] LNetError: 25245:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 788.753221] LNet: Removed LNI 192.168.204.48@tcp [ 789.062487] Key type .llcrypt unregistered [ 789.063992] Key type ._llcrypt unregistered [ 795.325403] Key type ._llcrypt registered [ 795.326959] Key type .llcrypt registered [ 795.939286] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 10:51:56 (1775832716) [ 796.954486] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 796.965591] alg: No test for adler32 (adler32-zlib) [ 797.847158] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 797.947393] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 799.536178] Key type lgssc registered [ 800.036582] Lustre: Echo OBD driver; http://www.lustre.org/ [ 821.502366] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 823.124411] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 831.112133] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 836.591276] Lustre: Mounted lustre-client [ 841.699167] Lustre: lustre-MDT0000-mdc-ffff8ccb845b3000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 846.818518] Lustre: lustre-MDT0001-mdc-ffff8ccb845b3000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 853.361200] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 863.073856] Lustre: 26204:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775832767/real 1775832767] req@00000000c28daa91 x1862095568115200/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1775832783 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 863.087071] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 863.674655] Lustre: Unmounted lustre-client [ 875.360250] Key type lgssc unregistered [ 875.489098] LNet: 28807:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 875.493897] LNetError: 28807:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 875.503785] LNet: Removed LNI 192.168.204.48@tcp [ 875.796374] Key type .llcrypt unregistered [ 875.797931] Key type ._llcrypt unregistered [ 882.217561] Key type ._llcrypt registered [ 882.219568] Key type .llcrypt registered [ 882.865105] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 10:53:22 (1775832802) [ 883.762660] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 883.813086] alg: No test for adler32 (adler32-zlib) [ 884.712948] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 884.814162] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 886.415190] Key type lgssc registered [ 886.882984] Lustre: Echo OBD driver; http://www.lustre.org/ [ 906.497520] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 908.021277] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 915.584153] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 927.242938] Lustre: Mounted lustre-client [ 932.325387] Lustre: lustre-OST0000-osc-ffff8ccb83e81000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 936.547801] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 946.820240] Lustre: Unmounted lustre-client [ 965.097777] Key type lgssc unregistered [ 965.255597] LNet: 32343:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 965.258827] LNetError: 32343:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 965.273116] LNet: Removed LNI 192.168.204.48@tcp [ 965.590103] Key type .llcrypt unregistered [ 965.591960] Key type ._llcrypt unregistered [ 971.859553] Key type ._llcrypt registered [ 971.861208] Key type .llcrypt registered [ 972.518728] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 10:54:52 (1775832892) [ 973.453425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 973.510229] alg: No test for adler32 (adler32-zlib) [ 974.395488] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 974.511341] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 976.103171] Key type lgssc registered [ 976.627266] Lustre: Echo OBD driver; http://www.lustre.org/ [ 998.516411] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1000.099290] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1009.268618] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1015.806362] Lustre: Mounted lustre-client [ 1017.945429] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1019.392030] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1029.978616] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-04-1010h55m50s [ 1030.796502] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1036.257834] Lustre: lustre-MDT0000-mdc-ffff8ccb87dec000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1038.549520] LustreError: 36039:0:(lmv_obd.c:1437:lmv_statfs()) lustre-MDT0000-mdc-ffff8ccb87dec000: can't stat MDS #0: rc = -19 [ 1039.124434] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1042.338575] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 1042.345450] LustreError: lustre-MDT0000-mdc-ffff8ccb87dec000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1042.351422] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0x761afec79d5ec225 to 0x761afec79d5ec5b3 [ 1042.353995] Lustre: lustre-MDT0000-mdc-ffff8ccb87dec000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1042.359945] Lustre: Skipped 1 previous similar message [ 1045.091258] Lustre: DEBUG MARKER: Wait for df (36039) ... [ 1045.713992] Lustre: DEBUG MARKER: done [ 1046.182558] LustreError: 36647:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb87dec000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1046.220789] Lustre: Unmounted lustre-client [ 1062.574648] Key type lgssc unregistered [ 1062.701906] LNet: 37049:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1062.707371] LNetError: 37049:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1062.719072] LNet: Removed LNI 192.168.204.48@tcp [ 1062.993143] Key type .llcrypt unregistered [ 1062.995051] Key type ._llcrypt unregistered [ 1075.183244] Key type ._llcrypt registered [ 1075.184692] Key type .llcrypt registered [ 1075.762412] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 10:56:35 (1775832995) [ 1076.708574] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1076.758394] alg: No test for adler32 (adler32-zlib) [ 1077.643581] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1077.740928] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1079.343165] Key type lgssc registered [ 1079.854903] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1100.867960] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1102.325422] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1109.985936] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1117.675632] Lustre: Mounted lustre-client [ 1120.333609] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-04-1010h57m20s [ 1121.025229] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1124.157476] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1125.276036] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1145.823178] Lustre: 41099:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775833046/real 1775833046] req@000000003195b7f6 x1862095861716480/t0(0) o101->lustre-MDT0000-mdc-ffff8ccb8b332800@192.168.204.148@tcp:12/10 lens 576/1152 e 0 to 1 dl 1775833066 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1145.840338] Lustre: lustre-MDT0000-mdc-ffff8ccb8b332800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1145.860165] Lustre: lustre-MDT0000-mdc-ffff8ccb8b332800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1166.055270] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1167.297869] Lustre: DEBUG MARKER: done [ 1168.290018] LustreError: 41579:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b332800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1168.325617] Lustre: Unmounted lustre-client [ 1187.243342] Key type lgssc unregistered [ 1187.385253] LNet: 41982:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1187.389248] LNetError: 41982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1187.397503] LNet: Removed LNI 192.168.204.48@tcp [ 1187.684554] Key type .llcrypt unregistered [ 1187.686190] Key type ._llcrypt unregistered [ 1200.019139] Key type ._llcrypt registered [ 1200.020612] Key type .llcrypt registered [ 1200.595844] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 10:58:40 (1775833120) [ 1201.199244] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1201.900106] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 10:58:42 (1775833122) [ 1203.456673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1203.467206] alg: No test for adler32 (adler32-zlib) [ 1204.344784] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1204.441358] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1206.031243] Key type lgssc registered [ 1206.525470] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1219.256614] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 10:58:59 (1775833139) [ 1230.621652] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1232.192875] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1239.270255] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1240.449606] Lustre: Mounted lustre-client [ 1242.397056] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1243.271569] LustreError: 46318:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb862a9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1243.317380] Lustre: Unmounted lustre-client [ 1253.386653] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1270.832713] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1272.279392] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1272.503384] Lustre: Mounted lustre-client [ 1273.552258] LustreError: 47574:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb89b21800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1273.596109] Lustre: Unmounted lustre-client [ 1302.117608] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1303.663764] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1303.877994] Lustre: Mounted lustre-client [ 1304.942919] LustreError: 48689:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb845b5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1304.984134] Lustre: Unmounted lustre-client [ 1317.411113] Lustre: DEBUG MARKER: files compared the same [ 1332.568910] Key type lgssc unregistered [ 1332.704733] LNet: 49395:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1332.708398] LNetError: 49395:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1332.720296] LNet: Removed LNI 192.168.204.48@tcp [ 1333.000125] Key type .llcrypt unregistered [ 1333.001974] Key type ._llcrypt unregistered [ 1339.074984] Key type ._llcrypt registered [ 1339.076812] Key type .llcrypt registered [ 1339.664208] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 11:00:59 (1775833259) [ 1340.630937] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1340.706652] alg: No test for adler32 (adler32-zlib) [ 1341.587225] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1341.687655] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1343.287291] Key type lgssc registered [ 1343.872757] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1364.476749] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1365.918323] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1372.895910] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1383.406060] Lustre: Mounted lustre-client [ 1385.091171] LustreError: 52501:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb89b27800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1385.126049] Lustre: Unmounted lustre-client [ 1411.343592] Key type lgssc unregistered [ 1411.470556] LNet: 52905:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1411.473338] LNetError: 52905:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1411.480828] LNet: Removed LNI 192.168.204.48@tcp [ 1411.738907] Key type .llcrypt unregistered [ 1411.740249] Key type ._llcrypt unregistered [ 1417.308325] Key type ._llcrypt registered [ 1417.309859] Key type .llcrypt registered [ 1417.796739] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 11:02:18 (1775833338) [ 1418.619693] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1418.627844] alg: No test for adler32 (adler32-zlib) [ 1419.497725] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1419.589361] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1421.183145] Key type lgssc registered [ 1421.567348] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1481.727932] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1492.274429] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1493.526699] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1527.920766] Key type lgssc unregistered [ 1528.056358] LNet: 56294:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1528.060251] LNetError: 56294:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1528.068419] LNet: Removed LNI 192.168.204.48@tcp [ 1528.307557] Key type .llcrypt unregistered [ 1528.308581] Key type ._llcrypt unregistered [ 1533.701549] Key type ._llcrypt registered [ 1533.703152] Key type .llcrypt registered [ 1534.227972] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 11:04:14 (1775833454) [ 1535.382584] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1535.438420] alg: No test for adler32 (adler32-zlib) [ 1536.299900] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1536.383420] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1537.967169] Key type lgssc registered [ 1538.378500] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1565.349922] Lustre: Mounted lustre-client [ 1570.677099] LustreError: 58774:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb865ec000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1570.705935] Lustre: Unmounted lustre-client [ 1590.842480] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 11:05:11 (1775833511) [ 1629.570401] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1634.871364] Lustre: Mounted lustre-client [ 1640.208238] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1640.211380] LustreError: 62726:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8ccb86258800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1640.220869] Lustre: 57278:0:(llite_lib.c:4149:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.148@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1650.487575] Lustre: Unmounted lustre-client [ 1677.159667] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 11:06:37 (1775833597) [ 1680.688246] Key type lgssc unregistered [ 1680.807371] LNet: 63934:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1680.809448] LNetError: 63934:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1680.816673] LNet: Removed LNI 192.168.204.48@tcp [ 1681.039425] Key type .llcrypt unregistered [ 1681.041331] Key type ._llcrypt unregistered [ 1684.725872] Key type ._llcrypt registered [ 1684.730941] Key type .llcrypt registered [ 1684.897577] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1684.902261] alg: No test for adler32 (adler32-zlib) [ 1685.759873] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1685.843292] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1687.423144] Key type lgssc registered [ 1687.817375] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1704.213570] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1705.496042] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1711.254085] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1726.956342] Lustre: Mounted lustre-client [ 1728.535166] LustreError: 66452:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb89b25800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1728.565852] Lustre: Unmounted lustre-client [ 1745.669731] Key type lgssc unregistered [ 1745.782493] LNet: 66855:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1745.786495] LNetError: 66855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1745.795552] LNet: Removed LNI 192.168.204.48@tcp [ 1745.992216] Key type .llcrypt unregistered [ 1745.993477] Key type ._llcrypt unregistered [ 1749.137530] Key type ._llcrypt registered [ 1749.139227] Key type .llcrypt registered [ 1749.301289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1749.308522] alg: No test for adler32 (adler32-zlib) [ 1750.168928] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1750.268813] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1751.863195] Key type lgssc registered [ 1752.259696] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1798.151869] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1799.384880] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1805.464928] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1821.168979] Lustre: Mounted lustre-client [ 1821.638391] LustreError: 69787:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85055000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1821.675264] Lustre: Unmounted lustre-client [ 1839.158059] Key type lgssc unregistered [ 1839.268422] LNet: 70191:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1839.272456] LNetError: 70191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1839.280702] LNet: Removed LNI 192.168.204.48@tcp [ 1839.516734] Key type .llcrypt unregistered [ 1839.517870] Key type ._llcrypt unregistered [ 1844.900154] Key type ._llcrypt registered [ 1844.901683] Key type .llcrypt registered [ 1845.373386] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 11:09:25 (1775833765) [ 1846.190946] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1846.204160] alg: No test for adler32 (adler32-zlib) [ 1847.098909] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1847.192755] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1848.783160] Key type lgssc registered [ 1849.251221] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1867.279108] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1868.695928] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1874.958864] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1885.675935] Lustre: Mounted lustre-client [ 1887.784503] LustreError: 73305:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8bd13000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1887.814125] Lustre: Unmounted lustre-client [ 1887.925116] Lustre: Mounted lustre-client [ 1888.531213] LustreError: 73382:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8326a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1888.560767] Lustre: Unmounted lustre-client [ 1905.972595] Key type lgssc unregistered [ 1906.090501] LNet: 73785:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1906.092924] LNetError: 73785:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1906.102953] LNet: Removed LNI 192.168.204.48@tcp [ 1906.352063] Key type .llcrypt unregistered [ 1906.354085] Key type ._llcrypt unregistered [ 1910.314724] Key type ._llcrypt registered [ 1910.315799] Key type .llcrypt registered [ 1910.486194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1910.491124] alg: No test for adler32 (adler32-zlib) [ 1911.363571] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1911.460858] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1913.055158] Key type lgssc registered [ 1913.454582] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1930.742855] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1931.927317] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1938.351644] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1949.163487] Lustre: Mounted lustre-client [ 1950.803901] LustreError: 76319:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b330000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1950.832144] Lustre: Unmounted lustre-client [ 1968.054296] Key type lgssc unregistered [ 1968.179652] LNet: 76722:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1968.183593] LNetError: 76722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1968.194696] LNet: Removed LNI 192.168.204.48@tcp [ 1968.439022] Key type .llcrypt unregistered [ 1968.440101] Key type ._llcrypt unregistered [ 1973.386274] Key type ._llcrypt registered [ 1973.387192] Key type .llcrypt registered [ 1973.874220] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 11:11:34 (1775833894) [ 1974.702612] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1974.774723] alg: No test for adler32 (adler32-zlib) [ 1975.650893] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 1975.755786] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1977.343157] Key type lgssc registered [ 1977.763108] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1994.367518] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1995.585742] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2001.744216] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2013.176435] Lustre: Mounted lustre-client [ 2016.307663] Lustre: lustre: root_squash is set to 0:0 [ 2025.966358] Lustre: lustre: nosquash_nids is cleared [ 2025.976669] Lustre: lustre: root_squash is set to 500:500 [ 2034.159495] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.48@tcp 192.168.0.[2,10]@tcp [ 2039.280329] Lustre: lustre: nosquash_nids set to 192.168.204.48/24@tcp [ 2040.043727] LustreError: 80212:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb865e8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2040.075891] Lustre: Unmounted lustre-client [ 2057.171899] Key type lgssc unregistered [ 2057.296507] LNet: 80615:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2057.299310] LNetError: 80615:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2057.306969] LNet: Removed LNI 192.168.204.48@tcp [ 2057.566167] Key type .llcrypt unregistered [ 2057.567239] Key type ._llcrypt unregistered [ 2062.359991] Key type ._llcrypt registered [ 2062.360923] Key type .llcrypt registered [ 2062.758239] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 11:13:03 (1775833983) [ 2063.501470] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2064.027405] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 11:13:04 (1775833984) [ 2064.799723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2064.839372] alg: No test for adler32 (adler32-zlib) [ 2065.695436] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 2065.770075] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2067.351149] Key type lgssc registered [ 2067.687798] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2083.809673] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2085.016543] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2090.868037] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2091.034201] Lustre: lustre: root_squash is set to 500:500 [ 2091.040624] Lustre: lustre: nosquash_nids set to 192.168.204.48/24@tcp [ 2092.045795] Lustre: Mounted lustre-client [ 2094.011879] LustreError: 84079:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8a424000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2094.043957] Lustre: Unmounted lustre-client [ 2102.893509] Key type lgssc unregistered [ 2103.012520] LNet: 84481:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2103.015240] LNetError: 84481:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2103.023351] LNet: Removed LNI 192.168.204.48@tcp [ 2103.239941] Key type .llcrypt unregistered [ 2103.241507] Key type ._llcrypt unregistered [ 2108.231102] Key type ._llcrypt registered [ 2108.232390] Key type .llcrypt registered [ 2108.713422] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2109.234554] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 11:13:49 (1775834029) [ 2114.594112] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2114.599747] alg: No test for adler32 (adler32-zlib) [ 2115.453509] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 2115.525743] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2117.103140] Key type lgssc registered [ 2117.441409] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2144.659301] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2145.771395] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2152.714855] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2181.536977] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2182.669733] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2188.386838] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2192.164290] Lustre: Mounted lustre-client [ 2202.083461] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8ccb86ae1000.ost_server_uuid 50 [ 2202.579539] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8ccb86ae1000.ost_server_uuid in FULL state after 0 sec [ 2202.706897] Lustre: Mounted lustre-client [ 2203.416183] LustreError: 91356:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8581c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2203.451180] Lustre: Unmounted lustre-client [ 2239.093572] Key type lgssc unregistered [ 2239.215502] LNet: 91928:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2239.219333] LNetError: 91928:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2239.227641] LNet: Removed LNI 192.168.204.48@tcp [ 2239.473959] Key type .llcrypt unregistered [ 2239.475770] Key type ._llcrypt unregistered [ 2249.626063] Key type ._llcrypt registered [ 2249.627242] Key type .llcrypt registered [ 2250.122118] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 11:16:10 (1775834170) [ 2255.760673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2255.809101] alg: No test for adler32 (adler32-zlib) [ 2256.675524] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 2256.756313] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2258.335193] Key type lgssc registered [ 2258.745441] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2287.748215] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2288.960393] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2296.547362] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2297.712799] Lustre: Mounted lustre-client [ 2312.940130] Lustre: lustre-OST0000-osc-ffff8ccb862a8000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2317.217366] Lustre: lustre-MDT0000-mdc-ffff8ccb862a8000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2318.303133] Lustre: 93286:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775834223/real 1775834223] req@00000000baa31b38 x1862097097987200/t0(0) o400->lustre-OST0000-osc-ffff8ccb862a8000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1775834239 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2323.423106] Lustre: 93286:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775834228/real 1775834228] req@000000009f418fe6 x1862097097987712/t0(0) o400->lustre-OST0000-osc-ffff8ccb862a8000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1775834244 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2328.032440] Lustre: lustre-OST0000-osc-ffff8ccb862a8000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 2332.319129] Lustre: 93288:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775834237/real 1775834237] req@00000000bd9424f9 x1862097097988864/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1775834253 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2332.329768] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 2332.337543] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0x530dd1620514d46f to 0x530dd1620514d72b [ 2332.343443] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 2333.401043] LustreError: 97086:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb862a8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2333.429143] Lustre: Unmounted lustre-client [ 2350.919431] Key type lgssc unregistered [ 2351.050859] LNet: 97488:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2351.053789] LNetError: 97488:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2351.068437] LNet: Removed LNI 192.168.204.48@tcp [ 2351.318507] Key type .llcrypt unregistered [ 2351.319761] Key type ._llcrypt unregistered [ 2356.407686] Key type ._llcrypt registered [ 2356.409016] Key type .llcrypt registered [ 2356.886131] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 11:17:57 (1775834277) [ 2368.540744] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2368.592053] alg: No test for adler32 (adler32-zlib) [ 2369.454034] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 2369.538504] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2371.127142] Key type lgssc registered [ 2371.521401] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2385.653071] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2416.432694] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2417.566434] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2424.219231] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2425.403793] Lustre: Mounted lustre-client [ 2426.117033] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2426.719161] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 11:19:06 (1775834346) [ 2480.267335] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2490.551828] Lustre: Unmounted lustre-client [ 2542.031189] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2543.306314] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2550.906880] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2568.418640] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 11:21:28 (1775834488) [ 2599.448580] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2600.820171] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2608.602293] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2614.255702] Lustre: Mounted lustre-client [ 2615.298144] LustreError: 115615:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85a19800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2615.330446] Lustre: Unmounted lustre-client [ 2641.985230] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 11:22:42 (1775834562) [ 2672.638128] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2673.756277] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2681.248603] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2681.421497] Lustre: Mounted lustre-client [ 2682.573777] LustreError: 119649:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85a1e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2682.606397] Lustre: Unmounted lustre-client [ 2700.027193] Key type lgssc unregistered [ 2700.148603] LNet: 120053:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2700.151552] LNetError: 120053:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2700.160753] LNet: Removed LNI 192.168.204.48@tcp [ 2700.417862] Key type .llcrypt unregistered [ 2700.418960] Key type ._llcrypt unregistered [ 2705.711625] Key type ._llcrypt registered [ 2705.712939] Key type .llcrypt registered [ 2706.201930] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 11:23:46 (1775834626) [ 2706.913560] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2706.942740] alg: No test for adler32 (adler32-zlib) [ 2707.806913] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 2707.899086] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2709.479233] Key type lgssc registered [ 2709.914219] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2727.383172] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2728.622219] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2734.689745] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2745.326895] Lustre: Mounted lustre-client [ 2756.042106] LustreError: 123147:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85606000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2756.076222] Lustre: Unmounted lustre-client [ 2773.784812] Key type lgssc unregistered [ 2773.892336] LNet: 123550:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2773.894495] LNetError: 123550:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2773.902457] LNet: Removed LNI 192.168.204.48@tcp [ 2774.154041] Key type .llcrypt unregistered [ 2774.155298] Key type ._llcrypt unregistered [ 2779.208174] Key type ._llcrypt registered [ 2779.209292] Key type .llcrypt registered [ 2779.699315] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 11:24:59 (1775834699) [ 2780.553854] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2780.560737] alg: No test for adler32 (adler32-zlib) [ 2781.436378] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 2781.527818] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2783.119178] Key type lgssc registered [ 2783.535599] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2801.223250] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2802.498649] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2808.606089] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2819.056739] Lustre: Mounted lustre-client [ 2824.163447] Lustre: lustre-OST0000-osc-ffff8ccb862ad800: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2837.759235] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8ccb862ad800.ost_server_uuid 50 [ 2838.302743] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff8ccb862ad800.ost_server_uuid in DISCONN state after 0 sec [ 2838.853530] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 2848.214666] LustreError: 127221:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb862ad800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2848.247601] Lustre: Unmounted lustre-client [ 2859.426304] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 11:26:19 (1775834779) [ 2869.010317] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2870.125768] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2875.699974] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2882.871126] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 2883.045955] Lustre: Mounted lustre-client [ 2888.163627] Lustre: lustre-OST0000-osc-ffff8ccb85a0f000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2902.345696] LustreError: 129866:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85a0f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2902.371441] Lustre: Unmounted lustre-client [ 2925.449503] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 11:27:25 (1775834845) [ 2934.833479] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2936.001852] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2941.784701] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2947.554961] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 2947.704330] Lustre: Mounted lustre-client [ 2953.186483] Lustre: lustre-OST0000-osc-ffff8ccb8326a000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2972.807508] LustreError: 132617:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8326a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2972.811697] LustreError: 132617:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 2972.843118] Lustre: Unmounted lustre-client [ 2996.150089] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 11:28:36 (1775834916) [ 3026.668403] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3027.861615] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3035.329485] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3075.023096] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3076.259347] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3082.496727] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3103.791070] Lustre: Mounted lustre-client [ 3131.056819] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3131.630804] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3131.947157] LustreError: 139193:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b330000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3131.952590] LustreError: 139193:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 3131.983824] Lustre: Unmounted lustre-client [ 3142.533793] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 11:31:02 (1775835062) [ 3152.472077] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3153.724448] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3159.694865] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3179.896212] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3192.945887] Lustre: Mounted lustre-client [ 3220.100183] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3220.692661] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3224.035175] Lustre: lustre-OST0001-osc-ffff8ccb892d8000: Connection to lustre-OST0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3228.383157] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3238.651939] Lustre: Unmounted lustre-client [ 3268.251900] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 11:33:08 (1775835188) [ 3278.144958] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3279.389083] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3285.464939] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3285.642746] Lustre: Mounted lustre-client [ 3293.043737] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3293.602445] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3297.638114] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8ccb85a08800.ost_server_uuid 50 [ 3298.128861] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8ccb85a08800.ost_server_uuid in FULL state after 0 sec [ 3298.771285] LustreError: 146179:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85a08800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3298.800126] Lustre: Unmounted lustre-client [ 3298.884152] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3298.887750] Lustre: Skipped 3 previous similar messages [ 3299.282993] LustreError: 146244:0:(sec.c:413:import_sec_validate_get()) import 000000008772f2e8 (NEW) with no sec [ 3330.148900] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 11:34:10 (1775835250) [ 3340.198473] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3341.423214] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3347.662760] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3353.815345] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3353.957988] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3354.001710] Lustre: Mounted lustre-client [ 3354.003330] Lustre: Skipped 1 previous similar message [ 3362.742510] LustreError: 149088:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb88b8f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3362.746678] LustreError: 149088:0:(lov_obd.c:786:lov_cleanup()) Skipped 2 previous similar messages [ 3362.781723] Lustre: Unmounted lustre-client [ 3362.782869] Lustre: Skipped 1 previous similar message [ 3387.576767] Key type lgssc unregistered [ 3387.692612] LNet: 149534:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3387.695542] LNetError: 149534:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3387.705043] LNet: Removed LNI 192.168.204.48@tcp [ 3387.951738] Key type .llcrypt unregistered [ 3387.953084] Key type ._llcrypt unregistered [ 3393.393630] Key type ._llcrypt registered [ 3393.394994] Key type .llcrypt registered [ 3393.874155] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 11:35:14 (1775835314) [ 3394.320351] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3394.342559] alg: No test for adler32 (adler32-zlib) [ 3395.231844] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 3395.315316] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3396.911182] Key type lgssc registered [ 3397.332730] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3415.287273] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3416.536726] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3422.773415] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3429.036501] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3429.184935] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3434.479897] Lustre: Mounted lustre-client [ 3437.163785] LustreError: lustre-MDT0001-mdc-ffff8ccb892df000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 3437.173055] Lustre: lustre-MDT0001-mdc-ffff8ccb892df000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 3439.184922] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3439.755820] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3445.102102] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3457.197796] LustreError: 153717:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb892df000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3457.227620] Lustre: Unmounted lustre-client [ 3476.513558] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 11:36:36 (1775835396) [ 3507.255063] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3508.440607] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3515.970872] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3516.139796] Lustre: Mounted lustre-client [ 3526.093137] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3526.691939] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3540.963233] Lustre: lustre-OST0001-osc-ffff8ccb8a582800: Connection to lustre-OST0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3544.747888] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3555.002146] Lustre: Unmounted lustre-client [ 3578.611394] Key type lgssc unregistered [ 3578.727385] LNet: 158842:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3578.730674] LNetError: 158842:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3578.738088] LNet: Removed LNI 192.168.204.48@tcp [ 3578.998640] Key type .llcrypt unregistered [ 3579.000040] Key type ._llcrypt unregistered [ 3589.217234] Key type ._llcrypt registered [ 3589.219071] Key type .llcrypt registered [ 3589.687700] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 11:38:29 (1775835509) [ 3590.457700] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3590.520793] alg: No test for adler32 (adler32-zlib) [ 3591.381052] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 3591.468415] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3593.055199] Key type lgssc registered [ 3593.463082] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3610.980752] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3612.170969] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3618.155763] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3619.309923] Lustre: Mounted lustre-client [ 3655.950140] LustreError: 162103:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8a584000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3655.979814] Lustre: Unmounted lustre-client [ 3672.320340] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3672.480337] Lustre: Mounted lustre-client [ 3704.675185] LustreError: 162755:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb890b3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3704.707099] Lustre: Unmounted lustre-client [ 3721.928636] Key type lgssc unregistered [ 3722.039470] LNet: 163162:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3722.042283] LNetError: 163162:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3722.049433] LNet: Removed LNI 192.168.204.48@tcp [ 3722.281891] Key type .llcrypt unregistered [ 3722.283395] Key type ._llcrypt unregistered [ 3727.546906] Key type ._llcrypt registered [ 3727.548832] Key type .llcrypt registered [ 3728.032594] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 11:40:48 (1775835648) [ 3728.736513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3728.784052] alg: No test for adler32 (adler32-zlib) [ 3729.650614] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 3729.750545] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3731.351230] Key type lgssc registered [ 3731.783331] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3750.683234] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3752.096079] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3758.404602] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3768.817854] Lustre: Mounted lustre-client [ 3775.575266] LustreError: 166418:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85a1c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3775.603165] Lustre: Unmounted lustre-client [ 3800.986164] Key type lgssc unregistered [ 3801.111568] LNet: 166821:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3801.114374] LNetError: 166821:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3801.124495] LNet: Removed LNI 192.168.204.48@tcp [ 3801.359247] Key type .llcrypt unregistered [ 3801.360546] Key type ._llcrypt unregistered [ 3805.915657] Key type ._llcrypt registered [ 3805.918346] Key type .llcrypt registered [ 3806.104899] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3806.136153] alg: No test for adler32 (adler32-zlib) [ 3807.007113] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 3807.096662] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3808.671208] Key type lgssc registered [ 3809.132157] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3826.740805] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3828.017142] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3834.842748] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3845.628444] Lustre: Mounted lustre-client [ 3848.858186] LustreError: 169390:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b334800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3848.893597] Lustre: Unmounted lustre-client [ 3874.947051] Key type lgssc unregistered [ 3875.063586] LNet: 169795:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3875.066499] LNetError: 169795:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3875.078990] LNet: Removed LNI 192.168.204.48@tcp [ 3875.332704] Key type .llcrypt unregistered [ 3875.334729] Key type ._llcrypt unregistered [ 3880.986432] Key type ._llcrypt registered [ 3880.987632] Key type .llcrypt registered [ 3881.449891] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:43:21 (1775835801) [ 3882.257161] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3882.292268] alg: No test for adler32 (adler32-zlib) [ 3883.160827] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 3883.247707] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3884.847212] Key type lgssc registered [ 3885.293218] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3903.023597] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3904.263393] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3910.051445] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3925.489344] Lustre: Mounted lustre-client [ 3932.730955] LustreError: 173053:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8400f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3932.760167] Lustre: Unmounted lustre-client [ 3958.753636] Key type lgssc unregistered [ 3958.869812] LNet: 173458:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3958.872568] LNetError: 173458:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3958.881053] LNet: Removed LNI 192.168.204.48@tcp [ 3959.104616] Key type .llcrypt unregistered [ 3959.106630] Key type ._llcrypt unregistered [ 3963.684820] Key type ._llcrypt registered [ 3963.696921] Key type .llcrypt registered [ 3963.938580] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3963.945377] alg: No test for adler32 (adler32-zlib) [ 3964.831293] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 3964.939953] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3966.551101] Key type lgssc registered [ 3966.945970] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3986.852866] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3988.285120] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3995.634521] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4006.386241] Lustre: Mounted lustre-client [ 4010.313246] LustreError: 176027:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb84a6e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4010.357049] Lustre: Unmounted lustre-client [ 4030.954267] Key type lgssc unregistered [ 4031.102320] LNet: 176430:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4031.107923] LNetError: 176430:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4031.124744] LNet: Removed LNI 192.168.204.48@tcp [ 4031.519450] Key type .llcrypt unregistered [ 4031.521874] Key type ._llcrypt unregistered [ 4037.085455] Key type ._llcrypt registered [ 4037.086306] Key type .llcrypt registered [ 4037.547871] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:45:57 (1775835957) [ 4044.122474] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4044.156979] alg: No test for adler32 (adler32-zlib) [ 4045.008103] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4045.096182] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4046.679145] Key type lgssc registered [ 4047.065323] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4074.878014] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4076.051555] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4083.037805] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4103.595894] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:47:03 (1775836023) [ 4112.548369] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4113.692807] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4119.609598] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4120.778048] Lustre: Mounted lustre-client [ 4122.731517] LustreError: 182925:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8967e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4122.763101] Lustre: Unmounted lustre-client [ 4139.855814] Key type lgssc unregistered [ 4139.981542] LNet: 183328:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4139.984306] LNetError: 183328:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4139.991696] LNet: Removed LNI 192.168.204.48@tcp [ 4140.232065] Key type .llcrypt unregistered [ 4140.233721] Key type ._llcrypt unregistered [ 4145.216110] Key type ._llcrypt registered [ 4145.218085] Key type .llcrypt registered [ 4145.712926] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4146.296443] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:47:46 (1775836066) [ 4151.953373] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4151.959698] alg: No test for adler32 (adler32-zlib) [ 4152.839169] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4152.945713] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4154.535192] Key type lgssc registered [ 4154.983343] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4186.723959] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4187.858672] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4195.284251] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 4201.456300] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 4202.611515] Lustre: Mounted lustre-client [ 4208.376130] LustreError: 188848:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb862ad000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 4208.407178] Lustre: Unmounted lustre-client [ 4271.136807] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4272.349301] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4279.723805] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4302.170889] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 11:50:22 (1775836222) [ 4302.751321] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4303.293288] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 11:50:23 (1775836223) [ 4322.201916] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4323.646696] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4350.777079] Key type lgssc unregistered [ 4350.892627] LNet: 195011:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4350.894781] LNetError: 195011:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4350.901501] LNet: Removed LNI 192.168.204.48@tcp [ 4351.112534] Key type .llcrypt unregistered [ 4351.114501] Key type ._llcrypt unregistered [ 4356.185348] Key type ._llcrypt registered [ 4356.186436] Key type .llcrypt registered [ 4356.658039] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 11:51:16 (1775836276) [ 4389.885184] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4389.891138] alg: No test for adler32 (adler32-zlib) [ 4390.746260] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4390.825323] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4392.407175] Key type lgssc registered [ 4392.759557] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4407.583706] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4408.887612] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4427.826482] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4439.015656] Key type lgssc unregistered [ 4439.145384] LNet: 198642:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4439.148805] LNetError: 198642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4439.160433] LNet: Removed LNI 192.168.204.48@tcp [ 4439.429527] Key type .llcrypt unregistered [ 4439.431136] Key type ._llcrypt unregistered [ 4444.556541] Key type ._llcrypt registered [ 4444.557804] Key type .llcrypt registered [ 4445.047160] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 11:52:45 (1775836365) [ 4445.839931] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4445.887417] alg: No test for adler32 (adler32-zlib) [ 4446.741028] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4446.822182] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4448.407141] Key type lgssc registered [ 4448.768845] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4468.147965] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4469.628565] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4478.174089] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4483.567061] Lustre: Mounted lustre-client [ 4488.675115] Lustre: lustre-MDT0000-mdc-ffff8ccb890b7800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4493.794868] Lustre: lustre-MDT0001-mdc-ffff8ccb890b7800: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4504.033597] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 4504.040366] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xdbef651fab4c0b5 to 0xdbef651fab4d9f9 [ 4504.045579] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4511.715478] Lustre: 201656:0:(mgc_request.c:1917:mgc_process_log()) MGC192.168.204.148@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4523.490292] LustreError: lustre-MDT0000-mdc-ffff8ccb890b7800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4523.510388] Lustre: lustre-MDT0000-mdc-ffff8ccb890b7800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4526.017550] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4526.540135] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4527.694600] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4534.372420] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 6 sec [ 4534.966896] LustreError: 203090:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb890b7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4534.993817] Lustre: Unmounted lustre-client [ 4552.442936] Key type lgssc unregistered [ 4552.581609] LNet: 203494:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4552.584525] LNetError: 203494:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4552.592736] LNet: Removed LNI 192.168.204.48@tcp [ 4552.812172] Key type .llcrypt unregistered [ 4552.813495] Key type ._llcrypt unregistered [ 4557.814081] Key type ._llcrypt registered [ 4557.815193] Key type .llcrypt registered [ 4558.254261] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 11:54:38 (1775836478) [ 4558.952279] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4558.987403] alg: No test for adler32 (adler32-zlib) [ 4559.837423] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4559.915306] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4561.495093] Key type lgssc registered [ 4561.865069] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4578.697540] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4579.874783] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4600.377361] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4601.589152] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4614.851957] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4621.282837] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4642.416385] Key type lgssc unregistered [ 4642.537391] LNet: 208591:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4642.540268] LNetError: 208591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4642.554375] LNet: Removed LNI 192.168.204.48@tcp [ 4642.793352] Key type .llcrypt unregistered [ 4642.794741] Key type ._llcrypt unregistered [ 4664.039434] Key type ._llcrypt registered [ 4664.040741] Key type .llcrypt registered [ 4664.530680] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 11:56:24 (1775836584) [ 4676.830373] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4676.891648] alg: No test for adler32 (adler32-zlib) [ 4677.756888] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4677.844267] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4679.439151] Key type lgssc registered [ 4679.789509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4708.576206] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4709.833503] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4717.412530] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4734.232256] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 11:57:34 (1775836654) [ 4736.589248] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 11:57:36 (1775836656) [ 4746.834159] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4747.985185] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4753.776881] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4769.265282] Lustre: Mounted lustre-client [ 4772.507920] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 4773.250774] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 4773.754063] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 4774.292450] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 4779.490063] Lustre: lustre-MDT0000-mdc-ffff8ccb89af6000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4789.729069] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 4789.735902] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xb5deccfba29fee18 to 0xb5deccfba29ff0aa [ 4789.739713] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4793.229738] Lustre: lustre-MDT0000-mdc-ffff8ccb89af6000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4794.578252] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4795.132752] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4797.040949] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 4799.969763] Lustre: lustre-MDT0000-mdc-ffff8ccb89af6000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4814.303138] Lustre: 216271:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775836719/real 1775836719] req@0000000084b31b4a x1862099636599296/t0(0) o101->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 328/344 e 0 to 1 dl 1775836735 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4814.311247] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 4814.314961] Lustre: 216271:0:(mgc_request.c:1917:mgc_process_log()) MGC192.168.204.148@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 4814.318920] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xb5deccfba29ff0aa to 0xb5deccfba29ff39e [ 4814.322385] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4817.406904] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4817.959195] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4819.497985] LustreError: 218713:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb89af6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4819.522701] Lustre: Unmounted lustre-client [ 4851.851438] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4853.036580] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4859.121987] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4874.740659] Lustre: Mounted lustre-client [ 4875.128735] LustreError: 220324:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb879aa800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4875.160142] Lustre: Unmounted lustre-client [ 4901.442210] Key type lgssc unregistered [ 4901.593660] LNet: 220728:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4901.598785] LNetError: 220728:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4901.610696] LNet: Removed LNI 192.168.204.48@tcp [ 4901.842295] Key type .llcrypt unregistered [ 4901.843563] Key type ._llcrypt unregistered [ 4907.072915] Key type ._llcrypt registered [ 4907.074372] Key type .llcrypt registered [ 4907.510192] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 12:00:27 (1775836827) [ 4909.045771] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4909.054749] alg: No test for adler32 (adler32-zlib) [ 4909.926782] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 4910.024052] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4911.615204] Key type lgssc registered [ 4911.996170] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4930.460512] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4931.750199] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4938.686688] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4948.984234] Lustre: Mounted lustre-client [ 4952.263421] LustreError: 223907:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb892de800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4952.304854] Lustre: Unmounted lustre-client [ 4986.256452] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4987.438120] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4993.064477] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5003.776799] Lustre: Mounted lustre-client [ 5010.107859] LustreError: 225503:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb84ad3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5010.136250] Lustre: Unmounted lustre-client [ 5047.683766] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5049.243548] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5055.677410] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5066.235582] Lustre: Mounted lustre-client [ 5066.579242] LustreError: 227116:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb862af800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5066.606181] Lustre: Unmounted lustre-client [ 5084.047304] Key type lgssc unregistered [ 5084.162737] LNet: 227519:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5084.165235] LNetError: 227519:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5084.178195] LNet: Removed LNI 192.168.204.48@tcp [ 5084.441236] Key type .llcrypt unregistered [ 5084.443822] Key type ._llcrypt unregistered [ 5089.499573] Key type ._llcrypt registered [ 5089.500772] Key type .llcrypt registered [ 5089.973912] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 12:03:30 (1775837010) [ 5091.030634] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5091.037829] alg: No test for adler32 (adler32-zlib) [ 5091.897454] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5091.979673] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5093.559175] Key type lgssc registered [ 5094.088216] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5111.714663] Key type lgssc unregistered [ 5111.837393] LNet: 229833:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5111.839834] LNetError: 229833:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5111.847396] LNet: Removed LNI 192.168.204.48@tcp [ 5112.082491] Key type .llcrypt unregistered [ 5112.083700] Key type ._llcrypt unregistered [ 5122.054725] Key type ._llcrypt registered [ 5122.055911] Key type .llcrypt registered [ 5122.173461] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5122.178703] alg: No test for adler32 (adler32-zlib) [ 5123.074360] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5123.169687] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5124.775300] Key type lgssc registered [ 5125.390637] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5155.946307] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5157.049552] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5164.373777] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5189.678588] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 5190.177723] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 12:05:10 (1775837110) [ 5200.973425] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5202.365377] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5209.834880] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5217.011258] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5218.206801] Lustre: Mounted lustre-client [ 5223.395370] Lustre: lustre-OST0001-osc-ffff8ccb840d3000: Connection to lustre-OST0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5225.862292] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5236.158246] Lustre: Unmounted lustre-client [ 5259.424318] Key type lgssc unregistered [ 5259.540822] LNet: 236718:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5259.543315] LNetError: 236718:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5259.550324] LNet: Removed LNI 192.168.204.48@tcp [ 5259.816824] Key type .llcrypt unregistered [ 5259.818613] Key type ._llcrypt unregistered [ 5269.659274] Key type ._llcrypt registered [ 5269.660331] Key type .llcrypt registered [ 5270.100721] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 12:06:30 (1775837190) [ 5274.378779] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5274.389211] alg: No test for adler32 (adler32-zlib) [ 5275.241514] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5275.319133] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5276.903183] Key type lgssc registered [ 5277.295490] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5293.649294] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5294.744963] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5314.895613] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 12:07:15 (1775837235) [ 5325.210564] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5326.363340] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5332.503107] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5333.664585] Lustre: Mounted lustre-client [ 5339.821954] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5341.070680] Lustre: Unmounted lustre-client [ 5391.474783] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5392.965735] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5424.519507] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5435.380077] Lustre: Mounted lustre-client [ 5435.794233] LustreError: 243779:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85032000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5435.823160] Lustre: Unmounted lustre-client [ 5453.180661] Key type lgssc unregistered [ 5453.297596] LNet: 244183:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5453.300057] LNetError: 244183:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5453.306737] LNet: Removed LNI 192.168.204.48@tcp [ 5453.530240] Key type .llcrypt unregistered [ 5453.531847] Key type ._llcrypt unregistered [ 5462.304249] Key type ._llcrypt registered [ 5462.305440] Key type .llcrypt registered [ 5462.537745] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5462.543202] alg: No test for adler32 (adler32-zlib) [ 5463.404328] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5463.494857] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5465.079112] Key type lgssc registered [ 5465.481318] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5491.389430] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5492.509889] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5499.153214] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5520.001679] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 5520.529071] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 12:10:40 (1775837440) [ 5529.509444] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5530.596306] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5536.377222] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5538.368511] Lustre: Mounted lustre-client [ 5538.970587] LustreError: 250213:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8b334000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5538.997737] Lustre: Unmounted lustre-client [ 5555.740886] Key type lgssc unregistered [ 5555.848567] LNet: 250615:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5555.851317] LNetError: 250615:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5555.860504] LNet: Removed LNI 192.168.204.48@tcp [ 5556.062577] Key type .llcrypt unregistered [ 5556.063577] Key type ._llcrypt unregistered [ 5561.068200] Key type ._llcrypt registered [ 5561.069164] Key type .llcrypt registered [ 5561.498978] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 5562.009137] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 12:11:22 (1775837482) [ 5564.977220] Key type .llcrypt unregistered [ 5564.978428] Key type ._llcrypt unregistered [ 5567.913685] Key type ._llcrypt registered [ 5567.919262] Key type .llcrypt registered [ 5568.135651] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5568.141958] alg: No test for adler32 (adler32-zlib) [ 5568.994323] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5569.084146] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5570.671200] Key type lgssc registered [ 5571.069385] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5589.231513] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5594.738357] Lustre: Mounted lustre-client [ 5595.194478] LustreError: 253631:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85035800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5595.226431] Lustre: Unmounted lustre-client [ 5612.658684] Key type lgssc unregistered [ 5612.773644] LNet: 254036:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5612.777558] LNetError: 254036:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5612.790760] LNet: Removed LNI 192.168.204.48@tcp [ 5613.027179] Key type .llcrypt unregistered [ 5613.028358] Key type ._llcrypt unregistered [ 5617.959633] Key type ._llcrypt registered [ 5617.960544] Key type .llcrypt registered [ 5618.374316] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 12:12:18 (1775837538) [ 5619.153154] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5619.161789] alg: No test for adler32 (adler32-zlib) [ 5620.026909] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5620.126334] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5621.719160] Key type lgssc registered [ 5622.119569] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5680.919739] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5690.491958] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5691.715464] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5692.886983] Lustre: Mounted lustre-client [ 5693.325802] LustreError: 257089:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85ed2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5693.350603] Lustre: Unmounted lustre-client [ 5710.401738] Key type lgssc unregistered [ 5710.516570] LNet: 257493:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5710.518922] LNetError: 257493:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5710.529734] LNet: Removed LNI 192.168.204.48@tcp [ 5710.747169] Key type .llcrypt unregistered [ 5710.748351] Key type ._llcrypt unregistered [ 5715.675284] Key type ._llcrypt registered [ 5715.676594] Key type .llcrypt registered [ 5716.122146] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 12:13:56 (1775837636) [ 5716.948644] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5716.957373] alg: No test for adler32 (adler32-zlib) [ 5717.825864] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5717.925414] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5719.511137] Key type lgssc registered [ 5719.915889] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5736.932858] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5738.145329] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5744.107212] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5759.985937] Lustre: Mounted lustre-client [ 5765.090174] Lustre: lustre-MDT0000-mdc-ffff8ccb85031800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5767.649081] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5767.657517] LustreError: 260557:0:(file.c:6097:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 5767.763342] LustreError: 260576:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85031800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5767.768625] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 5767.788213] Lustre: Unmounted lustre-client [ 5778.486911] Key type lgssc unregistered [ 5778.606402] LNet: 260970:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5778.610096] LNetError: 260970:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5778.618296] LNet: Removed LNI 192.168.204.48@tcp [ 5778.856090] Key type .llcrypt unregistered [ 5778.857154] Key type ._llcrypt unregistered [ 5783.976978] Key type ._llcrypt registered [ 5783.978198] Key type .llcrypt registered [ 5784.409524] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 12:15:04 (1775837704) [ 5785.152645] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5785.161522] alg: No test for adler32 (adler32-zlib) [ 5786.025891] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5786.109987] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5787.703171] Key type lgssc registered [ 5788.065692] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5804.441905] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5805.626978] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5811.581680] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5812.772602] Lustre: Mounted lustre-client [ 5817.827358] Lustre: lustre-MDT0001-mdc-ffff8ccb8900f800: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5820.197363] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5820.535305] LustreError: 264058:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8900f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5820.563924] Lustre: Unmounted lustre-client [ 5831.299415] Key type lgssc unregistered [ 5831.404536] LNet: 264452:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5831.406989] LNetError: 264452:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5831.414654] LNet: Removed LNI 192.168.204.48@tcp [ 5831.647672] Key type .llcrypt unregistered [ 5831.649301] Key type ._llcrypt unregistered [ 5837.121215] Key type ._llcrypt registered [ 5837.122839] Key type .llcrypt registered [ 5837.620039] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 12:15:57 (1775837757) [ 5843.342673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5843.353983] alg: No test for adler32 (adler32-zlib) [ 5844.233181] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5844.323086] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5845.911216] Key type lgssc registered [ 5846.289717] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5883.116519] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5885.302719] Lustre: Mounted lustre-client [ 5902.819127] Lustre: lustre-MDT0001-mdc-ffff8ccb8a334000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5906.189375] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5916.479206] Lustre: Unmounted lustre-client [ 5941.835288] Key type lgssc unregistered [ 5941.958578] LNet: 270199:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5941.961394] LNetError: 270199:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5941.970397] LNet: Removed LNI 192.168.204.48@tcp [ 5942.192496] Key type .llcrypt unregistered [ 5942.193647] Key type ._llcrypt unregistered [ 5947.404515] Key type ._llcrypt registered [ 5947.406144] Key type .llcrypt registered [ 5947.888891] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 12:17:48 (1775837868) [ 5948.444952] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 5949.017080] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 12:17:49 (1775837869) [ 5949.568373] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 5950.173662] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 12:17:50 (1775837870) [ 5950.730747] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 5951.341146] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 12:17:51 (1775837871) [ 5951.936683] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 5952.508181] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 12:17:52 (1775837872) [ 5953.079454] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 5953.668831] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 12:17:53 (1775837873) [ 5956.594399] Key type .llcrypt unregistered [ 5956.595713] Key type ._llcrypt unregistered [ 5958.866094] Key type ._llcrypt registered [ 5958.867451] Key type .llcrypt registered [ 5959.096690] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5959.102882] alg: No test for adler32 (adler32-zlib) [ 5959.964783] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 5960.063962] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5961.655166] Key type lgssc registered [ 5962.086291] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5988.316242] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5989.569701] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5997.208781] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5998.404859] Lustre: Mounted lustre-client [ 5998.880608] LustreError: 275780:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8a583800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5998.912858] Lustre: Unmounted lustre-client [ 6021.983771] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 12:19:02 (1775837942) [ 6032.253469] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6033.489754] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6052.620447] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6052.802774] Lustre: Mounted lustre-client [ 6053.148584] LustreError: 277890:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb892d8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6053.176414] Lustre: Unmounted lustre-client [ 6078.723665] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 12:19:59 (1775837999) [ 6109.599383] LNet: 1 local NIs in recovery (showing 1): 192.168.204.48@tcp [ 6698.998876] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6701.677540] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6727.817243] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6807.210566] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 12:32:06 (1775838726) [ 6816.558057] Key type lgssc unregistered [ 6816.802953] LNet: 283429:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6816.809243] LNetError: 283429:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6816.826600] LNet: Removed LNI 192.168.204.48@tcp [ 6817.328794] Key type .llcrypt unregistered [ 6817.331572] Key type ._llcrypt unregistered [ 6946.230987] Key type ._llcrypt registered [ 6946.235739] Key type .llcrypt registered [ 6946.566810] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6946.578166] alg: No test for adler32 (adler32-zlib) [ 6947.717081] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 6948.132318] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 6949.863441] Key type lgssc registered [ 6951.713800] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7068.450622] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7072.168407] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7088.630784] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7114.823665] Key type lgssc unregistered [ 7115.011978] LNet: 287040:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7115.019309] LNetError: 287040:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7115.042956] LNet: Removed LNI 192.168.204.48@tcp [ 7115.516594] Key type .llcrypt unregistered [ 7115.519323] Key type ._llcrypt unregistered [ 7148.965724] Key type ._llcrypt registered [ 7148.968519] Key type .llcrypt registered [ 7149.943983] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 12:37:49 (1775839069) [ 7165.000247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7165.023754] alg: No test for adler32 (adler32-zlib) [ 7166.032725] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 7166.236266] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7167.895220] Key type lgssc registered [ 7169.027716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7208.035123] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 12:38:47 (1775839127) [ 7217.307721] Key type lgssc unregistered [ 7217.567500] LNet: 290592:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7217.578539] LNetError: 290592:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7217.596319] LNet: Removed LNI 192.168.204.48@tcp [ 7218.121062] Key type .llcrypt unregistered [ 7218.125035] Key type ._llcrypt unregistered [ 7227.297485] Key type ._llcrypt registered [ 7227.300340] Key type .llcrypt registered [ 7227.608063] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7227.629511] alg: No test for adler32 (adler32-zlib) [ 7228.634864] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 7228.822105] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7230.487533] Key type lgssc registered [ 7231.366626] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7273.615510] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7277.347839] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7297.672305] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7578.020727] LNet: Added LNI 192.168.204.48@tcp50 [8/256/0/180] [ 7581.682336] LNet: Removed LNI 192.168.204.48@tcp [ 7584.022077] Lustre: 294895:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8ccb8a335000: config has no valid NIDs, force dynamic NIDs [ 7585.312030] Lustre: Mounted lustre-client [ 7585.418882] LustreError: 294910:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8a335000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7585.554397] Lustre: Unmounted lustre-client [ 7589.308251] Key type lgssc unregistered [ 7589.766325] LNet: 295160:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7589.776150] LNetError: 295160:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7589.796397] LNet: Removed LNI 192.168.204.48@tcp50 [ 7590.838665] Key type .llcrypt unregistered [ 7590.842396] Key type ._llcrypt unregistered [ 7611.280932] Key type ._llcrypt registered [ 7611.290581] Key type .llcrypt registered [ 7611.946734] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7611.961069] alg: No test for adler32 (adler32-zlib) [ 7613.151820] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 7613.492875] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7615.186662] Key type lgssc registered [ 7616.498823] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7677.881295] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7683.291186] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7692.462055] LNet: Added LNI 192.168.204.48@tcp50 [8/256/0/180] [ 7693.428695] LNet: Removed LNI 192.168.204.48@tcp [ 7694.625745] Lustre: 297793:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8ccb85037000: config has no valid NIDs, force dynamic NIDs [ 7695.918771] Lustre: Mounted lustre-client [ 7696.701146] LustreError: 297828:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb85037000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7696.832343] Lustre: Unmounted lustre-client [ 7743.592879] Key type lgssc unregistered [ 7744.034934] LNet: 298670:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7744.062826] LNetError: 298670:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7744.083786] LNet: Removed LNI 192.168.204.48@tcp50 [ 7744.834058] Key type .llcrypt unregistered [ 7744.839135] Key type ._llcrypt unregistered [ 7757.854763] Key type ._llcrypt registered [ 7757.859110] Key type .llcrypt registered [ 7759.469968] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 12:47:58 (1775839678) [ 7762.770389] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7762.799632] alg: No test for adler32 (adler32-zlib) [ 7763.960215] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 7764.253554] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7766.023601] Key type lgssc registered [ 7767.618538] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7829.651558] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7835.236981] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7859.560088] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7861.703706] Lustre: Mounted lustre-client [ 7921.975849] Lustre: Mounted fs15246-client [ 7937.123097] LustreError: 302818:0:(lov_obd.c:786:lov_cleanup()) fs15246-clilov-ffff8ccb8afd0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7937.180068] Lustre: Unmounted fs15246-client [ 7963.170115] LustreError: 303038:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ccb8506a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7963.245228] Lustre: Unmounted lustre-client [ 7989.651633] Key type lgssc unregistered [ 7989.906382] LNet: 303441:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7989.914504] LNetError: 303441:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7989.938553] LNet: Removed LNI 192.168.204.48@tcp [ 7990.683086] Key type .llcrypt unregistered [ 7990.685961] Key type ._llcrypt unregistered [ 7999.969592] Key type ._llcrypt registered [ 7999.973716] Key type .llcrypt registered [ 8001.269038] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 12:52:00 (1775839920) [ 8002.792251] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8002.826836] alg: No test for adler32 (adler32-zlib) [ 8003.849337] Lustre: Lustre: Build Version: 2.17.51_75_gd106f95 [ 8004.040346] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8005.735279] Key type lgssc registered [ 8006.737452] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8113.396480] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8116.648198] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8134.172282] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8211.893923] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 7940 sec ========== 12:55:31 (1775840131) [ 8213.295724] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 12:55:32 (1775840132) === [ 8215.693378] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 12:55:35 (1775840135) === [ 8241.899575] Key type lgssc unregistered [ 8242.104552] LNet: 312602:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8242.111791] LNetError: 312602:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8242.131474] LNet: Removed LNI 192.168.204.48@tcp [ 8242.729539] Key type .llcrypt unregistered [ 8242.733357] Key type ._llcrypt unregistered