[ 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-10.fc44 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 414515795 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 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 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: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002383] x2apic enabled [ 0.003007] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.007388] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009010] pid_max: default: 32768 minimum: 301 [ 0.010114] LSM: Security Framework initializing [ 0.011000] Yama: becoming mindful. [ 0.011027] SELinux: Initializing. [ 0.012047] *** VALIDATE selinux *** [ 0.019638] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024359] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025120] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026083] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027078] *** VALIDATE tmpfs *** [ 0.028365] *** VALIDATE proc *** [ 0.029143] *** VALIDATE cgroup *** [ 0.030005] *** VALIDATE cgroup2 *** [ 0.031169] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.032119] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.033006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.035019] Spectre V2 : User space: Vulnerable [ 0.036005] Speculative Store Bypass: Vulnerable [ 0.038000] debug: unmapping init [mem 0xffffffffb3e59000-0xffffffffb3e60fff] [ 0.039162] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.040615] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.041018] ... version: 2 [ 0.042012] ... bit width: 48 [ 0.043010] ... generic registers: 4 [ 0.044016] ... value mask: 0000ffffffffffff [ 0.045012] ... max period: 00007fffffffffff [ 0.046009] ... fixed-purpose events: 3 [ 0.047007] ... event mask: 000000070000000f [ 0.048291] rcu: Hierarchical SRCU implementation. [ 0.050294] smp: Bringing up secondary CPUs ... [ 0.051520] x86: Booting SMP configuration: [ 0.052036] .... node #0, CPUs: #1 #2 #3 [ 0.056764] smp: Brought up 1 node, 4 CPUs [ 0.057984] smpboot: Max logical packages: 1 [ 0.058020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.170000] node 0 deferred pages initialised in 110ms [ 0.175116] devtmpfs: initialized [ 0.176276] x86/mm: Memory block size: 128MB [ 0.180687] gcov: version magic: 0x41383552 [ 0.183153] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.187100] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.189287] pinctrl core: initialized pinctrl subsystem [ 0.191163] [ 0.191775] ************************************************************* [ 0.194012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.196011] ** ** [ 0.199011] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.200008] ** ** [ 0.203011] ** This means that this kernel is built to expose internal ** [ 0.205010] ** IOMMU data structures, which may compromise security on ** [ 0.207014] ** your system. ** [ 0.209012] ** ** [ 0.212016] ** If you see this message and you are not debugging the ** [ 0.214010] ** kernel, report this immediately to your vendor! ** [ 0.216013] ** ** [ 0.218013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.221013] ************************************************************* [ 0.224660] NET: Registered protocol family 16 [ 0.226370] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.229042] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.231070] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.235097] cpuidle: using governor menu [ 0.236806] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.240207] PCI: Using configuration type 1 for base access [ 0.243146] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.252120] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.254023] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.257275] cryptd: max_cpu_qlen set to 1000 [ 0.260159] ACPI: Added _OSI(Module Device) [ 0.262018] ACPI: Added _OSI(Processor Device) [ 0.264015] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.265010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.270135] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.276383] ACPI: Interpreter enabled [ 0.279070] ACPI: PM: (supports S0 S3 S4 S5) [ 0.280014] ACPI: Using IOAPIC for interrupt routing [ 0.282131] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.286422] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.294815] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.297041] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.300028] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.303099] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.310608] acpiphp: Slot [2] registered [ 0.312173] acpiphp: Slot [5] registered [ 0.314114] acpiphp: Slot [6] registered [ 0.316124] acpiphp: Slot [3] registered [ 0.317094] acpiphp: Slot [4] registered [ 0.319062] acpiphp: Slot [7] registered [ 0.320095] acpiphp: Slot [8] registered [ 0.321097] acpiphp: Slot [9] registered [ 0.323095] acpiphp: Slot [10] registered [ 0.324087] acpiphp: Slot [11] registered [ 0.325069] acpiphp: Slot [12] registered [ 0.327075] acpiphp: Slot [13] registered [ 0.328133] acpiphp: Slot [14] registered [ 0.330104] acpiphp: Slot [15] registered [ 0.331133] acpiphp: Slot [16] registered [ 0.333108] acpiphp: Slot [17] registered [ 0.334074] acpiphp: Slot [18] registered [ 0.336079] acpiphp: Slot [19] registered [ 0.337094] acpiphp: Slot [20] registered [ 0.338107] acpiphp: Slot [21] registered [ 0.340090] acpiphp: Slot [22] registered [ 0.342101] acpiphp: Slot [23] registered [ 0.343094] acpiphp: Slot [24] registered [ 0.345087] acpiphp: Slot [25] registered [ 0.347119] acpiphp: Slot [26] registered [ 0.348118] acpiphp: Slot [27] registered [ 0.349111] acpiphp: Slot [28] registered [ 0.350015] acpiphp: Slot [29] registered [ 0.352077] acpiphp: Slot [30] registered [ 0.353080] acpiphp: Slot [31] registered [ 0.354105] PCI host bridge to bus 0000:00 [ 0.356022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.359040] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.361028] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.364027] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.366027] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.369024] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.370168] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.374159] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.378358] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.385949] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.390013] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.394020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.396020] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.399021] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.401722] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.403808] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.405042] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.407913] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.411917] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.421019] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.425000] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.429627] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.434016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.442016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.460130] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.470014] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.488014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.495995] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.510007] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.519109] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.521430] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.524333] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.526400] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.530324] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.534715] iommu: Default domain type: Passthrough [ 0.536504] SCSI subsystem initialized [ 0.538064] ACPI: bus type USB registered [ 0.539097] usbcore: registered new interface driver usbfs [ 0.541075] usbcore: registered new interface driver hub [ 0.542066] usbcore: registered new device driver usb [ 0.544244] pps_core: LinuxPPS API ver. 1 registered [ 0.545007] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.548067] PTP clock support registered [ 0.550180] EDAC MC: Ver: 3.0.0 [ 0.553134] PCI: Using ACPI for IRQ routing [ 0.554917] NetLabel: Initializing [ 0.555012] NetLabel: domain hash size = 128 [ 0.556010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.557170] NetLabel: unlabeled traffic allowed by default [ 0.559356] vgaarb: loaded [ 0.560652] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.562014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.571093] clocksource: Switched to clocksource kvm-clock [ 0.673724] VFS: Disk quotas dquot_6.6.0 [ 0.675499] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.678030] *** VALIDATE ramfs *** [ 0.679179] *** VALIDATE hugetlbfs *** [ 0.681059] pnp: PnP ACPI init [ 0.683057] pnp: PnP ACPI: found 6 devices [ 0.704557] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.708978] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.711495] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.713162] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.714729] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.716563] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.719032] NET: Registered protocol family 2 [ 0.721665] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.726684] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.731533] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.737234] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.740276] TCP: Hash tables configured (established 65536 bind 65536) [ 0.742825] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.745633] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.748342] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.751285] NET: Registered protocol family 1 [ 0.753361] RPC: Registered named UNIX socket transport module. [ 0.755521] RPC: Registered udp transport module. [ 0.757284] RPC: Registered tcp transport module. [ 0.758756] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.761355] NET: Registered protocol family 44 [ 0.762438] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.763891] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.767909] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.769732] PCI: CLS 0 bytes, default 64 [ 0.771477] Unpacking initramfs... [ 2.138672] debug: unmapping init [mem 0xffff9cccbcc64000-0xffff9cccbffcffff] [ 2.142506] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.144961] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.147453] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.625294] Initialise system trusted keyrings [ 2.627288] Key type blacklist registered [ 2.629317] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.641175] zbud: loaded [ 2.644343] *** VALIDATE nfs *** [ 2.645313] *** VALIDATE nfs4 *** [ 2.647274] pstore: using deflate compression [ 2.651120] Platform Keyring initialized [ 2.760492] NET: Registered protocol family 38 [ 2.762760] Key type asymmetric registered [ 2.764392] Asymmetric key parser 'x509' registered [ 2.766535] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.770538] io scheduler mq-deadline registered [ 2.772234] io scheduler kyber registered [ 2.773759] io scheduler bfq registered [ 2.776107] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.779224] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.783466] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.786770] ACPI: Power Button [PWRF] [ 2.791526] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.798216] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.813646] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.842980] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.870926] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.876195] Non-volatile memory driver v1.3 [ 2.877764] Linux agpgart interface v0.103 [ 2.911723] virtio_blk virtio1: [vda] 146648 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.914177] vda: detected capacity change from 0 to 75083776 [ 2.927850] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.930689] vdb: detected capacity change from 0 to 1073741824 [ 2.936572] libphy: Fixed MDIO Bus: probed [ 2.944447] usbcore: registered new interface driver usbserial_generic [ 2.946884] usbserial: USB Serial support registered for generic [ 2.949397] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.954435] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.955939] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.958345] mousedev: PS/2 mouse device common for all mice [ 2.961419] rtc_cmos 00:05: RTC can wake from S4 [ 2.965580] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.968777] rtc_cmos 00:05: registered as rtc0 [ 2.971729] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.973217] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.977609] intel_pstate: CPU model not supported [ 2.982418] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.989424] hid: raw HID events driver (C) Jiri Kosina [ 2.991488] usbcore: registered new interface driver usbhid [ 2.993159] usbhid: USB HID core driver [ 2.994466] drop_monitor: Initializing network drop monitor service [ 2.996987] Initializing XFRM netlink socket [ 2.999602] NET: Registered protocol family 10 [ 3.004323] Segment Routing with IPv6 [ 3.006126] NET: Registered protocol family 17 [ 3.009043] mpls_gso: MPLS GSO support [ 3.014858] RAS: Correctable Errors collector initialized. [ 3.017325] AVX version of gcm_enc/dec engaged. [ 3.018691] AES CTR mode by8 optimization enabled [ 3.094145] sched_clock: Marking stable (3094109414, 0)->(3942319456, -848210042) [ 3.097491] registered taskstats version 1 [ 3.099257] Loading compiled-in X.509 certificates [ 3.101137] zswap: loaded using pool lzo/zbud [ 3.126852] Key type big_key registered [ 3.141464] Key type encrypted registered [ 3.143474] ima: No TPM chip found, activating TPM-bypass! [ 3.145711] ima: Allocated hash algorithm: sha1 [ 3.147730] ima: No architecture policies found [ 3.149681] evm: Initialising EVM extended attributes: [ 3.151613] evm: security.selinux [ 3.152854] evm: security.ima [ 3.153857] evm: security.capability [ 3.155008] evm: HMAC attrs: 0x1 [ 3.158116] rtc_cmos 00:05: setting system clock to 2026-09-08 11:13:55 UTC (1788866035) [ 3.163122] debug: unmapping init [mem 0xffffffffb4e03000-0xffffffffb4ffffff] [ 3.166256] debug: unmapping init [mem 0xffffffffb3b82000-0xffffffffb3e58fff] [ 3.173084] Write protecting the kernel read-only data: 28672k [ 3.176422] debug: unmapping init [mem 0xffffffffb2203000-0xffffffffb23fffff] [ 3.180140] debug: unmapping init [mem 0xffffffffb2b14000-0xffffffffb2bfffff] [ 3.208978] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.218440] systemd[1]: Detected virtualization kvm. [ 3.221031] systemd[1]: Detected architecture x86-64. [ 3.223169] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.250255] systemd[1]: No hostname configured. [ 3.251830] systemd[1]: Set hostname to . [ 3.254030] random: systemd: uninitialized urandom read (16 bytes read) [ 3.256598] systemd[1]: Initializing machine ID from random generator. [ 3.294075] random: ln: uninitialized urandom read (6 bytes read) [ 3.381835] random: systemd: uninitialized urandom read (16 bytes read) [ 3.384427] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.391204] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ 3.395632] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket. Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... Starting Create Volatile Files and Directories... [ OK ] Listening on udev Kernel Socket. Starting Setup Virtual Console... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Sockets. [ OK ] Reached target Timers. [ OK ] Reached target Slices. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.967433] device-mapper: uevent: version 1.0.3 [ 3.969137] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ 4.591993] random: fast init done [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.663322] virtio_net virtio0 ens2: renamed from eth0 [ 4.688393] scsi host0: ata_piix [ 4.698235] scsi host1: ata_piix [ 4.699611] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.701925] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.263771] dracut-initqueue[586]: RTNETLINK answers: File exists [ 9.661470] random: crng init done [ 9.664651] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.993968] 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... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Timers. [ OK ] Stopped dracut initqueue hook. [ 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 target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.178493] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.448484] SELinux: Disabled at runtime. [ 11.513930] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.523650] systemd[1]: Detected virtualization kvm. [ 11.526177] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.065508] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.068996] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.077492] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.082243] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.084952] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.097226] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.102274] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. Starting Create list of required st…ce nodes for the current kernel... Mounting POSIX Message Queue File System... [ OK ] Reached target rpc_pipefs.target. Mounting Huge Pages File System... [ OK ] Created slice User and Session Slice. [ OK ] Listening on Process Core Dump Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Stopped target Switch Root. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Stopped target Initrd Root File System. [FAILED] Failed to [ 12.200170] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Initrd File Systems. Mounting Kernel Debug File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Slices. [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Apply Kernel Variables... [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.559215] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.868333] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.907964] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.984790] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.003136] EDAC sbridge: Ver: 1.1.2 [ 14.181764] Key type dns_resolver registered [ 14.509298] NFS: Registering the id_resolver key type [ 14.511768] Key type id_resolver registered [ 14.514036] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Login Service... Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started irqbalance daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ 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 Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg652-client login: [ 40.437596] libcfs: loading out-of-tree module taints kernel. [ 40.460209] Key type ._llcrypt registered [ 40.466972] Key type .llcrypt registered [ 40.780822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 40.789835] alg: No test for adler32 (adler32-zlib) [ 41.800300] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 42.134802] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 43.759765] Key type lgssc registered [ 44.410421] Lustre: Echo OBD driver; http://www.lustre.org/ [ 110.531402] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 113.078227] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 118.722240] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing check_logdir /tmp/testlogs/ [ 120.168696] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing yml_node [ 121.701863] Lustre: DEBUG MARKER: Client: 2.17.57.104 [ 122.587407] Lustre: DEBUG MARKER: MDS: 2.17.57.104 [ 123.529975] Lustre: DEBUG MARKER: OSS: 2.17.57.104 [ 124.125399] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Tue Sep 8 07:15:55 EDT 2026 [ 130.510075] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 131.142765] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 131.698194] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 142.008706] Lustre: Unmounted lustre-client [ 211.689531] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 213.784770] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 222.318987] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 250.765781] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 07:18:02 (1788866282) [ 251.625917] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 252.273878] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 07:18:04 (1788866284) [ 264.306159] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 266.705867] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 275.687234] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 281.083503] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 283.051881] Lustre: Unmounted lustre-client [ 301.513389] Key type lgssc unregistered [ 301.641585] LNet: 14979:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 301.645651] LNetError: 14979:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 301.654786] LNet: Removed LNI 192.168.206.52@tcp [ 301.980127] Key type .llcrypt unregistered [ 301.982074] Key type ._llcrypt unregistered [ 308.128179] Key type ._llcrypt registered [ 308.129895] Key type .llcrypt registered [ 308.710744] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 07:19:00 (1788866340) [ 309.328348] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 309.337717] alg: No test for adler32 (adler32-zlib) [ 310.222329] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 310.349550] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 311.943304] Key type lgssc registered [ 312.408707] Lustre: Echo OBD driver; http://www.lustre.org/ [ 344.381893] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 426.666050] Lustre: Unmounted lustre-client [ 451.340583] Key type lgssc unregistered [ 451.489599] LNet: 18783:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 451.493790] LNetError: 18783:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 451.506779] LNet: Removed LNI 192.168.206.52@tcp [ 451.817290] Key type .llcrypt unregistered [ 451.819270] Key type ._llcrypt unregistered [ 456.161258] Key type ._llcrypt registered [ 456.162972] Key type .llcrypt registered [ 456.741577] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 07:21:28 (1788866488) [ 457.615688] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 457.668144] alg: No test for adler32 (adler32-zlib) [ 458.571806] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 458.677637] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 460.271184] Key type lgssc registered [ 460.794875] Lustre: Echo OBD driver; http://www.lustre.org/ [ 484.848537] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 487.868295] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 497.505281] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 504.294226] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 513.328937] Lustre: Unmounted lustre-client [ 531.913899] Key type lgssc unregistered [ 532.043389] LNet: 22369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 532.046806] LNetError: 22369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 532.054803] LNet: Removed LNI 192.168.206.52@tcp [ 532.391806] Key type .llcrypt unregistered [ 532.394307] Key type ._llcrypt unregistered [ 537.076480] Key type ._llcrypt registered [ 537.079198] Key type .llcrypt registered [ 537.776260] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 07:22:49 (1788866569) [ 538.885544] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 538.901763] alg: No test for adler32 (adler32-zlib) [ 539.827437] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 539.935836] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 541.535547] Key type lgssc registered [ 542.023986] Lustre: Echo OBD driver; http://www.lustre.org/ [ 563.040608] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 565.317951] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 574.190485] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 580.594623] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 587.497472] Lustre: Unmounted lustre-client [ 614.392836] Key type lgssc unregistered [ 614.535877] LNet: 25544:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 614.541047] LNetError: 25544:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 614.549799] LNet: Removed LNI 192.168.206.52@tcp [ 614.830936] Key type .llcrypt unregistered [ 614.832817] Key type ._llcrypt unregistered [ 620.360364] Key type ._llcrypt registered [ 620.361508] Key type .llcrypt registered [ 620.857412] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 07:24:12 (1788866652) [ 621.761325] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 621.776191] alg: No test for adler32 (adler32-zlib) [ 622.644528] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 622.742304] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 624.337128] Key type lgssc registered [ 624.818986] Lustre: Echo OBD driver; http://www.lustre.org/ [ 645.565843] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 648.250853] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 657.033304] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 663.526377] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 673.766093] Lustre: lustre-MDT0000-mdc-ffff9ccd06699000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 678.883362] Lustre: lustre-MDT0001-mdc-ffff9ccd06699000: Connection to lustre-MDT0001 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 684.964390] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 695.212506] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 695.225806] Lustre: Unmounted lustre-client [ 715.349383] Key type lgssc unregistered [ 715.487600] LNet: 29185:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 715.490652] LNetError: 29185:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 715.499249] LNet: Removed LNI 192.168.206.52@tcp [ 715.795430] Key type .llcrypt unregistered [ 715.796912] Key type ._llcrypt unregistered [ 722.173171] Key type ._llcrypt registered [ 722.175605] Key type .llcrypt registered [ 722.763415] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 07:25:54 (1788866754) [ 723.690194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 723.704811] alg: No test for adler32 (adler32-zlib) [ 724.580817] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 724.682292] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 726.279266] Key type lgssc registered [ 726.754300] Lustre: Echo OBD driver; http://www.lustre.org/ [ 752.382958] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 755.156887] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 765.046653] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 766.365526] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 776.675785] Lustre: lustre-OST0000-osc-ffff9ccd0669e000: Connection to lustre-OST0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 779.548827] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 789.821166] Lustre: Unmounted lustre-client [ 807.706373] Key type lgssc unregistered [ 807.833556] LNet: 32780:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 807.838813] LNetError: 32780:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 807.848345] LNet: Removed LNI 192.168.206.52@tcp [ 808.123629] Key type .llcrypt unregistered [ 808.125063] Key type ._llcrypt unregistered [ 814.156881] Key type ._llcrypt registered [ 814.158264] Key type .llcrypt registered [ 814.733638] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 07:27:26 (1788866846) [ 815.645925] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 815.723439] alg: No test for adler32 (adler32-zlib) [ 816.605200] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 816.715865] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 818.311218] Key type lgssc registered [ 818.796804] Lustre: Echo OBD driver; http://www.lustre.org/ [ 840.745349] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 842.890184] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 850.834168] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 856.571850] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 858.698996] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 860.142264] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 870.791385] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-08 7h28m22s [ 871.592450] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 877.026725] Lustre: lustre-MDT0000-mdc-ffff9ccd050f7000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 887.643458] LustreError: 36552:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff9ccd050f7000: can't stat MDS #0: rc = -19 [ 888.151627] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 893.887362] Lustre: DEBUG MARKER: Wait for df (36552) ... [ 894.432771] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 894.447248] Lustre: Evicted from MGS (at 192.168.206.152@tcp) after server handle changed from 0xe9a2fc506c19f7b9 to 0xe9a2fc506c19fb5c [ 894.454646] Lustre: MGC192.168.206.152@tcp: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 894.586234] Lustre: DEBUG MARKER: done [ 895.254820] Lustre: Unmounted lustre-client [ 913.086991] Key type lgssc unregistered [ 913.236397] LNet: 37560:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 913.239821] LNetError: 37560:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 913.249679] LNet: Removed LNI 192.168.206.52@tcp [ 913.513798] Key type .llcrypt unregistered [ 913.515544] Key type ._llcrypt unregistered [ 924.797269] Key type ._llcrypt registered [ 924.798452] Key type .llcrypt registered [ 925.302301] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 07:29:17 (1788866957) [ 926.084526] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 926.092334] alg: No test for adler32 (adler32-zlib) [ 926.968036] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 927.076664] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 928.671180] Key type lgssc registered [ 929.059746] Lustre: Echo OBD driver; http://www.lustre.org/ [ 950.239880] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 952.488226] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 960.133735] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 962.402721] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 964.763953] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-08 7h29m56s [ 965.392813] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 968.187225] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 969.155502] Lustre: DEBUG MARKER: Creating a test file and stat it [ 989.663134] Lustre: 41686:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788867001/real 1788867001] req@00000000a3716ac2 x1875762960405120/t0(0) o101->lustre-MDT0000-mdc-ffff9ccd097b7800@192.168.206.152@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788867021 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 989.678215] Lustre: lustre-MDT0000-mdc-ffff9ccd097b7800: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 989.693521] Lustre: lustre-MDT0000-mdc-ffff9ccd097b7800: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 1009.959761] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1011.306650] Lustre: DEBUG MARKER: done [ 1012.535048] Lustre: Unmounted lustre-client [ 1030.923409] Key type lgssc unregistered [ 1031.058685] LNet: 42566:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1031.066414] LNetError: 42566:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1031.077671] LNet: Removed LNI 192.168.206.52@tcp [ 1031.347466] Key type .llcrypt unregistered [ 1031.348829] Key type ._llcrypt unregistered [ 1042.962772] Key type ._llcrypt registered [ 1042.964594] Key type .llcrypt registered [ 1043.491455] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 07:31:15 (1788867075) [ 1044.095427] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1044.826996] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 07:31:16 (1788867076) [ 1046.446281] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1046.459116] alg: No test for adler32 (adler32-zlib) [ 1047.339388] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1047.447418] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1049.047212] Key type lgssc registered [ 1049.537611] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1062.066898] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 07:31:33 (1788867093) [ 1075.635735] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1077.770709] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1085.930016] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1092.583389] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1094.652650] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1095.568653] Lustre: Unmounted lustre-client [ 1105.726797] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1123.215392] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1125.298167] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1125.483248] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1126.436072] Lustre: Unmounted lustre-client [ 1154.851755] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1157.241251] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1157.496260] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1159.070564] Lustre: Unmounted lustre-client [ 1171.612155] Lustre: DEBUG MARKER: files compared the same [ 1185.899962] Key type lgssc unregistered [ 1186.033129] LNet: 50152:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1186.038421] LNetError: 50152:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1186.046636] LNet: Removed LNI 192.168.206.52@tcp [ 1186.336671] Key type .llcrypt unregistered [ 1186.337962] Key type ._llcrypt unregistered [ 1191.965483] Key type ._llcrypt registered [ 1191.966829] Key type .llcrypt registered [ 1192.518265] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 07:33:44 (1788867224) [ 1193.326773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1193.397140] alg: No test for adler32 (adler32-zlib) [ 1194.282844] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1194.383269] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1195.975265] Key type lgssc registered [ 1196.468766] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1217.446545] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1219.772080] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1228.229927] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1233.904078] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1235.661669] Lustre: Unmounted lustre-client [ 1246.275552] Key type lgssc unregistered [ 1246.408649] LNet: 53717:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1246.413268] LNetError: 53717:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1246.423850] LNet: Removed LNI 192.168.206.52@tcp [ 1246.728324] Key type .llcrypt unregistered [ 1246.730130] Key type ._llcrypt unregistered [ 1252.694368] Key type ._llcrypt registered [ 1252.695487] Key type .llcrypt registered [ 1253.272951] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 07:34:44 (1788867284) [ 1254.195374] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1254.202125] alg: No test for adler32 (adler32-zlib) [ 1255.086818] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1255.190683] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1256.783272] Key type lgssc registered [ 1257.198244] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1319.263340] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1332.442991] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1334.739395] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1353.698641] Key type lgssc unregistered [ 1353.854698] LNet: 57189:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1353.857560] LNetError: 57189:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1353.871279] LNet: Removed LNI 192.168.206.52@tcp [ 1354.197815] Key type .llcrypt unregistered [ 1354.199939] Key type ._llcrypt unregistered [ 1360.158770] Key type ._llcrypt registered [ 1360.160922] Key type .llcrypt registered [ 1360.713774] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 07:36:32 (1788867392) [ 1361.976274] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1362.038893] alg: No test for adler32 (adler32-zlib) [ 1362.933883] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1363.045364] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1364.633515] Key type lgssc registered [ 1365.114472] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1395.264279] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1400.650458] Lustre: Unmounted lustre-client [ 1422.994710] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 07:37:34 (1788867454) [ 1469.441284] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1486.850537] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1492.389581] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1492.393515] LustreError: 63633:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9ccd066a0000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1492.403815] Lustre: 58168:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.152@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1502.726813] Lustre: Unmounted lustre-client [ 1533.686215] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 07:39:25 (1788867565) [ 1539.047864] Key type lgssc unregistered [ 1539.182671] LNet: 64841:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1539.185946] LNetError: 64841:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1539.194554] LNet: Removed LNI 192.168.206.52@tcp [ 1539.519580] Key type .llcrypt unregistered [ 1539.520549] Key type ._llcrypt unregistered [ 1544.494834] Key type ._llcrypt registered [ 1544.505236] Key type .llcrypt registered [ 1544.790604] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1544.799190] alg: No test for adler32 (adler32-zlib) [ 1545.730709] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1545.857275] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1547.463534] Key type lgssc registered [ 1548.089652] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1570.514840] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1572.704560] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1580.659129] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1586.177647] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1588.183139] Lustre: Unmounted lustre-client [ 1599.029709] Key type lgssc unregistered [ 1599.182538] LNet: 67839:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1599.187560] LNetError: 67839:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1599.202254] LNet: Removed LNI 192.168.206.52@tcp [ 1599.548290] Key type .llcrypt unregistered [ 1599.551057] Key type ._llcrypt unregistered [ 1603.922054] Key type ._llcrypt registered [ 1603.927462] Key type .llcrypt registered [ 1604.116548] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1604.123165] alg: No test for adler32 (adler32-zlib) [ 1605.006741] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1605.115945] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1606.719184] Key type lgssc registered [ 1607.230725] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1654.510915] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1657.120348] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1666.585746] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1673.199375] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1679.073946] Lustre: Unmounted lustre-client [ 1715.224147] Key type lgssc unregistered [ 1715.380198] LNet: 71253:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1715.386522] LNetError: 71253:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1716.455950] LNet: Removed LNI 192.168.206.52@tcp [ 1716.820266] Key type .llcrypt unregistered [ 1716.822188] Key type ._llcrypt unregistered [ 1724.152780] Key type ._llcrypt registered [ 1724.154619] Key type .llcrypt registered [ 1724.858401] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 07:42:36 (1788867756) [ 1725.929485] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1726.005771] alg: No test for adler32 (adler32-zlib) [ 1726.919522] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1727.065855] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1728.671962] Key type lgssc registered [ 1729.288893] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1754.279208] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1757.003282] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1767.285979] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1769.675651] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1776.594058] Lustre: Unmounted lustre-client [ 1776.812225] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1778.232062] Lustre: Unmounted lustre-client [ 1806.063988] Key type lgssc unregistered [ 1806.224688] LNet: 74921:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1806.233561] LNetError: 74921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1806.246264] LNet: Removed LNI 192.168.206.52@tcp [ 1806.624433] Key type .llcrypt unregistered [ 1806.625965] Key type ._llcrypt unregistered [ 1811.935691] Key type ._llcrypt registered [ 1811.937705] Key type .llcrypt registered [ 1812.159304] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1812.170312] alg: No test for adler32 (adler32-zlib) [ 1813.077951] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1813.210335] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1814.831438] Key type lgssc registered [ 1815.433995] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1841.216242] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1844.011881] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1854.291366] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1855.716553] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1862.443578] Lustre: Unmounted lustre-client [ 1879.284456] Key type lgssc unregistered [ 1879.450405] LNet: 77940:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1879.457483] LNetError: 77940:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1879.470409] LNet: Removed LNI 192.168.206.52@tcp [ 1879.914180] Key type .llcrypt unregistered [ 1879.915530] Key type ._llcrypt unregistered [ 1889.316684] Key type ._llcrypt registered [ 1889.318879] Key type .llcrypt registered [ 1890.082826] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 07:45:21 (1788867921) [ 1891.365948] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1891.380177] alg: No test for adler32 (adler32-zlib) [ 1892.313059] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 1892.475645] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 1894.095153] Key type lgssc registered [ 1894.702871] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1919.240113] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1921.970230] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1932.141663] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1938.924326] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 1948.869820] Lustre: lustre: root_squash is set to 0:0 [ 1948.882363] Lustre: lustre: nosquash_nids is cleared [ 1956.353686] Lustre: lustre: root_squash is set to 500:500 [ 1963.070133] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.52@tcp 192.168.0.[2,10]@tcp [ 1970.168706] Lustre: lustre: nosquash_nids set to 192.168.206.52/24@tcp [ 1972.316538] Lustre: Unmounted lustre-client [ 1991.001315] Key type lgssc unregistered [ 1991.131432] LNet: 81902:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1991.138313] LNetError: 81902:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1991.154000] LNet: Removed LNI 192.168.206.52@tcp [ 1991.466492] Key type .llcrypt unregistered [ 1991.467917] Key type ._llcrypt unregistered [ 1997.793528] Key type ._llcrypt registered [ 1997.795125] Key type .llcrypt registered [ 1998.390598] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 07:47:10 (1788868030) [ 1999.406443] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2000.112303] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 07:47:11 (1788868031) [ 2000.972856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2000.993557] alg: No test for adler32 (adler32-zlib) [ 2001.888510] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 2001.993926] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 2003.591279] Key type lgssc registered [ 2004.098193] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2027.065235] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2029.485212] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2038.903126] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2040.174503] Lustre: lustre: root_squash is set to 500:500 [ 2040.184336] Lustre: lustre: nosquash_nids set to 192.168.206.52/24@tcp [ 2046.436532] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2049.051742] Lustre: Unmounted lustre-client [ 2063.593578] Key type lgssc unregistered [ 2063.737595] LNet: 85859:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2063.742914] LNetError: 85859:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2063.754798] LNet: Removed LNI 192.168.206.52@tcp [ 2064.048871] Key type .llcrypt unregistered [ 2064.055111] Key type ._llcrypt unregistered [ 2069.831643] Key type ._llcrypt registered [ 2069.832762] Key type .llcrypt registered [ 2070.344292] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2071.001644] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 07:48:22 (1788868102) [ 2078.762780] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2078.772174] alg: No test for adler32 (adler32-zlib) [ 2079.651680] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 2079.757794] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 2081.351163] Key type lgssc registered [ 2081.843902] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2120.333946] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2122.982189] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2133.981589] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2170.343412] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2173.104990] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2182.845460] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2191.379056] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2210.006394] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9ccd06a0c000.ost_server_uuid 50 [ 2210.675428] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9ccd06a0c000.ost_server_uuid in FULL state after 0 sec [ 2210.851360] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2212.057163] Lustre: Unmounted lustre-client [ 2242.265119] Key type lgssc unregistered [ 2242.410774] LNet: 93498:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2242.415127] LNetError: 93498:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2242.427709] LNet: Removed LNI 192.168.206.52@tcp [ 2242.750064] Key type .llcrypt unregistered [ 2242.751522] Key type ._llcrypt unregistered [ 2257.491120] Key type ._llcrypt registered [ 2257.492599] Key type .llcrypt registered [ 2258.196617] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 07:51:29 (1788868289) [ 2267.641246] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2267.675683] alg: No test for adler32 (adler32-zlib) [ 2268.564648] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 2268.687475] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 2270.295454] Key type lgssc registered [ 2270.922405] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2309.976443] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2312.394230] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2324.174160] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2331.147536] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2346.473240] Lustre: lustre-OST0000-osc-ffff9ccd04e75000: Connection to lustre-OST0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2351.591667] Lustre: lustre-MDT0000-mdc-ffff9ccd04e75000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2352.607258] Lustre: 94857:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788868368/real 1788868368] req@00000000a150d62c x1875764367595008/t0(0) o400->lustre-OST0000-osc-ffff9ccd04e75000@192.168.206.152@tcp:28/4 lens 224/224 e 0 to 1 dl 1788868384 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2356.703318] Lustre: 94857:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788868373/real 1788868373] req@000000004c36790c x1875764367595520/t0(0) o400->lustre-OST0000-osc-ffff9ccd04e75000@192.168.206.152@tcp:28/4 lens 224/224 e 0 to 1 dl 1788868389 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2366.687167] Lustre: 94854:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788868383/real 1788868383] req@000000007580064a x1875764367596544/t0(0) o400->MGC192.168.206.152@tcp@192.168.206.152@tcp:26/25 lens 224/224 e 0 to 1 dl 1788868399 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2366.701114] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 2366.708849] Lustre: 98021:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.206.152@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 2366.713194] Lustre: Evicted from MGS (at 192.168.206.152@tcp) after server handle changed from 0x85c86f5118439f35 to 0x85c86f511843a276 [ 2366.721442] Lustre: MGC192.168.206.152@tcp: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 2370.633977] Lustre: lustre-OST0000-osc-ffff9ccd04e75000: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 2371.294196] Lustre: Unmounted lustre-client [ 2390.892854] Key type lgssc unregistered [ 2391.045183] LNet: 99140:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2391.049493] LNetError: 99140:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2391.062855] LNet: Removed LNI 192.168.206.52@tcp [ 2391.440776] Key type .llcrypt unregistered [ 2391.442428] Key type ._llcrypt unregistered [ 2398.543459] Key type ._llcrypt registered [ 2398.544593] Key type .llcrypt registered [ 2399.136671] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 07:53:50 (1788868430) [ 2411.169968] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2411.175916] alg: No test for adler32 (adler32-zlib) [ 2412.099403] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 2412.241509] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 2413.855161] Key type lgssc registered [ 2414.429759] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2434.098251] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2478.770076] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2481.499430] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2492.267287] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2494.550864] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2495.419675] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2496.177940] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 07:55:27 (1788868527) [ 2593.347028] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2603.645200] Lustre: Unmounted lustre-client [ 2670.334727] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2672.937156] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2683.379487] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2703.825688] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 07:58:55 (1788868735) [ 2743.805049] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2746.187130] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2757.061388] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2757.398819] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2759.072528] Lustre: Unmounted lustre-client [ 2779.256967] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:00:10 (1788868810) [ 2819.336966] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2821.661176] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2832.163981] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2832.458929] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2834.564776] Lustre: Unmounted lustre-client [ 2853.954879] Key type lgssc unregistered [ 2854.094264] LNet: 122084:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2854.099845] LNetError: 122084:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2854.119065] LNet: Removed LNI 192.168.206.52@tcp [ 2854.469520] Key type .llcrypt unregistered [ 2854.470779] Key type ._llcrypt unregistered [ 2860.782976] Key type ._llcrypt registered [ 2860.784148] Key type .llcrypt registered [ 2861.339908] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 08:01:33 (1788868893) [ 2862.237047] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2862.262970] alg: No test for adler32 (adler32-zlib) [ 2863.146422] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 2863.253407] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 2864.847328] Key type lgssc registered [ 2865.357808] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2888.520400] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2891.457330] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2901.259954] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2907.634222] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 2922.493175] Lustre: Unmounted lustre-client [ 2941.157278] Key type lgssc unregistered [ 2941.296081] LNet: 125663:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2941.300104] LNetError: 125663:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2941.310673] LNet: Removed LNI 192.168.206.52@tcp [ 2941.592785] Key type .llcrypt unregistered [ 2941.594272] Key type ._llcrypt unregistered [ 2947.541324] Key type ._llcrypt registered [ 2947.542796] Key type .llcrypt registered [ 2948.077264] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 08:02:59 (1788868979) [ 2948.894688] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2948.920714] alg: No test for adler32 (adler32-zlib) [ 2949.794701] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 2949.900564] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 2951.503282] Key type lgssc registered [ 2951.945827] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2974.666591] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2976.946632] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2985.682629] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2992.110120] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3002.340243] Lustre: lustre-OST0000-osc-ffff9ccd04e76800: Connection to lustre-OST0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3007.303208] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9ccd04e76800.ost_server_uuid 50 [ 3007.929163] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff9ccd04e76800.ost_server_uuid in DISCONN state after 0 sec [ 3008.599614] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 3018.026039] Lustre: Unmounted lustre-client [ 3029.797254] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 08:04:21 (1788869061) [ 3042.747567] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3045.041902] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3053.912348] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3063.543252] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3063.775714] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3068.902899] Lustre: lustre-OST0000-osc-ffff9ccd0479b000: Connection to lustre-OST0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3084.923308] Lustre: Unmounted lustre-client [ 3111.417994] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 08:05:43 (1788869143) [ 3124.417319] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3126.810757] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3135.875623] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3144.975225] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3145.297640] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3150.313374] Lustre: lustre-OST0000-osc-ffff9ccd05c6b000: Connection to lustre-OST0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3171.202125] Lustre: Unmounted lustre-client [ 3200.299380] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 08:07:11 (1788869231) [ 3245.712486] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3248.516780] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3259.458407] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3293.940711] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3296.663200] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3306.141450] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3326.160401] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3357.003333] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3357.708970] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3358.204804] Lustre: Unmounted lustre-client [ 3379.868788] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 08:10:11 (1788869411) [ 3394.647678] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3397.554787] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3407.754306] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3425.725975] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3437.811859] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3467.204819] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3467.884796] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3468.772687] Lustre: lustre-OST0001-osc-ffff9ccd06ed3800: Connection to lustre-OST0001 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3476.394657] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3486.649253] Lustre: Unmounted lustre-client [ 3521.335370] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 08:12:32 (1788869552) [ 3535.149472] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3537.885671] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3547.443218] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3547.774767] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3560.597792] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3561.486540] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3569.210898] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9ccd04e73800.ost_server_uuid 50 [ 3570.111203] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9ccd04e73800.ost_server_uuid in FULL state after 0 sec [ 3571.526036] Lustre: Unmounted lustre-client [ 3571.674595] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3571.677783] Lustre: Skipped 3 previous similar messages [ 3571.735169] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3572.295175] LustreError: 149121:0:(sec.c:403:import_sec_validate_get()) import 00000000e2ce3106 (NEW) with no sec [ 3613.304674] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 08:14:04 (1788869644) [ 3627.255754] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3629.592952] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3638.269753] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3647.225967] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3647.392167] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3647.446523] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3659.058748] Lustre: Unmounted lustre-client [ 3659.060325] Lustre: Skipped 1 previous similar message [ 3686.832840] Key type lgssc unregistered [ 3686.977051] LNet: 152535:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3686.981208] LNetError: 152535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3686.994696] LNet: Removed LNI 192.168.206.52@tcp [ 3687.316784] Key type .llcrypt unregistered [ 3687.319065] Key type ._llcrypt unregistered [ 3693.861307] Key type ._llcrypt registered [ 3693.862852] Key type .llcrypt registered [ 3694.504807] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 08:15:26 (1788869726) [ 3694.913348] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3694.989844] alg: No test for adler32 (adler32-zlib) [ 3695.870767] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 3695.987106] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 3697.591178] Key type lgssc registered [ 3698.085901] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3721.555793] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3724.010871] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3733.094732] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3741.625681] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3741.817681] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3742.879120] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3748.853031] LustreError: lustre-MDT0001-mdc-ffff9ccd0978c000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 3748.862203] Lustre: lustre-MDT0001-mdc-ffff9ccd0978c000: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 3752.055340] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3752.720440] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3758.353764] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3765.914960] Lustre: Unmounted lustre-client [ 3786.493378] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 08:16:58 (1788869818) [ 3825.917922] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3828.154643] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3838.268835] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3843.582984] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 3856.521368] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3858.315938] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 3867.628399] Lustre: lustre-OST0001-osc-ffff9ccd04ffc800: Connection to lustre-OST0001 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3873.128803] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3883.388734] Lustre: Unmounted lustre-client [ 3908.365526] Key type lgssc unregistered [ 3908.507585] LNet: 162093:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3908.511156] LNetError: 162093:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3908.524566] LNet: Removed LNI 192.168.206.52@tcp [ 3908.860813] Key type .llcrypt unregistered [ 3908.862347] Key type ._llcrypt unregistered [ 3922.108802] Key type ._llcrypt registered [ 3922.110248] Key type .llcrypt registered [ 3922.760399] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 08:19:14 (1788869954) [ 3923.675736] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3923.703043] alg: No test for adler32 (adler32-zlib) [ 3924.594421] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 3924.704698] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 3926.303222] Key type lgssc registered [ 3926.821832] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3949.505819] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3952.003640] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3960.841323] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3967.472789] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4005.255321] Lustre: Unmounted lustre-client [ 4024.283812] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4024.515156] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4057.491351] Lustre: Unmounted lustre-client [ 4076.392131] Key type lgssc unregistered [ 4076.523782] LNet: 166517:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4076.528723] LNetError: 166517:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4076.537465] LNet: Removed LNI 192.168.206.52@tcp [ 4076.834138] Key type .llcrypt unregistered [ 4076.835531] Key type ._llcrypt unregistered [ 4083.263595] Key type ._llcrypt registered [ 4083.264980] Key type .llcrypt registered [ 4083.842697] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 08:21:55 (1788870115) [ 4084.773986] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4084.783275] alg: No test for adler32 (adler32-zlib) [ 4085.673625] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4085.786224] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4087.383118] Key type lgssc registered [ 4087.840217] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4108.085702] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4110.170103] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4117.075876] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4127.730077] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4135.411125] Lustre: Unmounted lustre-client [ 4153.047106] Key type lgssc unregistered [ 4153.164463] LNet: 170254:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4153.168745] LNetError: 170254:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4153.178618] LNet: Removed LNI 192.168.206.52@tcp [ 4153.441705] Key type .llcrypt unregistered [ 4153.442734] Key type ._llcrypt unregistered [ 4157.954458] Key type ._llcrypt registered [ 4157.955853] Key type .llcrypt registered [ 4158.140960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4158.147956] alg: No test for adler32 (adler32-zlib) [ 4159.055284] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4159.171342] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4160.775206] Key type lgssc registered [ 4161.215779] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4180.471763] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4182.334878] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4189.559793] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4199.925291] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4203.010403] Lustre: Unmounted lustre-client [ 4221.023257] Key type lgssc unregistered [ 4221.156698] LNet: 173302:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4221.159828] LNetError: 173302:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4221.170218] LNet: Removed LNI 192.168.206.52@tcp [ 4221.459490] Key type .llcrypt unregistered [ 4221.461185] Key type ._llcrypt unregistered [ 4227.023904] Key type ._llcrypt registered [ 4227.025201] Key type .llcrypt registered [ 4227.527264] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 08:24:19 (1788870259) [ 4228.277208] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4228.306476] alg: No test for adler32 (adler32-zlib) [ 4229.194814] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4229.289064] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4230.879285] Key type lgssc registered [ 4231.317090] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4250.840779] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4252.761352] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4259.587430] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4270.072779] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4277.581889] Lustre: Unmounted lustre-client [ 4295.802751] Key type lgssc unregistered [ 4295.935622] LNet: 177051:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4295.939154] LNetError: 177051:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4295.950896] LNet: Removed LNI 192.168.206.52@tcp [ 4296.253848] Key type .llcrypt unregistered [ 4296.255279] Key type ._llcrypt unregistered [ 4301.201829] Key type ._llcrypt registered [ 4301.203231] Key type .llcrypt registered [ 4301.315658] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4301.323347] alg: No test for adler32 (adler32-zlib) [ 4302.210060] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4302.323956] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4303.927325] Key type lgssc registered [ 4304.385676] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4325.209942] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4327.394368] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4335.210794] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4341.732098] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4348.553830] Lustre: Unmounted lustre-client [ 4365.995434] Key type lgssc unregistered [ 4366.121595] LNet: 180098:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4366.125168] LNetError: 180098:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4366.131586] LNet: Removed LNI 192.168.206.52@tcp [ 4366.368254] Key type .llcrypt unregistered [ 4366.369740] Key type ._llcrypt unregistered [ 4371.561940] Key type ._llcrypt registered [ 4371.563166] Key type .llcrypt registered [ 4372.070899] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 08:26:43 (1788870403) [ 4379.606473] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4379.616329] alg: No test for adler32 (adler32-zlib) [ 4380.493318] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4380.610502] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4382.207160] Key type lgssc registered [ 4382.650785] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4415.038379] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4417.478419] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4427.463460] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4450.882941] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 08:28:02 (1788870482) [ 4464.749504] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4466.773948] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4474.664905] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4480.009437] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4482.271630] Lustre: Unmounted lustre-client [ 4501.201768] Key type lgssc unregistered [ 4501.328718] LNet: 187168:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4501.332790] LNetError: 187168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4501.342798] LNet: Removed LNI 192.168.206.52@tcp [ 4501.648300] Key type .llcrypt unregistered [ 4501.650215] Key type ._llcrypt unregistered [ 4507.569689] Key type ._llcrypt registered [ 4507.570944] Key type .llcrypt registered [ 4508.180926] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4508.833623] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 08:29:00 (1788870540) [ 4516.197129] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4516.241041] alg: No test for adler32 (adler32-zlib) [ 4517.123382] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4517.226804] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4518.831291] Key type lgssc registered [ 4519.416971] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4559.603593] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4561.761426] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4571.222035] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4578.153830] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4579.360489] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4586.576155] Lustre: Unmounted lustre-client [ 4654.371959] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4656.470075] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4666.320225] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4685.463682] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 08:31:57 (1788870717) [ 4686.058338] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4686.714335] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 08:31:58 (1788870718) [ 4732.910253] Key type lgssc unregistered [ 4733.024727] LNet: 198559:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4733.028663] LNetError: 198559:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4733.040530] LNet: Removed LNI 192.168.206.52@tcp [ 4733.321871] Key type .llcrypt unregistered [ 4733.323250] Key type ._llcrypt unregistered [ 4740.801623] Key type ._llcrypt registered [ 4740.803086] Key type .llcrypt registered [ 4741.364706] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 08:32:53 (1788870773) [ 4766.002433] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4766.051158] alg: No test for adler32 (adler32-zlib) [ 4766.917105] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4767.020601] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4768.615205] Key type lgssc registered [ 4769.104925] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4786.937118] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4789.219832] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4810.083795] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4821.786268] Key type lgssc unregistered [ 4821.901533] LNet: 202272:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4821.904251] LNetError: 202272:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4821.914429] LNet: Removed LNI 192.168.206.52@tcp [ 4822.177782] Key type .llcrypt unregistered [ 4822.179183] Key type ._llcrypt unregistered [ 4827.503908] Key type ._llcrypt registered [ 4827.505680] Key type .llcrypt registered [ 4828.011732] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 08:34:19 (1788870859) [ 4828.831061] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4828.842995] alg: No test for adler32 (adler32-zlib) [ 4829.732209] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4829.851068] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4831.439276] Key type lgssc registered [ 4831.879497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4852.224722] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4854.085256] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4863.172476] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4869.598587] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 4879.842287] Lustre: lustre-MDT0000-mdc-ffff9ccd063d0000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4884.961758] Lustre: lustre-MDT0001-mdc-ffff9ccd063d0000: Connection to lustre-MDT0001 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4901.343208] Lustre: 203255:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788870917/real 1788870917] req@00000000423c884a x1875767053074944/t0(0) o400->MGC192.168.206.152@tcp@192.168.206.152@tcp:26/25 lens 224/224 e 0 to 1 dl 1788870933 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4901.354622] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 4911.524099] Lustre: Evicted from MGS (at 192.168.206.152@tcp) after server handle changed from 0x1edfa1e2c4b35525 to 0x1edfa1e2c4b37037 [ 4911.530053] Lustre: MGC192.168.206.152@tcp: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 4919.434550] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4924.834758] LustreError: lustre-MDT0000-mdc-ffff9ccd063d0000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4924.854299] Lustre: lustre-MDT0000-mdc-ffff9ccd063d0000: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 4926.151794] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 6 sec [ 4928.182348] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4928.785731] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4929.465183] Lustre: Unmounted lustre-client [ 4947.207663] Key type lgssc unregistered [ 4947.326395] LNet: 207238:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4947.329444] LNetError: 207238:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4947.338246] LNet: Removed LNI 192.168.206.52@tcp [ 4947.593732] Key type .llcrypt unregistered [ 4947.595198] Key type ._llcrypt unregistered [ 4953.270329] Key type ._llcrypt registered [ 4953.272138] Key type .llcrypt registered [ 4953.874652] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 08:36:25 (1788870985) [ 4954.915568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4954.976073] alg: No test for adler32 (adler32-zlib) [ 4955.870248] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 4955.969124] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 4957.567107] Key type lgssc registered [ 4958.067438] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4978.560382] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4980.787475] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5005.874771] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5008.117583] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5023.783366] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5031.884764] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5068.026533] Key type lgssc unregistered [ 5068.158381] LNet: 212508:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5068.161395] LNetError: 212508:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5068.169468] LNet: Removed LNI 192.168.206.52@tcp [ 5068.420735] Key type .llcrypt unregistered [ 5068.421786] Key type ._llcrypt unregistered [ 5091.201164] Key type ._llcrypt registered [ 5091.202561] Key type .llcrypt registered [ 5091.749531] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 08:38:43 (1788871123) [ 5105.647289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5105.675032] alg: No test for adler32 (adler32-zlib) [ 5106.552150] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 5106.644792] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 5108.231145] Key type lgssc registered [ 5108.800627] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5143.156304] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5145.308119] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5155.194583] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5180.712947] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 08:40:12 (1788871212) [ 5183.333912] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 08:40:15 (1788871215) [ 5196.417654] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5198.617671] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5206.498059] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5212.152262] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5215.564085] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 5216.226634] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5216.875961] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5217.532783] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 5222.372735] Lustre: lustre-MDT0000-mdc-ffff9ccd066a0000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5232.611342] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 5232.620167] Lustre: Evicted from MGS (at 192.168.206.152@tcp) after server handle changed from 0xc614bcc0eeff8622 to 0xc614bcc0eeff8898 [ 5232.624952] Lustre: MGC192.168.206.152@tcp: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 5236.814687] Lustre: lustre-MDT0000-mdc-ffff9ccd066a0000: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 5239.020812] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5239.710554] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5241.790707] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 5242.850182] Lustre: lustre-MDT0000-mdc-ffff9ccd066a0000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5258.212250] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 5258.222615] Lustre: Evicted from MGS (at 192.168.206.152@tcp) after server handle changed from 0xc614bcc0eeff8898 to 0xc614bcc0eeff8ba8 [ 5258.227173] Lustre: MGC192.168.206.152@tcp: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 5261.909554] Lustre: lustre-MDT0000-mdc-ffff9ccd066a0000: Connection restored to 192.168.206.152@tcp (at 192.168.206.152@tcp) [ 5264.072151] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5264.673892] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5266.453268] Lustre: Unmounted lustre-client [ 5301.346041] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5303.319433] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5310.821528] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5321.210570] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5321.650856] Lustre: Unmounted lustre-client [ 5332.035286] Key type lgssc unregistered [ 5332.165356] LNet: 224941:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5332.169450] LNetError: 224941:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5332.180289] LNet: Removed LNI 192.168.206.52@tcp [ 5332.454094] Key type .llcrypt unregistered [ 5332.455410] Key type ._llcrypt unregistered [ 5338.082977] Key type ._llcrypt registered [ 5338.084324] Key type .llcrypt registered [ 5338.555566] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 08:42:50 (1788871370) [ 5340.054245] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5340.084802] alg: No test for adler32 (adler32-zlib) [ 5340.953960] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 5341.056416] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 5342.655145] Key type lgssc registered [ 5343.111869] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5363.166274] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5365.319577] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5372.724889] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5383.156489] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5386.187091] Lustre: Unmounted lustre-client [ 5416.654706] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5418.801446] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5426.695115] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5432.309168] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5438.292590] Lustre: Unmounted lustre-client [ 5474.567184] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5476.668550] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5484.236468] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5494.777647] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5495.196199] Lustre: Unmounted lustre-client [ 5513.737320] Key type lgssc unregistered [ 5513.867356] LNet: 231955:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5513.871530] LNetError: 231955:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5513.881343] LNet: Removed LNI 192.168.206.52@tcp [ 5514.221895] Key type .llcrypt unregistered [ 5514.224207] Key type ._llcrypt unregistered [ 5520.928818] Key type ._llcrypt registered [ 5520.930417] Key type .llcrypt registered [ 5521.536198] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 08:45:53 (1788871553) [ 5523.255943] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5523.272461] alg: No test for adler32 (adler32-zlib) [ 5524.191086] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 5524.324663] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 5525.927186] Key type lgssc registered [ 5526.470823] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5545.998428] Key type lgssc unregistered [ 5546.133223] LNet: 234274:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5546.137222] LNetError: 234274:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5546.145316] LNet: Removed LNI 192.168.206.52@tcp [ 5546.474505] Key type .llcrypt unregistered [ 5546.476925] Key type ._llcrypt unregistered [ 5557.731766] Key type ._llcrypt registered [ 5557.733131] Key type .llcrypt registered [ 5557.945675] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5557.953497] alg: No test for adler32 (adler32-zlib) [ 5558.834409] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 5558.945983] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 5560.543151] Key type lgssc registered [ 5561.002404] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5593.836182] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5596.088783] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5605.680284] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5630.297300] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 5630.893927] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 08:47:42 (1788871662) [ 5643.493474] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5645.959593] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5654.052738] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5663.992600] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5665.241720] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5670.379186] Lustre: lustre-OST0001-osc-ffff9ccd06ac2000: Connection to lustre-OST0001 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5673.389110] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5683.651358] Lustre: Unmounted lustre-client [ 5709.181696] Key type lgssc unregistered [ 5709.329223] LNet: 241357:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5709.334477] LNetError: 241357:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5709.344902] LNet: Removed LNI 192.168.206.52@tcp [ 5709.652141] Key type .llcrypt unregistered [ 5709.653647] Key type ._llcrypt unregistered [ 5724.098282] Key type ._llcrypt registered [ 5724.099779] Key type .llcrypt registered [ 5724.706229] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 08:49:16 (1788871756) [ 5730.665467] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5730.678793] alg: No test for adler32 (adler32-zlib) [ 5731.567545] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 5731.666938] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 5733.271166] Key type lgssc registered [ 5733.722558] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5753.532227] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5755.706477] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5776.108638] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 08:50:07 (1788871807) [ 5789.319224] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5791.864372] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5801.350545] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5809.135431] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5814.303924] Lustre: Unmounted lustre-client [ 5870.346813] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5872.553155] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5904.087046] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5914.612107] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 5915.086081] Lustre: Unmounted lustre-client [ 5933.104810] Key type lgssc unregistered [ 5933.225592] LNet: 249000:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5933.228317] LNetError: 249000:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5933.237246] LNet: Removed LNI 192.168.206.52@tcp [ 5933.483832] Key type .llcrypt unregistered [ 5933.485676] Key type ._llcrypt unregistered [ 5944.649750] Key type ._llcrypt registered [ 5944.651262] Key type .llcrypt registered [ 5944.879143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5944.887542] alg: No test for adler32 (adler32-zlib) [ 5945.779818] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 5945.881894] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 5947.479389] Key type lgssc registered [ 5948.009925] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5982.903661] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5985.298273] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5994.854934] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6018.598175] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 6019.319975] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 08:54:11 (1788872051) [ 6032.919628] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6035.149809] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6043.313214] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6049.787048] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6050.693539] Lustre: Unmounted lustre-client [ 6068.520322] Key type lgssc unregistered [ 6068.653575] LNet: 255609:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6068.656828] LNetError: 255609:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6068.665369] LNet: Removed LNI 192.168.206.52@tcp [ 6068.942133] Key type .llcrypt unregistered [ 6068.944154] Key type ._llcrypt unregistered [ 6074.768354] Key type ._llcrypt registered [ 6074.770501] Key type .llcrypt registered [ 6075.300275] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 6075.931147] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 08:55:07 (1788872107) [ 6079.414241] Key type .llcrypt unregistered [ 6079.415685] Key type ._llcrypt unregistered [ 6082.459738] Key type ._llcrypt registered [ 6082.463267] Key type .llcrypt registered [ 6082.641034] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6082.647741] alg: No test for adler32 (adler32-zlib) [ 6083.507468] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 6083.602127] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 6085.191186] Key type lgssc registered [ 6085.657836] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6106.355894] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6117.384217] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6118.126866] Lustre: Unmounted lustre-client [ 6137.290757] Key type lgssc unregistered [ 6137.440170] LNet: 259047:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6137.445533] LNetError: 259047:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6137.457304] LNet: Removed LNI 192.168.206.52@tcp [ 6137.825473] Key type .llcrypt unregistered [ 6137.828240] Key type ._llcrypt unregistered [ 6145.305398] Key type ._llcrypt registered [ 6145.306777] Key type .llcrypt registered [ 6145.979325] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 08:56:17 (1788872177) [ 6147.069266] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6147.131822] alg: No test for adler32 (adler32-zlib) [ 6148.064428] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 6148.187093] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 6149.783298] Key type lgssc registered [ 6150.431361] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6214.082922] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6227.177733] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6229.384524] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6230.587196] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6231.174839] Lustre: Unmounted lustre-client [ 6249.054933] Key type lgssc unregistered [ 6249.182258] LNet: 262574:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6249.185618] LNetError: 262574:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6249.195553] LNet: Removed LNI 192.168.206.52@tcp [ 6249.473317] Key type .llcrypt unregistered [ 6249.475091] Key type ._llcrypt unregistered [ 6256.110880] Key type ._llcrypt registered [ 6256.112387] Key type .llcrypt registered [ 6256.713885] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 08:58:08 (1788872288) [ 6257.768517] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6257.775446] alg: No test for adler32 (adler32-zlib) [ 6258.671542] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 6258.784270] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 6260.375179] Key type lgssc registered [ 6260.872113] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6282.128155] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6284.402619] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6293.107962] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6299.651734] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6304.739744] Lustre: lustre-MDT0000-mdc-ffff9ccd04fff000: Connection to lustre-MDT0000 (at 192.168.206.152@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6307.689845] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6307.703507] LustreError: 265717:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 6307.870756] LustreError: MGC192.168.206.152@tcp: Connection to MGS (at 192.168.206.152@tcp) was lost; in progress operations using this service will fail [ 6307.899455] Lustre: Unmounted lustre-client [ 6320.174467] Key type lgssc unregistered [ 6320.309805] LNet: 266131:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6320.314203] LNetError: 266131:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6320.322413] LNet: Removed LNI 192.168.206.52@tcp [ 6320.679581] Key type .llcrypt unregistered [ 6320.681142] Key type ._llcrypt unregistered [ 6327.192589] Key type ._llcrypt registered [ 6327.193861] Key type .llcrypt registered [ 6327.734306] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 08:59:19 (1788872359) [ 6328.681199] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6328.690356] alg: No test for adler32 (adler32-zlib) [ 6329.566699] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 6329.662875] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 6331.255172] Key type lgssc registered [ 6331.715384] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6354.828174] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6357.426365] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6366.939729] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6369.291852] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6377.168761] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6377.786292] Lustre: Unmounted lustre-client [ 6389.035471] Key type lgssc unregistered [ 6389.163547] LNet: 269698:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6389.166679] LNetError: 269698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6389.174626] LNet: Removed LNI 192.168.206.52@tcp [ 6389.443834] Key type .llcrypt unregistered [ 6389.445680] Key type ._llcrypt unregistered [ 6395.490430] Key type ._llcrypt registered [ 6395.491781] Key type .llcrypt registered [ 6396.088453] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 09:00:27 (1788872427) [ 6403.460797] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6403.471208] alg: No test for adler32 (adler32-zlib) [ 6404.364763] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 6404.468886] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 6406.063177] Key type lgssc registered [ 6406.508700] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6450.997728] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6452.205820] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6474.606656] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6484.919576] Lustre: Unmounted lustre-client [ 6502.679854] Key type lgssc unregistered [ 6502.805630] LNet: 275468:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6502.808485] LNetError: 275468:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6502.817711] LNet: Removed LNI 192.168.206.52@tcp [ 6503.080334] Key type .llcrypt unregistered [ 6503.081834] Key type ._llcrypt unregistered [ 6508.507400] Key type ._llcrypt registered [ 6508.508377] Key type .llcrypt registered [ 6509.027360] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 09:02:20 (1788872540) [ 6509.633287] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 6510.256118] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 09:02:22 (1788872542) [ 6510.886351] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 6511.507800] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 09:02:23 (1788872543) [ 6512.170506] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 6512.936926] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 09:02:24 (1788872544) [ 6513.677122] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 6514.471272] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 09:02:26 (1788872546) [ 6515.146244] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 6515.856396] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 09:02:27 (1788872547) [ 6519.414314] Key type .llcrypt unregistered [ 6519.415209] Key type ._llcrypt unregistered [ 6522.003242] Key type ._llcrypt registered [ 6522.005543] Key type .llcrypt registered [ 6522.196944] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6522.211513] alg: No test for adler32 (adler32-zlib) [ 6523.095314] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 6523.200649] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 6524.791178] Key type lgssc registered [ 6525.294837] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6556.501182] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6558.522859] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6568.044466] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6569.261796] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6569.825138] Lustre: Unmounted lustre-client [ 6593.999622] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 09:03:45 (1788872625) [ 6606.325215] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6608.401456] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6629.129792] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6644.725746] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 6645.148910] Lustre: Unmounted lustre-client [ 6676.125499] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 09:05:07 (1788872707) [ 6685.023332] LNet: 1 local NIs in recovery (showing 1): 192.168.206.52@tcp [ 7272.716493] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7275.688698] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7298.967854] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7365.581825] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 09:16:37 (1788873397) [ 7370.778244] Key type lgssc unregistered [ 7370.935822] LNet: 288947:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7370.939789] LNetError: 288947:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7370.951364] LNet: Removed LNI 192.168.206.52@tcp [ 7371.347681] Key type .llcrypt unregistered [ 7371.349353] Key type ._llcrypt unregistered [ 7426.181838] Key type ._llcrypt registered [ 7426.184617] Key type .llcrypt registered [ 7426.377312] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7426.389057] alg: No test for adler32 (adler32-zlib) [ 7427.323320] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 7427.463909] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 7429.079492] Key type lgssc registered [ 7429.633407] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7468.462902] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7470.672396] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7480.536631] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7497.376893] Key type lgssc unregistered [ 7497.524861] LNet: 292612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7497.531060] LNetError: 292612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7497.541248] LNet: Removed LNI 192.168.206.52@tcp [ 7497.866930] Key type .llcrypt unregistered [ 7497.868656] Key type ._llcrypt unregistered [ 7530.865971] Key type ._llcrypt registered [ 7530.867554] Key type .llcrypt registered [ 7531.507821] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 09:19:23 (1788873563) [ 7540.210303] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7540.248235] alg: No test for adler32 (adler32-zlib) [ 7541.126460] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 7541.226638] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 7542.815441] Key type lgssc registered [ 7543.232759] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7562.643231] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 09:19:54 (1788873594) [ 7567.368578] Key type lgssc unregistered [ 7567.504821] LNet: 296154:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7567.510488] LNetError: 296154:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7567.519505] LNet: Removed LNI 192.168.206.52@tcp [ 7567.812950] Key type .llcrypt unregistered [ 7567.814235] Key type ._llcrypt unregistered [ 7572.411371] Key type ._llcrypt registered [ 7572.414572] Key type .llcrypt registered [ 7572.644104] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7572.651255] alg: No test for adler32 (adler32-zlib) [ 7573.564929] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 7573.681267] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 7575.303454] Key type lgssc registered [ 7575.829564] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7602.827521] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7605.381745] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7615.568587] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7725.306671] LNet: Added LNI 192.168.206.52@tcp50 [8/256/0/180] [ 7726.416296] LNet: Removed LNI 192.168.206.52@tcp [ 7728.008841] Lustre: 300511:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff9ccd052d7000: config has no valid NIDs, force dynamic NIDs [ 7729.108619] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 7729.217866] Lustre: Unmounted lustre-client [ 7730.488051] Key type lgssc unregistered [ 7730.640145] LNet: 300769:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7730.643974] LNetError: 300769:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7730.655464] LNet: Removed LNI 192.168.206.52@tcp50 [ 7730.930398] Key type .llcrypt unregistered [ 7730.932030] Key type ._llcrypt unregistered [ 7741.536598] Key type ._llcrypt registered [ 7741.537993] Key type .llcrypt registered [ 7741.698331] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7741.706088] alg: No test for adler32 (adler32-zlib) [ 7742.587437] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 7742.699308] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 7744.303168] Key type lgssc registered [ 7744.780644] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7775.882876] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7778.048180] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7780.990313] LNet: Added LNI 192.168.206.52@tcp50 [8/256/0/180] [ 7781.338902] LNet: Removed LNI 192.168.206.52@tcp [ 7782.453707] Lustre: 303445:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff9ccd082bb000: config has no valid NIDs, force dynamic NIDs [ 7783.536593] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 7783.785244] Lustre: Unmounted lustre-client [ 7812.224263] Key type lgssc unregistered [ 7812.388618] LNet: 304314:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7812.393409] LNetError: 304314:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7812.410575] LNet: Removed LNI 192.168.206.52@tcp50 [ 7812.665598] Key type .llcrypt unregistered [ 7812.666814] Key type ._llcrypt unregistered [ 7817.289548] Key type ._llcrypt registered [ 7817.290784] Key type .llcrypt registered [ 7817.875580] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 09:24:09 (1788873849) [ 7825.688127] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7825.696059] alg: No test for adler32 (adler32-zlib) [ 7826.586260] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 7826.693613] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 7828.295137] Key type lgssc registered [ 7828.786596] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7865.511746] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7868.122174] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7880.821810] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7901.780712] Key type lgssc unregistered [ 7901.921606] LNet: 309041:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7901.927868] LNetError: 309041:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7901.939593] LNet: Removed LNI 192.168.206.52@tcp [ 7902.241951] Key type .llcrypt unregistered [ 7902.243430] Key type ._llcrypt unregistered [ 7906.758392] Key type ._llcrypt registered [ 7906.760072] Key type .llcrypt registered [ 7907.370052] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 09:25:39 (1788873939) [ 7908.480860] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7908.498163] alg: No test for adler32 (adler32-zlib) [ 7909.402825] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 7909.505962] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 7911.111157] Key type lgssc registered [ 7911.613068] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7933.089371] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7935.072419] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7943.279042] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7948.812871] Lustre: Mounted lustre-client - version 2.17.57_104_g1a15c94 [ 7973.347398] Lustre: Mounted fs15246-client - version 2.17.57_104_g1a15c94 [ 7979.427404] Lustre: Unmounted fs15246-client [ 7993.935873] Lustre: Unmounted lustre-client [ 8012.501739] Key type lgssc unregistered [ 8012.636854] LNet: 313889:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8012.642824] LNetError: 313889:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8012.651374] LNet: Removed LNI 192.168.206.52@tcp [ 8012.967552] Key type .llcrypt unregistered [ 8012.969290] Key type ._llcrypt unregistered [ 8017.392916] Key type ._llcrypt registered [ 8017.393962] Key type .llcrypt registered [ 8017.954547] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 09:27:29 (1788874049) [ 8018.641774] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8018.652841] alg: No test for adler32 (adler32-zlib) [ 8019.533773] Lustre: Lustre: Build Version: 2.17.57_104_g1a15c94 [ 8019.639363] LNet: Added LNI 192.168.206.52@tcp [8/256/0/180] [ 8021.223157] Key type lgssc registered [ 8021.657897] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8076.760863] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8079.000885] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8089.268020] Lustre: DEBUG MARKER: oleg652-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8136.799076] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 8012 sec ========== 09:29:28 (1788874168) [ 8137.470367] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 09:29:29 (1788874169) === [ 8138.873084] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 09:29:30 (1788874170) === [ 8151.724121] Key type lgssc unregistered [ 8151.857796] LNet: 323116:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8151.861323] LNetError: 323116:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8151.872379] LNet: Removed LNI 192.168.206.52@tcp [ 8152.148071] Key type .llcrypt unregistered [ 8152.149743] Key type ._llcrypt unregistered