[ 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 424722272 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: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.003218] x2apic enabled [ 0.004009] Switched APIC routing to physical x2apic. [ 0.005018] kvm-guest: setup PV IPIs [ 0.009000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010012] pid_max: default: 32768 minimum: 301 [ 0.011140] LSM: Security Framework initializing [ 0.012054] Yama: becoming mindful. [ 0.013043] SELinux: Initializing. [ 0.014075] *** VALIDATE selinux *** [ 0.023392] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028415] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029158] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030116] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031125] *** VALIDATE tmpfs *** [ 0.033321] *** VALIDATE proc *** [ 0.034213] *** VALIDATE cgroup *** [ 0.035007] *** VALIDATE cgroup2 *** [ 0.037239] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038119] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040031] Spectre V2 : User space: Vulnerable [ 0.041011] Speculative Store Bypass: Vulnerable [ 0.044235] debug: unmapping init [mem 0xffffffffb1059000-0xffffffffb1060fff] [ 0.046177] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047710] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048025] ... version: 2 [ 0.049016] ... bit width: 48 [ 0.050014] ... generic registers: 4 [ 0.051015] ... value mask: 0000ffffffffffff [ 0.052017] ... max period: 00007fffffffffff [ 0.053014] ... fixed-purpose events: 3 [ 0.054013] ... event mask: 000000070000000f [ 0.055325] rcu: Hierarchical SRCU implementation. [ 0.057461] smp: Bringing up secondary CPUs ... [ 0.058568] x86: Booting SMP configuration: [ 0.059029] .... node #0, CPUs: #1 #2 #3 [ 0.063095] smp: Brought up 1 node, 4 CPUs [ 0.065014] smpboot: Max logical packages: 1 [ 0.066016] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.158574] node 0 deferred pages initialised in 89ms [ 0.162119] devtmpfs: initialized [ 0.163274] x86/mm: Memory block size: 128MB [ 0.166809] gcov: version magic: 0x41383552 [ 0.169191] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.173115] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.176304] pinctrl core: initialized pinctrl subsystem [ 0.177168] [ 0.177752] ************************************************************* [ 0.180010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.183011] ** ** [ 0.185010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.187023] ** ** [ 0.189011] ** This means that this kernel is built to expose internal ** [ 0.191011] ** IOMMU data structures, which may compromise security on ** [ 0.194013] ** your system. ** [ 0.196007] ** ** [ 0.198013] ** If you see this message and you are not debugging the ** [ 0.201013] ** kernel, report this immediately to your vendor! ** [ 0.204011] ** ** [ 0.206011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.208012] ************************************************************* [ 0.211657] NET: Registered protocol family 16 [ 0.214408] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.217070] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.219046] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.221336] cpuidle: using governor menu [ 0.222718] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.225547] PCI: Using configuration type 1 for base access [ 0.227128] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.237106] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.240029] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.243279] cryptd: max_cpu_qlen set to 1000 [ 0.247133] ACPI: Added _OSI(Module Device) [ 0.248012] ACPI: Added _OSI(Processor Device) [ 0.249013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.250045] ACPI: Added _OSI(Processor Aggregator Device) [ 0.255000] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.261589] ACPI: Interpreter enabled [ 0.263069] ACPI: PM: (supports S0 S3 S4 S5) [ 0.265005] ACPI: Using IOAPIC for interrupt routing [ 0.266137] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.270506] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.281320] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.284043] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.287024] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.290089] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.295532] acpiphp: Slot [2] registered [ 0.297132] acpiphp: Slot [5] registered [ 0.298126] acpiphp: Slot [6] registered [ 0.299138] acpiphp: Slot [3] registered [ 0.301169] acpiphp: Slot [4] registered [ 0.302116] acpiphp: Slot [7] registered [ 0.304127] acpiphp: Slot [8] registered [ 0.305103] acpiphp: Slot [9] registered [ 0.307154] acpiphp: Slot [10] registered [ 0.308107] acpiphp: Slot [11] registered [ 0.310137] acpiphp: Slot [12] registered [ 0.312114] acpiphp: Slot [13] registered [ 0.313103] acpiphp: Slot [14] registered [ 0.315104] acpiphp: Slot [15] registered [ 0.317128] acpiphp: Slot [16] registered [ 0.318168] acpiphp: Slot [17] registered [ 0.320084] acpiphp: Slot [18] registered [ 0.321105] acpiphp: Slot [19] registered [ 0.323179] acpiphp: Slot [20] registered [ 0.324098] acpiphp: Slot [21] registered [ 0.326085] acpiphp: Slot [22] registered [ 0.327079] acpiphp: Slot [23] registered [ 0.328118] acpiphp: Slot [24] registered [ 0.330098] acpiphp: Slot [25] registered [ 0.331094] acpiphp: Slot [26] registered [ 0.332122] acpiphp: Slot [27] registered [ 0.334117] acpiphp: Slot [28] registered [ 0.336134] acpiphp: Slot [29] registered [ 0.338122] acpiphp: Slot [30] registered [ 0.339109] acpiphp: Slot [31] registered [ 0.341075] PCI host bridge to bus 0000:00 [ 0.345037] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.349023] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.352027] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.356034] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.360031] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.364025] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.366268] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.371325] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.377293] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.389014] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.402833] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.405016] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.408017] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.412017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.414730] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.418982] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.421060] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.427035] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.438018] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.470015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.478014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.486304] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.499085] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.506015] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.526015] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.544853] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.555015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.561015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.582017] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.597411] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.605008] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.614347] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.616325] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.619212] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.623132] iommu: Default domain type: Passthrough [ 0.627415] SCSI subsystem initialized [ 0.629139] ACPI: bus type USB registered [ 0.635113] usbcore: registered new interface driver usbfs [ 0.644122] usbcore: registered new interface driver hub [ 0.653078] usbcore: registered new device driver usb [ 0.657220] pps_core: LinuxPPS API ver. 1 registered [ 0.661011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.665107] PTP clock support registered [ 0.671051] EDAC MC: Ver: 3.0.0 [ 0.673147] PCI: Using ACPI for IRQ routing [ 0.675277] NetLabel: Initializing [ 0.676014] NetLabel: domain hash size = 128 [ 0.679022] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.680142] NetLabel: unlabeled traffic allowed by default [ 0.685974] vgaarb: loaded [ 0.690283] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.691015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.698949] clocksource: Switched to clocksource kvm-clock [ 0.987618] VFS: Disk quotas dquot_6.6.0 [ 0.989772] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.992830] *** VALIDATE ramfs *** [ 0.994225] *** VALIDATE hugetlbfs *** [ 0.996087] pnp: PnP ACPI init [ 1.004100] pnp: PnP ACPI: found 6 devices [ 1.036061] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 1.039886] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.042213] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.046652] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.066201] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.076110] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 1.084385] NET: Registered protocol family 2 [ 1.095497] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 1.114690] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 1.135111] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 1.149568] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 1.158936] TCP: Hash tables configured (established 65536 bind 65536) [ 1.172115] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 1.175045] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.177955] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.188124] NET: Registered protocol family 1 [ 1.204912] RPC: Registered named UNIX socket transport module. [ 1.213093] RPC: Registered udp transport module. [ 1.218312] RPC: Registered tcp transport module. [ 1.224186] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.225758] NET: Registered protocol family 44 [ 1.227696] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.233984] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.239131] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.241054] PCI: CLS 0 bytes, default 64 [ 1.242362] Unpacking initramfs... [ 4.749186] debug: unmapping init [mem 0xffff9a8dbcc64000-0xffff9a8dbffcffff] [ 4.758822] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 4.762618] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 4.766955] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 5.741576] Initialise system trusted keyrings [ 5.743045] Key type blacklist registered [ 5.746347] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 5.770911] zbud: loaded [ 5.774918] *** VALIDATE nfs *** [ 5.776527] *** VALIDATE nfs4 *** [ 5.778464] pstore: using deflate compression [ 5.805922] Platform Keyring initialized [ 6.180094] NET: Registered protocol family 38 [ 6.183665] Key type asymmetric registered [ 6.187716] Asymmetric key parser 'x509' registered [ 6.194419] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 6.199159] io scheduler mq-deadline registered [ 6.205675] io scheduler kyber registered [ 6.212278] io scheduler bfq registered [ 6.219470] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 6.222234] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 6.237210] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.246935] ACPI: Power Button [PWRF] [ 6.257319] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 6.270582] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 6.292754] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 6.341587] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 6.384632] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 6.394658] Non-volatile memory driver v1.3 [ 6.396781] Linux agpgart interface v0.103 [ 6.485242] virtio_blk virtio1: [vda] 146640 512-byte logical blocks (75.1 MB/71.6 MiB) [ 6.496919] vda: detected capacity change from 0 to 75079680 [ 6.536310] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 6.541378] vdb: detected capacity change from 0 to 1073741824 [ 6.550260] libphy: Fixed MDIO Bus: probed [ 6.570799] usbcore: registered new interface driver usbserial_generic [ 6.574113] usbserial: USB Serial support registered for generic [ 6.577178] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 6.583548] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 6.588124] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 6.593135] mousedev: PS/2 mouse device common for all mice [ 6.598911] rtc_cmos 00:05: RTC can wake from S4 [ 6.619176] rtc_cmos 00:05: registered as rtc0 [ 6.622783] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 6.624162] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 6.630191] intel_pstate: CPU model not supported [ 6.647737] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 6.648639] hid: raw HID events driver (C) Jiri Kosina [ 6.663652] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 6.677432] usbcore: registered new interface driver usbhid [ 6.678985] usbhid: USB HID core driver [ 6.680632] drop_monitor: Initializing network drop monitor service [ 6.684321] Initializing XFRM netlink socket [ 6.687610] NET: Registered protocol family 10 [ 6.692436] Segment Routing with IPv6 [ 6.693891] NET: Registered protocol family 17 [ 6.696598] mpls_gso: MPLS GSO support [ 6.703889] RAS: Correctable Errors collector initialized. [ 6.707230] AVX version of gcm_enc/dec engaged. [ 6.709948] AES CTR mode by8 optimization enabled [ 6.944164] sched_clock: Marking stable (6944141119, 0)->(7930192197, -986051078) [ 6.948960] registered taskstats version 1 [ 6.952433] Loading compiled-in X.509 certificates [ 6.956242] zswap: loaded using pool lzo/zbud [ 7.003426] Key type big_key registered [ 7.025283] Key type encrypted registered [ 7.030710] ima: No TPM chip found, activating TPM-bypass! [ 7.035316] ima: Allocated hash algorithm: sha1 [ 7.038520] ima: No architecture policies found [ 7.040768] evm: Initialising EVM extended attributes: [ 7.046159] evm: security.selinux [ 7.049607] evm: security.ima [ 7.054416] evm: security.capability [ 7.058544] evm: HMAC attrs: 0x1 [ 7.061355] rtc_cmos 00:05: setting system clock to 2026-09-02 06:10:55 UTC (1788329455) [ 7.071172] debug: unmapping init [mem 0xffffffffb2003000-0xffffffffb21fffff] [ 7.074524] debug: unmapping init [mem 0xffffffffb0d82000-0xffffffffb1058fff] [ 7.088386] Write protecting the kernel read-only data: 28672k [ 7.095456] debug: unmapping init [mem 0xffffffffaf403000-0xffffffffaf5fffff] [ 7.099115] debug: unmapping init [mem 0xffffffffafd14000-0xffffffffafdfffff] [ 7.221416] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 7.250345] systemd[1]: Detected virtualization kvm. [ 7.256141] systemd[1]: Detected architecture x86-64. [ 7.261976] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 7.317975] systemd[1]: No hostname configured. [ 7.329755] systemd[1]: Set hostname to . [ 7.335258] random: systemd: uninitialized urandom read (16 bytes read) [ 7.341178] systemd[1]: Initializing machine ID from random generator. [ 7.458334] random: ln: uninitialized urandom read (6 bytes read) [ 7.645766] random: systemd: uninitialized urandom read (16 bytes read) [ 7.649424] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 7.667143] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 7.698241] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Setup Virtual Console... [ OK ] Listening on udev Control Socket. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Reached target Swap. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Sockets. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 9.228669] device-mapper: uevent: version 1.0.3 [ 9.231471] 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. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 11.010308] virtio_net virtio0 ens2: renamed from eth0 [ 11.056772] random: fast init done [ 11.176534] scsi host0: ata_piix [ 11.262198] scsi host1: ata_piix [ 11.273589] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 11.284544] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 16.567084] random: crng init done [ 16.573405] random: 7 urandom warning(s) missed due to ratelimiting [ 17.804508] dracut-initqueue[585]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 19.298791] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ 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 Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 22.172042] printk: systemd: 26 output lines suppressed due to ratelimiting [ 23.205361] SELinux: Disabled at runtime. [ 23.326587] 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) [ 23.338809] systemd[1]: Detected virtualization kvm. [ 23.340954] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 24.887835] systemd[1]: initrd-switch-root.service: Succeeded. [ 24.898664] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 24.919887] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 24.935816] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 24.949441] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 24.972986] systemd[1]: Starting Journal Service... Starting Journal Service... [ 25.000410] systemd[1]: Created slice system-getty.slice. [ OK ] Created slice system-getty.slice. [ OK ] Listening on udev Control Socket. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Activating swap /dev/disk/by-label/SWAP... Starting Apply Kernel Variables... [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Create list of required st…ce nodes for the current kernel... [ 25.253728] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Starting Remount Root and Kernel File Systems... [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target rpc_pipefs.target. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-serial\x2dgetty.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 26.948641] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 27.898868] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 27.914150] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 28.384474] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 28.560156] EDAC sbridge: Ver: 1.1.2 [ 31.029105] hrtimer: interrupt took 4339519 ns [* ] A start job is running for Configur…-only root support (7s / no limit)[ 32.868883] Key type dns_resolver registered [** ] A start job is running for Configur…-only root support (8s / no limit) [*** ] A start job is running for Configur…-only root support (8s / no limit)[ 33.804709] NFS: Registering the id_resolver key type [ 33.817976] Key type id_resolver registered [ 33.821357] Key type id_legacy registered [ *** ] A start job is running for Configur…-only root support (9s / no limit) [ *** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting 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. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg360-client login: [ 99.298625] libcfs: loading out-of-tree module taints kernel. [ 99.405250] Key type ._llcrypt registered [ 99.411280] Key type .llcrypt registered [ 99.931513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 99.962344] alg: No test for adler32 (adler32-zlib) [ 101.507482] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 102.367262] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 104.136808] Key type lgssc registered [ 106.031467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 277.417468] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 282.013460] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 293.479956] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing check_logdir /tmp/testlogs/ [ 298.204967] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing yml_node [ 303.076059] Lustre: lustre-OST0000-osc-ffff9a8e20567000: disconnect after 23s idle [ 303.576888] Lustre: DEBUG MARKER: Client: 2.17.57.104 [ 306.313724] Lustre: DEBUG MARKER: MDS: 2.17.57.104 [ 309.129421] Lustre: DEBUG MARKER: OSS: 2.17.57.104 [ 310.608325] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Sep 2 02:15:57 EDT 2026 [ 328.264717] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 329.995610] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 333.223175] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 343.591269] Lustre: Unmounted lustre-client [ 456.626520] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 461.158616] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 480.988888] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 523.899692] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 02:19:31 (1788329971) [ 526.139758] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 527.985824] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 02:19:34 (1788329974) [ 557.247678] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 562.535850] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 582.856465] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 583.396137] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 588.619463] Lustre: Unmounted lustre-client [ 625.720755] Key type lgssc unregistered [ 626.147709] LNet: 15017:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 626.164051] LNetError: 15017:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 626.181216] LNet: Removed LNI 192.168.203.60@tcp [ 627.258161] Key type .llcrypt unregistered [ 627.260909] Key type ._llcrypt unregistered [ 642.401861] Key type ._llcrypt registered [ 642.404989] Key type .llcrypt registered [ 643.746472] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 02:21:30 (1788330090) [ 645.146914] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 645.162251] alg: No test for adler32 (adler32-zlib) [ 646.320540] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 646.661071] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 648.392126] Key type lgssc registered [ 649.342480] Lustre: Echo OBD driver; http://www.lustre.org/ [ 724.083249] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 810.140525] Lustre: Unmounted lustre-client [ 839.336272] Key type lgssc unregistered [ 839.639956] LNet: 18828:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 839.647967] LNetError: 18828:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 839.676231] LNet: Removed LNI 192.168.203.60@tcp [ 840.583079] Key type .llcrypt unregistered [ 840.585585] Key type ._llcrypt unregistered [ 850.734154] Key type ._llcrypt registered [ 850.744684] Key type .llcrypt registered [ 852.137418] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 02:24:58 (1788330298) [ 854.531868] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 854.668984] alg: No test for adler32 (adler32-zlib) [ 855.741491] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 856.077303] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 857.777064] Key type lgssc registered [ 859.024966] Lustre: Echo OBD driver; http://www.lustre.org/ [ 908.712386] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 915.531940] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 938.982865] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 940.692866] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 954.275050] Lustre: Unmounted lustre-client [ 990.525495] Key type lgssc unregistered [ 990.739290] LNet: 22427:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 990.750185] LNetError: 22427:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 990.776663] LNet: Removed LNI 192.168.203.60@tcp [ 991.598565] Key type .llcrypt unregistered [ 991.602546] Key type ._llcrypt unregistered [ 1002.772269] Key type ._llcrypt registered [ 1002.779185] Key type .llcrypt registered [ 1004.094580] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 02:27:30 (1788330450) [ 1006.070731] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1006.157725] alg: No test for adler32 (adler32-zlib) [ 1007.302965] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 1007.494384] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 1009.120172] Key type lgssc registered [ 1010.322212] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1060.342629] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1066.787691] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1086.233734] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1088.927861] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 1097.794978] Lustre: Unmounted lustre-client [ 1128.483219] Key type lgssc unregistered [ 1128.833377] LNet: 25612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1128.841644] LNetError: 25612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1128.858908] LNet: Removed LNI 192.168.203.60@tcp [ 1129.594586] Key type .llcrypt unregistered [ 1129.597265] Key type ._llcrypt unregistered [ 1145.835764] Key type ._llcrypt registered [ 1145.839625] Key type .llcrypt registered [ 1147.452353] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 02:29:54 (1788330594) [ 1150.459632] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1150.524132] alg: No test for adler32 (adler32-zlib) [ 1151.746726] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 1152.051735] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 1153.824245] Key type lgssc registered [ 1155.638702] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1214.012669] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1221.030476] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1242.391718] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1244.170957] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 1254.376798] Lustre: lustre-MDT0000-mdc-ffff9a8e11e21000: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1264.640801] Lustre: lustre-MDT0001-mdc-ffff9a8e11e21000: Connection to lustre-MDT0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1271.874572] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1274.849176] Lustre: 26568:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788330707/real 1788330707] req@000000008b5cd789 x1875200547231744/t0(0) o400->MGC192.168.203.160@tcp@192.168.203.160@tcp:26/25 lens 224/224 e 0 to 1 dl 1788330723 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1274.872107] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [ 1282.231497] Lustre: Unmounted lustre-client [ 1295.360672] Key type lgssc unregistered [ 1295.806120] LNet: 29265:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1295.815319] LNetError: 29265:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1295.840142] LNet: Removed LNI 192.168.203.60@tcp [ 1296.621421] Key type .llcrypt unregistered [ 1296.623565] Key type ._llcrypt unregistered [ 1311.558705] Key type ._llcrypt registered [ 1311.561425] Key type .llcrypt registered [ 1312.958326] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 02:32:39 (1788330759) [ 1315.072330] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1315.211042] alg: No test for adler32 (adler32-zlib) [ 1316.206138] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 1316.413781] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 1318.112337] Key type lgssc registered [ 1319.304698] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1369.814903] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1374.998437] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1395.482064] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1397.364047] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 1402.347509] Lustre: lustre-OST0000-osc-ffff9a8e07333800: Connection to lustre-OST0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1409.712694] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1420.051783] Lustre: Unmounted lustre-client [ 1455.309408] Key type lgssc unregistered [ 1455.573488] LNet: 32872:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1455.581259] LNetError: 32872:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1455.593902] LNet: Removed LNI 192.168.203.60@tcp [ 1456.396712] Key type .llcrypt unregistered [ 1456.400937] Key type ._llcrypt unregistered [ 1472.708612] Key type ._llcrypt registered [ 1472.710280] Key type .llcrypt registered [ 1474.184613] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 02:35:21 (1788330921) [ 1476.920425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1476.984900] alg: No test for adler32 (adler32-zlib) [ 1478.154414] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 1478.453719] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 1480.128839] Key type lgssc registered [ 1481.342121] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1532.011728] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1538.266557] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1558.955750] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1560.642323] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 1572.115226] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1576.101764] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1587.948958] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-02 2h37m14s [ 1590.206261] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1596.394964] Lustre: lustre-MDT0000-mdc-ffff9a8e0319b800: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1600.542472] LustreError: 36657:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff9a8e0319b800: can't stat MDS #0: rc = -19 [ 1602.043818] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1609.716816] LustreError: lustre-MDT0000-mdc-ffff9a8e0319b800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1609.748555] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [ 1609.749827] Lustre: lustre-MDT0000-mdc-ffff9a8e0319b800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 1609.766785] Lustre: Evicted from MGS (at 192.168.203.160@tcp) after server handle changed from 0xd4444ffb97d752ef to 0xd4444ffb97d755a4 [ 1616.113120] Lustre: DEBUG MARKER: Wait for df (36657) ... [ 1617.442809] Lustre: DEBUG MARKER: done [ 1620.181516] Lustre: Unmounted lustre-client [ 1657.357455] Key type lgssc unregistered [ 1657.603878] LNet: 37672:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1657.609154] LNetError: 37672:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1657.626921] LNet: Removed LNI 192.168.203.60@tcp [ 1658.290225] Key type .llcrypt unregistered [ 1658.296733] Key type ._llcrypt unregistered [ 1691.463325] Key type ._llcrypt registered [ 1691.467432] Key type .llcrypt registered [ 1693.258347] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 02:38:59 (1788331139) [ 1696.267747] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1696.306078] alg: No test for adler32 (adler32-zlib) [ 1697.367679] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 1697.608470] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 1699.363972] Key type lgssc registered [ 1700.773180] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1755.826099] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1762.094387] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1785.554790] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1788.175401] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 1792.866283] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-02 2h40m39s [ 1794.521569] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1800.996317] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1803.740517] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1824.224582] Lustre: 41830:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788331252/real 1788331252] req@0000000061b65d74 x1875201119755008/t0(0) o101->lustre-MDT0000-mdc-ffff9a8e11141800@192.168.203.160@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788331272 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1824.249769] Lustre: lustre-MDT0000-mdc-ffff9a8e11141800: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1824.275515] Lustre: lustre-MDT0000-mdc-ffff9a8e11141800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 1845.839359] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1848.972150] Lustre: DEBUG MARKER: done [ 1853.109588] Lustre: Unmounted lustre-client [ 1883.289696] Key type lgssc unregistered [ 1883.717206] LNet: 42712:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1883.736270] LNetError: 42712:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1883.775795] LNet: Removed LNI 192.168.203.60@tcp [ 1884.973525] Key type .llcrypt unregistered [ 1884.975340] Key type ._llcrypt unregistered [ 1926.994153] Key type ._llcrypt registered [ 1926.996581] Key type .llcrypt registered [ 1929.167949] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 02:42:55 (1788331375) [ 1931.092571] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1933.557850] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 02:43:00 (1788331380) [ 1938.311679] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1938.348925] alg: No test for adler32 (adler32-zlib) [ 1939.673489] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 1939.941829] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 1941.680461] Key type lgssc registered [ 1943.049491] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1977.956420] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 02:43:44 (1788331424) [ 2016.682386] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2024.454419] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2047.439284] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2049.540473] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 2053.303268] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2057.567687] Lustre: Unmounted lustre-client [ 2074.390423] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2124.488505] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2130.039207] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2130.756605] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 2134.704160] Lustre: Unmounted lustre-client [ 2190.261665] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2196.971383] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2197.597777] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 2202.417177] Lustre: Unmounted lustre-client [ 2225.462818] Lustre: DEBUG MARKER: files compared the same [ 2249.595635] Key type lgssc unregistered [ 2249.942316] LNet: 50329:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2249.953708] LNetError: 50329:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2249.978545] LNet: Removed LNI 192.168.203.60@tcp [ 2250.878354] Key type .llcrypt unregistered [ 2250.881142] Key type ._llcrypt unregistered [ 2266.418782] Key type ._llcrypt registered [ 2266.420648] Key type .llcrypt registered [ 2267.515613] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 02:48:34 (1788331714) [ 2270.373449] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2270.452241] alg: No test for adler32 (adler32-zlib) [ 2271.630719] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 2271.921781] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 2273.624190] Key type lgssc registered [ 2275.251940] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2331.600365] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2337.529988] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2361.864474] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2364.519788] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 2369.156596] Lustre: Unmounted lustre-client [ 2407.398745] Key type lgssc unregistered [ 2407.630812] LNet: 53914:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2407.641301] LNetError: 53914:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2407.663697] LNet: Removed LNI 192.168.203.60@tcp [ 2408.393087] Key type .llcrypt unregistered [ 2408.395829] Key type ._llcrypt unregistered [ 2427.446567] Key type ._llcrypt registered [ 2427.451868] Key type .llcrypt registered [ 2429.268928] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 02:51:15 (1788331875) [ 2431.858379] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2432.075652] alg: No test for adler32 (adler32-zlib) [ 2433.296649] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 2433.560591] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 2435.288244] Key type lgssc registered [ 2436.816738] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2528.355793] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2571.449909] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2578.378725] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2607.449817] Key type lgssc unregistered [ 2607.713048] LNet: 57404:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2607.723101] LNetError: 57404:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2607.732223] LNet: Removed LNI 192.168.203.60@tcp [ 2608.506995] Key type .llcrypt unregistered [ 2608.512713] Key type ._llcrypt unregistered [ 2625.192580] Key type ._llcrypt registered [ 2625.196131] Key type .llcrypt registered [ 2626.793215] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 02:54:33 (1788332073) [ 2631.088276] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2631.115028] alg: No test for adler32 (adler32-zlib) [ 2632.401506] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 2632.727435] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 2634.528211] Key type lgssc registered [ 2635.752145] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2712.406824] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 2719.588375] Lustre: Unmounted lustre-client [ 2760.760400] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 02:56:47 (1788332207) [ 2887.544918] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2909.237507] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 2916.037789] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2916.044575] LustreError: 63870:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9a8e11143800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2916.064788] Lustre: 58388:0:(llite_lib.c:4344:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.160@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2926.357764] Lustre: Unmounted lustre-client [ 2968.967149] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 03:00:15 (1788332415) [ 2979.428233] Key type lgssc unregistered [ 2979.658317] LNet: 65080:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2979.669871] LNetError: 65080:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2979.715486] LNet: Removed LNI 192.168.203.60@tcp [ 2980.496533] Key type .llcrypt unregistered [ 2980.498405] Key type ._llcrypt unregistered [ 2991.623797] Key type ._llcrypt registered [ 2991.627094] Key type .llcrypt registered [ 2992.102118] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2992.124139] alg: No test for adler32 (adler32-zlib) [ 2993.211237] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 2993.423274] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 2995.080346] Key type lgssc registered [ 2995.992656] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3048.388505] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3054.722432] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3076.527815] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3078.220807] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3085.555770] Lustre: Unmounted lustre-client [ 3114.480169] Key type lgssc unregistered [ 3114.887887] LNet: 68105:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3114.908118] LNetError: 68105:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3114.933200] LNet: Removed LNI 192.168.203.60@tcp [ 3115.925854] Key type .llcrypt unregistered [ 3115.936812] Key type ._llcrypt unregistered [ 3129.258213] Key type ._llcrypt registered [ 3129.260164] Key type .llcrypt registered [ 3129.594887] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3129.609827] alg: No test for adler32 (adler32-zlib) [ 3130.748479] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 3130.992554] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 3132.800413] Key type lgssc registered [ 3134.800983] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3251.026369] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3257.214844] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3279.612750] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3281.736838] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3289.989325] Lustre: Unmounted lustre-client [ 3319.818959] Key type lgssc unregistered [ 3320.120749] LNet: 71533:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3320.140086] LNetError: 71533:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3320.169424] LNet: Removed LNI 192.168.203.60@tcp [ 3320.797913] Key type .llcrypt unregistered [ 3320.802714] Key type ._llcrypt unregistered [ 3337.939334] Key type ._llcrypt registered [ 3337.945668] Key type .llcrypt registered [ 3339.397854] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 03:06:26 (1788332786) [ 3341.961071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3341.983038] alg: No test for adler32 (adler32-zlib) [ 3342.972737] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 3343.204545] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 3344.864476] Key type lgssc registered [ 3346.151723] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3395.140278] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3400.807536] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3422.587406] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3425.354344] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3433.454386] Lustre: Unmounted lustre-client [ 3433.978793] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3437.263182] Lustre: Unmounted lustre-client [ 3475.201948] Key type lgssc unregistered [ 3475.392194] LNet: 75212:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3475.403202] LNetError: 75212:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3475.435087] LNet: Removed LNI 192.168.203.60@tcp [ 3476.271708] Key type .llcrypt unregistered [ 3476.274650] Key type ._llcrypt unregistered [ 3488.618174] Key type ._llcrypt registered [ 3488.623908] Key type .llcrypt registered [ 3489.066824] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3489.080336] alg: No test for adler32 (adler32-zlib) [ 3490.260188] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 3490.506101] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 3492.160215] Key type lgssc registered [ 3493.281811] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3539.835264] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3546.888687] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3572.012161] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3573.752982] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3578.916125] Lustre: Unmounted lustre-client [ 3608.278333] Key type lgssc unregistered [ 3608.733503] LNet: 78242:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3608.755247] LNetError: 78242:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3608.781841] LNet: Removed LNI 192.168.203.60@tcp [ 3609.730134] Key type .llcrypt unregistered [ 3609.738587] Key type ._llcrypt unregistered [ 3625.696572] Key type ._llcrypt registered [ 3625.700405] Key type .llcrypt registered [ 3627.100265] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 03:11:13 (1788333073) [ 3629.705686] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3629.719360] alg: No test for adler32 (adler32-zlib) [ 3630.891210] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 3631.217359] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 3632.896365] Key type lgssc registered [ 3633.987386] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3683.485743] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3689.478386] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3713.053643] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3715.894720] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3726.666559] Lustre: lustre: root_squash is set to 0:0 [ 3734.664553] Lustre: lustre: nosquash_nids is cleared [ 3734.709887] Lustre: lustre: root_squash is set to 500:500 [ 3749.915822] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.60@tcp 192.168.0.[2,10]@tcp [ 3765.319512] Lustre: lustre: nosquash_nids set to 192.168.203.60/24@tcp [ 3769.881227] Lustre: Unmounted lustre-client [ 3800.167377] Key type lgssc unregistered [ 3800.455308] LNet: 82227:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3800.473559] LNetError: 82227:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3800.499356] LNet: Removed LNI 192.168.203.60@tcp [ 3801.352960] Key type .llcrypt unregistered [ 3801.354932] Key type ._llcrypt unregistered [ 3818.246971] Key type ._llcrypt registered [ 3818.249902] Key type .llcrypt registered [ 3820.112514] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 03:14:26 (1788333266) [ 3822.598285] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3824.590646] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 03:14:31 (1788333271) [ 3827.069263] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3827.206151] alg: No test for adler32 (adler32-zlib) [ 3828.289794] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 3828.553365] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 3830.248268] Key type lgssc registered [ 3831.438859] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3885.279383] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3893.336771] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3923.556620] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3924.156279] Lustre: lustre: root_squash is set to 500:500 [ 3924.189765] Lustre: lustre: nosquash_nids set to 192.168.203.60/24@tcp [ 3929.668142] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 3935.656142] Lustre: Unmounted lustre-client [ 3974.687864] Key type lgssc unregistered [ 3975.198046] LNet: 86186:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3975.209941] LNetError: 86186:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3975.254285] LNet: Removed LNI 192.168.203.60@tcp [ 3976.097316] Key type .llcrypt unregistered [ 3976.100423] Key type ._llcrypt unregistered [ 3996.299092] Key type ._llcrypt registered [ 3996.305213] Key type .llcrypt registered [ 3998.416860] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4000.628971] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 03:17:27 (1788333447) [ 4021.495444] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4021.512338] alg: No test for adler32 (adler32-zlib) [ 4022.696705] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 4023.172088] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 4024.937873] Key type lgssc registered [ 4027.036809] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4119.777731] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4126.093701] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4150.731243] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4223.766534] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4229.530359] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4253.262584] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4266.555996] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 4305.673802] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9a8e05c18000.ost_server_uuid 50 [ 4307.219966] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9a8e05c18000.ost_server_uuid in IDLE state after 0 sec [ 4307.909616] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 4312.630691] Lustre: Unmounted lustre-client [ 4314.469281] Lustre: Unmounted lustre-client [ 4367.216713] Key type lgssc unregistered [ 4367.508760] LNet: 93853:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4367.521880] LNetError: 93853:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4367.539549] LNet: Removed LNI 192.168.203.60@tcp [ 4368.281353] Key type .llcrypt unregistered [ 4368.283418] Key type ._llcrypt unregistered [ 4399.741511] Key type ._llcrypt registered [ 4399.747511] Key type .llcrypt registered [ 4401.886807] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 03:24:07 (1788333847) [ 4422.348074] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4422.426088] alg: No test for adler32 (adler32-zlib) [ 4423.487965] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 4423.728475] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 4425.424422] Key type lgssc registered [ 4426.691436] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4505.092905] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4511.425289] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4533.977615] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4536.754076] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 4558.304617] Lustre: 95212:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788333990/real 1788333990] req@00000000bfb553da x1875203978171648/t0(0) o400->lustre-OST0000-osc-ffff9a8e209c9800@192.168.203.160@tcp:28/4 lens 224/224 e 0 to 1 dl 1788334006 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4558.339719] Lustre: lustre-OST0000-osc-ffff9a8e209c9800: Connection to lustre-OST0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4563.296651] Lustre: 95211:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788333995/real 1788333995] req@0000000090997fdc x1875203978172160/t0(0) o400->lustre-OST0000-osc-ffff9a8e209c9800@192.168.203.160@tcp:28/4 lens 224/224 e 0 to 1 dl 1788334011 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4568.481125] Lustre: 95211:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788334000/real 1788334000] req@0000000039fbb359 x1875203978172672/t0(0) o400->lustre-OST0000-osc-ffff9a8e209c9800@192.168.203.160@tcp:28/4 lens 224/224 e 0 to 1 dl 1788334016 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4568.603872] Lustre: lustre-OST0000-osc-ffff9a8e209c9800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 4572.704405] Lustre: 95212:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788334005/real 1788334005] req@0000000085faac73 x1875203978173184/t0(0) o400->lustre-OST0000-osc-ffff9a8e209c9800@192.168.203.160@tcp:28/4 lens 224/224 e 0 to 1 dl 1788334021 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4573.673454] Lustre: lustre-MDT0000-mdc-ffff9a8e209c9800: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4590.052070] Lustre: 95211:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788334022/real 1788334022] req@00000000ca6ce58b x1875203978175488/t0(0) o400->MGC192.168.203.160@tcp@192.168.203.160@tcp:26/25 lens 224/224 e 0 to 1 dl 1788334038 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4590.091083] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [ 4600.305203] Lustre: Evicted from MGS (at 192.168.203.160@tcp) after server handle changed from 0xa2450263cea51cee to 0xa2450263cea51f79 [ 4600.319598] Lustre: MGC192.168.203.160@tcp: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 4603.734985] Lustre: lustre-MDT0000-mdc-ffff9a8e209c9800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 4609.377728] Lustre: Unmounted lustre-client [ 4636.002767] Key type lgssc unregistered [ 4636.201596] LNet: 99511:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4636.210968] LNetError: 99511:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4636.229174] LNet: Removed LNI 192.168.203.60@tcp [ 4636.963675] Key type .llcrypt unregistered [ 4636.968277] Key type ._llcrypt unregistered [ 4651.327139] Key type ._llcrypt registered [ 4651.330721] Key type .llcrypt registered [ 4652.551141] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 03:28:19 (1788334099) [ 4667.148988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4667.335647] alg: No test for adler32 (adler32-zlib) [ 4668.494840] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 4668.755600] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 4670.448455] Key type lgssc registered [ 4671.684375] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4710.855670] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4809.737834] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4814.912361] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4836.653660] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4839.269334] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 4841.018352] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4842.763768] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 03:31:29 (1788334289) [ 5085.819792] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5096.166748] Lustre: Unmounted lustre-client [ 5216.958490] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5222.849642] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5245.360846] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5282.379576] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 03:38:49 (1788334729) [ 5368.877875] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5374.348038] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5397.721465] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5398.278957] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 5403.557772] Lustre: Unmounted lustre-client [ 5435.640966] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 03:41:22 (1788334882) [ 5526.147862] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5531.751927] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5554.325713] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5554.798583] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 5559.674085] Lustre: Unmounted lustre-client [ 5585.214875] Key type lgssc unregistered [ 5585.501033] LNet: 122529:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5585.507262] LNetError: 122529:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5585.534501] LNet: Removed LNI 192.168.203.60@tcp [ 5586.156521] Key type .llcrypt unregistered [ 5586.159553] Key type ._llcrypt unregistered [ 5600.858392] Key type ._llcrypt registered [ 5600.859947] Key type .llcrypt registered [ 5602.157567] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 03:44:09 (1788335049) [ 5604.070834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5604.164964] alg: No test for adler32 (adler32-zlib) [ 5605.224548] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 5605.466382] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 5607.137706] Key type lgssc registered [ 5608.200891] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5655.477617] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5661.015824] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5681.079292] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5682.719551] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 5696.571645] Lustre: Unmounted lustre-client [ 5724.032109] Key type lgssc unregistered [ 5724.283516] LNet: 126114:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5724.290627] LNetError: 126114:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5724.312245] LNet: Removed LNI 192.168.203.60@tcp [ 5724.957890] Key type .llcrypt unregistered [ 5724.960903] Key type ._llcrypt unregistered [ 5739.920459] Key type ._llcrypt registered [ 5739.923714] Key type .llcrypt registered [ 5741.205027] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 03:46:28 (1788335188) [ 5743.515558] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5743.545261] alg: No test for adler32 (adler32-zlib) [ 5744.573781] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 5744.790888] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 5746.472706] Key type lgssc registered [ 5747.550710] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5790.642829] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5795.572821] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5813.302796] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5815.837489] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 5820.903702] Lustre: lustre-OST0000-osc-ffff9a8e06372800: Connection to lustre-OST0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5832.165307] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9a8e06372800.ost_server_uuid 50 [ 5833.557927] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5844.176107] Lustre: Unmounted lustre-client [ 5864.474298] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 03:48:31 (1788335311) [ 5892.214934] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5897.076924] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5915.567356] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5933.728199] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5934.250340] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 5939.690071] Lustre: lustre-OST0000-osc-ffff9a8e0557c800: Connection to lustre-OST0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5962.323850] Lustre: Unmounted lustre-client [ 6003.655626] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 03:50:50 (1788335450) [ 6033.082747] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6037.545567] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6053.004515] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6069.824492] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6070.344884] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6075.372492] Lustre: lustre-OST0000-osc-ffff9a8e05d0a000: Connection to lustre-OST0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6089.899866] Lustre: Unmounted lustre-client [ 6127.016659] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 03:52:54 (1788335574) [ 6192.820279] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6196.314555] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6210.360720] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6258.458429] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6262.215501] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6275.813389] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6314.890905] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6351.743537] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6362.269182] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 9 sec [ 6363.392553] Lustre: Unmounted lustre-client [ 6389.851275] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 03:57:17 (1788335837) [ 6411.759419] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6415.465313] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6429.852378] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6459.998766] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6480.353578] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6518.733335] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6519.761882] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6521.322846] Lustre: lustre-OST0001-osc-ffff9a8e11e70800: Connection to lustre-OST0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6530.251169] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6540.562289] Lustre: Unmounted lustre-client [ 6592.702358] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 04:00:39 (1788336039) [ 6622.186082] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6626.603930] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6643.794037] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6644.314672] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6661.470115] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6662.807636] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6673.917243] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9a8e07a8d000.ost_server_uuid 50 [ 6675.171365] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9a8e07a8d000.ost_server_uuid in IDLE state after 0 sec [ 6677.531137] Lustre: Unmounted lustre-client [ 6677.787305] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6677.797233] Lustre: Skipped 3 previous similar messages [ 6677.910425] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6678.766413] LustreError: 149559:0:(sec.c:403:import_sec_validate_get()) import 000000001b0588ea (NEW) with no sec [ 6724.371407] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 04:02:51 (1788336171) [ 6746.236701] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6750.128718] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6764.142627] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6777.200121] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6777.488875] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6777.591195] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6789.174931] Lustre: Unmounted lustre-client [ 6789.180067] Lustre: Skipped 1 previous similar message [ 6828.488581] Key type lgssc unregistered [ 6828.676681] LNet: 152971:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6828.681077] LNetError: 152971:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6828.694561] LNet: Removed LNI 192.168.203.60@tcp [ 6829.193924] Key type .llcrypt unregistered [ 6829.196972] Key type ._llcrypt unregistered [ 6839.919409] Key type ._llcrypt registered [ 6839.921283] Key type .llcrypt registered [ 6840.737989] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 04:04:48 (1788336288) [ 6841.565481] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6841.573340] alg: No test for adler32 (adler32-zlib) [ 6842.551654] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 6842.702965] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 6844.344428] Key type lgssc registered [ 6845.234681] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6876.775559] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6880.640367] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6893.164737] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6906.043269] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6907.372214] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6908.473917] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 6912.075286] LustreError: lustre-MDT0001-mdc-ffff9a8e03199000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6912.089066] Lustre: lustre-MDT0001-mdc-ffff9a8e03199000: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 6916.364613] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6917.637251] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6933.503421] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6935.599439] Lustre: Unmounted lustre-client [ 6960.276909] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 04:06:47 (1788336407) [ 7015.881271] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7019.030468] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7032.593754] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7033.067785] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7050.777749] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7051.766355] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7057.902156] Lustre: lustre-OST0001-osc-ffff9a8e0557c800: Connection to lustre-OST0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7063.788818] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7074.119809] Lustre: Unmounted lustre-client [ 7101.421268] Key type lgssc unregistered [ 7101.575324] LNet: 162544:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7101.582074] LNetError: 162544:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7101.599996] LNet: Removed LNI 192.168.203.60@tcp [ 7101.963589] Key type .llcrypt unregistered [ 7101.966128] Key type ._llcrypt unregistered [ 7118.907157] Key type ._llcrypt registered [ 7118.909635] Key type .llcrypt registered [ 7119.562531] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 04:09:27 (1788336567) [ 7120.749059] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7120.767327] alg: No test for adler32 (adler32-zlib) [ 7121.749209] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7121.898225] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7123.513523] Key type lgssc registered [ 7124.125193] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7148.695244] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7151.514865] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7160.654795] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7166.962969] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7204.724177] Lustre: Unmounted lustre-client [ 7226.775531] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7227.091741] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7260.021754] Lustre: Unmounted lustre-client [ 7287.782283] Key type lgssc unregistered [ 7287.942713] LNet: 166976:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7287.946811] LNetError: 166976:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7287.959049] LNet: Removed LNI 192.168.203.60@tcp [ 7288.316169] Key type .llcrypt unregistered [ 7288.317983] Key type ._llcrypt unregistered [ 7295.640857] Key type ._llcrypt registered [ 7295.642764] Key type .llcrypt registered [ 7296.442122] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 04:12:23 (1788336743) [ 7297.604233] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7297.616870] alg: No test for adler32 (adler32-zlib) [ 7298.538693] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7298.702779] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7300.328276] Key type lgssc registered [ 7301.084176] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7327.672114] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7330.536830] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7341.974285] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7344.352065] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7357.891406] Lustre: Unmounted lustre-client [ 7377.351427] Key type lgssc unregistered [ 7377.510610] LNet: 170716:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7377.514704] LNetError: 170716:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7377.525831] LNet: Removed LNI 192.168.203.60@tcp [ 7377.900798] Key type .llcrypt unregistered [ 7377.902800] Key type ._llcrypt unregistered [ 7384.621358] Key type ._llcrypt registered [ 7384.628471] Key type .llcrypt registered [ 7384.848355] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7384.857498] alg: No test for adler32 (adler32-zlib) [ 7385.783800] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7385.925975] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7387.528291] Key type lgssc registered [ 7388.125705] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7414.350750] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7417.238196] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7426.741220] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7428.028779] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7440.525919] Lustre: Unmounted lustre-client [ 7459.712741] Key type lgssc unregistered [ 7459.860173] LNet: 173768:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7459.864755] LNetError: 173768:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7459.877676] LNet: Removed LNI 192.168.203.60@tcp [ 7460.188519] Key type .llcrypt unregistered [ 7460.191810] Key type ._llcrypt unregistered [ 7466.899202] Key type ._llcrypt registered [ 7466.901152] Key type .llcrypt registered [ 7467.526264] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 04:15:15 (1788336915) [ 7468.576350] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7468.595425] alg: No test for adler32 (adler32-zlib) [ 7469.508314] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7469.621413] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7471.232204] Key type lgssc registered [ 7471.878512] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7496.364197] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7499.169980] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7508.660795] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7509.932084] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7527.957362] Lustre: Unmounted lustre-client [ 7547.211655] Key type lgssc unregistered [ 7547.374022] LNet: 177505:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7547.379258] LNetError: 177505:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7547.394582] LNet: Removed LNI 192.168.203.60@tcp [ 7547.724027] Key type .llcrypt unregistered [ 7547.726255] Key type ._llcrypt unregistered [ 7553.231802] Key type ._llcrypt registered [ 7553.233522] Key type .llcrypt registered [ 7553.435178] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7553.442144] alg: No test for adler32 (adler32-zlib) [ 7554.349281] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7554.478367] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7556.104882] Key type lgssc registered [ 7556.655149] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7579.842990] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7582.330294] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7591.442827] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7598.060674] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7605.503394] Lustre: Unmounted lustre-client [ 7624.857787] Key type lgssc unregistered [ 7625.008460] LNet: 180555:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7625.014428] LNetError: 180555:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7625.026691] LNet: Removed LNI 192.168.203.60@tcp [ 7625.402161] Key type .llcrypt unregistered [ 7625.403743] Key type ._llcrypt unregistered [ 7632.508123] Key type ._llcrypt registered [ 7632.510141] Key type .llcrypt registered [ 7633.210604] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 04:18:00 (1788337080) [ 7642.767814] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7642.777687] alg: No test for adler32 (adler32-zlib) [ 7643.678479] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7643.812057] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7645.433428] Key type lgssc registered [ 7646.069673] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7684.884928] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7687.344688] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7697.977515] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7722.322987] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 04:19:30 (1788337170) [ 7736.453751] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7739.181962] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7749.586754] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7750.990217] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7757.623810] Lustre: Unmounted lustre-client [ 7773.413826] Key type lgssc unregistered [ 7773.586930] LNet: 187624:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7773.590447] LNetError: 187624:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7773.602257] LNet: Removed LNI 192.168.203.60@tcp [ 7774.007690] Key type .llcrypt unregistered [ 7774.010102] Key type ._llcrypt unregistered [ 7780.721225] Key type ._llcrypt registered [ 7780.722753] Key type .llcrypt registered [ 7781.398660] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 7782.216711] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 04:20:29 (1788337229) [ 7790.663306] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7790.672556] alg: No test for adler32 (adler32-zlib) [ 7791.567116] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 7791.679688] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 7793.280222] Key type lgssc registered [ 7793.792859] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7834.836375] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7837.021138] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7846.769235] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7858.461113] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7861.201247] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 7880.020425] Lustre: Unmounted lustre-client [ 7976.400497] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7979.535945] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7992.945744] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8020.660907] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 04:24:28 (1788337468) [ 8021.670842] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8022.664580] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 04:24:30 (1788337470) [ 8084.552693] Key type lgssc unregistered [ 8084.764791] LNet: 199026:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8084.773081] LNetError: 199026:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8084.786645] LNet: Removed LNI 192.168.203.60@tcp [ 8085.140838] Key type .llcrypt unregistered [ 8085.145135] Key type ._llcrypt unregistered [ 8091.969381] Key type ._llcrypt registered [ 8091.970825] Key type .llcrypt registered [ 8092.596311] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 04:25:40 (1788337540) [ 8119.167653] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8119.218479] alg: No test for adler32 (adler32-zlib) [ 8120.139064] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 8120.267809] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 8121.872183] Key type lgssc registered [ 8122.445679] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8142.036484] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8144.368173] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8168.012387] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8181.586733] Key type lgssc unregistered [ 8181.735692] LNet: 202743:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8181.741576] LNetError: 202743:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8181.750355] LNet: Removed LNI 192.168.203.60@tcp [ 8182.115924] Key type .llcrypt unregistered [ 8182.117581] Key type ._llcrypt unregistered [ 8189.288754] Key type ._llcrypt registered [ 8189.290990] Key type .llcrypt registered [ 8189.948389] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 04:27:17 (1788337637) [ 8191.078568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8191.087568] alg: No test for adler32 (adler32-zlib) [ 8191.978749] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 8192.091122] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 8193.696567] Key type lgssc registered [ 8194.214671] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8217.589779] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8219.962996] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8231.125493] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8232.394476] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 8242.659794] Lustre: lustre-MDT0000-mdc-ffff9a8e102cc800: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8252.902033] Lustre: lustre-MDT0001-mdc-ffff9a8e102cc800: Connection to lustre-MDT0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8263.140692] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [ 8263.157058] Lustre: Evicted from MGS (at 192.168.203.160@tcp) after server handle changed from 0xfe1311b2f3e9d815 to 0xfe1311b2f3e9f175 [ 8263.164066] Lustre: MGC192.168.203.160@tcp: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 8270.827061] Lustre: 205858:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.203.160@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 8285.691462] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8287.718545] LustreError: lustre-MDT0000-mdc-ffff9a8e102cc800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8287.745140] Lustre: lustre-MDT0000-mdc-ffff9a8e102cc800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 8288.487138] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 2 sec [ 8291.085563] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8293.952038] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 2 sec [ 8295.152546] Lustre: Unmounted lustre-client [ 8322.474874] Key type lgssc unregistered [ 8322.616808] LNet: 207716:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8322.620806] LNetError: 207716:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8322.628752] LNet: Removed LNI 192.168.203.60@tcp [ 8322.932483] Key type .llcrypt unregistered [ 8322.934269] Key type ._llcrypt unregistered [ 8329.502600] Key type ._llcrypt registered [ 8329.504511] Key type .llcrypt registered [ 8330.128536] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 04:29:37 (1788337777) [ 8331.171185] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8331.178952] alg: No test for adler32 (adler32-zlib) [ 8332.067933] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 8332.200368] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 8333.808184] Key type lgssc registered [ 8334.300249] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8356.749818] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8359.052142] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8394.331917] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8396.759969] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8413.701756] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8422.084221] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8448.032952] Key type lgssc unregistered [ 8448.152525] LNet: 212987:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8448.155749] LNetError: 212987:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8448.166311] LNet: Removed LNI 192.168.203.60@tcp [ 8448.425820] Key type .llcrypt unregistered [ 8448.427387] Key type ._llcrypt unregistered [ 8471.082100] Key type ._llcrypt registered [ 8471.083768] Key type .llcrypt registered [ 8471.637804] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 04:31:59 (1788337919) [ 8485.450077] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8485.471487] alg: No test for adler32 (adler32-zlib) [ 8486.335366] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 8486.442996] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 8488.040165] Key type lgssc registered [ 8488.477897] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8521.551589] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8523.583528] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8532.441908] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8550.610716] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 04:33:18 (1788337998) [ 8553.229308] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 04:33:21 (1788338001) [ 8565.854169] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8567.840496] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8575.441945] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8587.263398] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 8590.749756] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 8591.725391] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8592.394207] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8593.060341] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 8597.476908] Lustre: lustre-MDT0000-mdc-ffff9a8e11634800: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8607.715962] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [ 8607.728286] Lustre: Evicted from MGS (at 192.168.203.160@tcp) after server handle changed from 0x91e077f705af540c to 0x91e077f705af5682 [ 8607.737397] Lustre: MGC192.168.203.160@tcp: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 8613.171229] Lustre: lustre-MDT0000-mdc-ffff9a8e11634800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 8615.399312] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8615.998558] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8618.095867] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 8623.075034] Lustre: lustre-MDT0000-mdc-ffff9a8e11634800: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8633.315392] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [ 8633.325741] Lustre: Evicted from MGS (at 192.168.203.160@tcp) after server handle changed from 0x91e077f705af5682 to 0x91e077f705af5992 [ 8633.333445] Lustre: MGC192.168.203.160@tcp: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 8638.258890] Lustre: lustre-MDT0000-mdc-ffff9a8e11634800: Connection restored to 192.168.203.160@tcp (at 192.168.203.160@tcp) [ 8640.108925] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8640.653927] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8642.277273] Lustre: Unmounted lustre-client [ 8677.901527] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8680.199112] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8688.061977] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8698.869828] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 8699.301137] Lustre: Unmounted lustre-client [ 8729.625592] Key type lgssc unregistered [ 8729.809270] LNet: 225413:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8729.813658] LNetError: 225413:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8730.854497] LNet: Removed LNI 192.168.203.60@tcp [ 8731.445835] Key type .llcrypt unregistered [ 8731.448117] Key type ._llcrypt unregistered [ 8746.552788] Key type ._llcrypt registered [ 8746.554881] Key type .llcrypt registered [ 8747.590659] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 04:36:34 (1788338194) [ 8752.245363] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8752.258178] alg: No test for adler32 (adler32-zlib) [ 8753.241551] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 8753.494426] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 8755.168257] Key type lgssc registered [ 8756.629476] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8809.527727] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8813.140110] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8825.346629] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8832.034767] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 8836.197714] Lustre: Unmounted lustre-client [ 8882.901804] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8886.193643] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8898.090471] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8898.529805] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 8905.940276] Lustre: Unmounted lustre-client [ 8959.992880] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8964.490922] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8979.735666] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8990.759248] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 8992.412387] Lustre: Unmounted lustre-client [ 9017.076620] Key type lgssc unregistered [ 9017.258181] LNet: 232445:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9017.266673] LNetError: 232445:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9017.276798] LNet: Removed LNI 192.168.203.60@tcp [ 9017.781992] Key type .llcrypt unregistered [ 9017.785851] Key type ._llcrypt unregistered [ 9028.657183] Key type ._llcrypt registered [ 9028.659211] Key type .llcrypt registered [ 9029.629280] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 04:41:16 (1788338476) [ 9031.813185] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9031.854038] alg: No test for adler32 (adler32-zlib) [ 9032.832176] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 9033.035856] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 9034.689793] Key type lgssc registered [ 9035.637637] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9068.421552] Key type lgssc unregistered [ 9068.662681] LNet: 234760:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9068.670498] LNetError: 234760:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9068.686604] LNet: Removed LNI 192.168.203.60@tcp [ 9069.166168] Key type .llcrypt unregistered [ 9069.171149] Key type ._llcrypt unregistered [ 9088.940197] Key type ._llcrypt registered [ 9088.945251] Key type .llcrypt registered [ 9089.177870] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9089.200759] alg: No test for adler32 (adler32-zlib) [ 9090.176803] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 9090.357348] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 9092.009976] Key type lgssc registered [ 9092.947091] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9179.491149] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9187.090049] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9214.900328] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9257.521597] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 9258.967755] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 04:45:06 (1788338706) [ 9288.950923] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9293.814860] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9312.295843] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9332.786671] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9334.373593] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 9339.379364] Lustre: lustre-OST0001-osc-ffff9a8e0319d800: Connection to lustre-OST0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9345.254204] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9355.583473] Lustre: Unmounted lustre-client [ 9388.315784] Key type lgssc unregistered [ 9388.563186] LNet: 241874:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9388.573271] LNetError: 241874:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9388.592172] LNet: Removed LNI 192.168.203.60@tcp [ 9389.183634] Key type .llcrypt unregistered [ 9389.187666] Key type ._llcrypt unregistered [ 9418.713257] Key type ._llcrypt registered [ 9418.715950] Key type .llcrypt registered [ 9419.983912] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 04:47:47 (1788338867) [ 9433.224886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9433.270284] alg: No test for adler32 (adler32-zlib) [ 9434.317350] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 9434.544680] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 9436.200195] Key type lgssc registered [ 9437.212974] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9481.957278] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9487.454427] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9508.048400] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 04:49:15 (1788338955) [ 9535.759749] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9540.462280] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9575.498843] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9578.653583] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 9585.422609] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 9592.576836] Lustre: Unmounted lustre-client [ 9693.817997] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9699.276779] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9753.261600] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9753.973424] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [ 9757.143596] Lustre: Unmounted lustre-client [ 9783.157758] Key type lgssc unregistered [ 9783.399986] LNet: 249565:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9783.412540] LNetError: 249565:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9783.443645] LNet: Removed LNI 192.168.203.60@tcp [ 9784.079547] Key type .llcrypt unregistered [ 9784.081467] Key type ._llcrypt unregistered [ 9811.421700] Key type ._llcrypt registered [ 9811.424711] Key type .llcrypt registered [ 9811.926225] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9811.943760] alg: No test for adler32 (adler32-zlib) [ 9813.040775] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [ 9813.271295] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [ 9814.920246] Key type lgssc registered [ 9816.103949] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9902.895363] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9908.842293] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9929.842218] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9968.216636] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 9969.885607] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 04:56:57 (1788339417) [10001.950308] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10007.099245] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10026.755311] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10032.243784] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [10035.281583] Lustre: Unmounted lustre-client [10060.633131] Key type lgssc unregistered [10060.871216] LNet: 256201:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10060.878349] LNetError: 256201:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10060.901781] LNet: Removed LNI 192.168.203.60@tcp [10061.521438] Key type .llcrypt unregistered [10061.524313] Key type ._llcrypt unregistered [10074.792816] Key type ._llcrypt registered [10074.794992] Key type .llcrypt registered [10075.976675] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [10077.637785] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 04:58:44 (1788339524) [10085.813572] Key type .llcrypt unregistered [10085.818584] Key type ._llcrypt unregistered [10092.735722] Key type ._llcrypt registered [10092.779596] Key type .llcrypt registered [10093.006560] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10093.019920] alg: No test for adler32 (adler32-zlib) [10094.027272] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [10094.243602] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [10095.921271] Key type lgssc registered [10097.118298] Lustre: Echo OBD driver; http://www.lustre.org/ [10146.333935] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10161.212492] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [10163.550972] Lustre: Unmounted lustre-client [10199.719409] Key type lgssc unregistered [10199.945567] LNet: 259651:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10199.957405] LNetError: 259651:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10199.972955] LNet: Removed LNI 192.168.203.60@tcp [10200.546907] Key type .llcrypt unregistered [10200.552995] Key type ._llcrypt unregistered [10214.635555] Key type ._llcrypt registered [10214.638591] Key type .llcrypt registered [10216.379245] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 05:01:02 (1788339662) [10219.083081] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10219.177185] alg: No test for adler32 (adler32-zlib) [10220.269649] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [10220.561548] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [10222.288227] Key type lgssc registered [10223.370927] Lustre: Echo OBD driver; http://www.lustre.org/ [10308.650600] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10341.677359] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10347.731575] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10350.517958] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [10353.185879] Lustre: Unmounted lustre-client [10379.127752] Key type lgssc unregistered [10379.347797] LNet: 263202:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10379.354389] LNetError: 263202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10379.373442] LNet: Removed LNI 192.168.203.60@tcp [10380.002386] Key type .llcrypt unregistered [10380.009586] Key type ._llcrypt unregistered [10394.313255] Key type ._llcrypt registered [10394.315820] Key type .llcrypt registered [10395.415750] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 05:04:02 (1788339842) [10397.821566] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10397.877866] alg: No test for adler32 (adler32-zlib) [10398.921297] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [10399.125237] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [10400.801126] Key type lgssc registered [10401.985612] Lustre: Echo OBD driver; http://www.lustre.org/ [10451.346890] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10457.168917] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10478.457430] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10481.114844] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [10486.266208] Lustre: lustre-MDT0000-mdc-ffff9a8e05579000: Connection to lustre-MDT0000 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [10491.806579] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10491.849922] LustreError: 266356:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10492.315401] LustreError: MGC192.168.203.160@tcp: Connection to MGS (at 192.168.203.160@tcp) was lost; in progress operations using this service will fail [10492.341716] Lustre: Unmounted lustre-client [10511.258676] Key type lgssc unregistered [10511.495078] LNet: 266770:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10511.502550] LNetError: 266770:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10511.519792] LNet: Removed LNI 192.168.203.60@tcp [10512.242330] Key type .llcrypt unregistered [10512.244752] Key type ._llcrypt unregistered [10527.722201] Key type ._llcrypt registered [10527.723677] Key type .llcrypt registered [10529.450350] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 05:06:15 (1788339975) [10531.883720] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10532.002273] alg: No test for adler32 (adler32-zlib) [10533.190277] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [10533.496229] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [10535.200375] Key type lgssc registered [10536.622457] Lustre: Echo OBD driver; http://www.lustre.org/ [10588.083413] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10594.837853] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10618.692481] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10621.552067] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [10626.549029] Lustre: lustre-MDT0001-mdc-ffff9a8e036ba800: Connection to lustre-MDT0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [10632.041834] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10633.788384] Lustre: Unmounted lustre-client [10653.683650] Key type lgssc unregistered [10653.934291] LNet: 270351:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10653.947548] LNetError: 270351:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10653.968029] LNet: Removed LNI 192.168.203.60@tcp [10655.042877] Key type .llcrypt unregistered [10655.046768] Key type ._llcrypt unregistered [10671.703917] Key type ._llcrypt registered [10671.708308] Key type .llcrypt registered [10673.226261] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 05:08:39 (1788340119) [10690.984672] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10691.144342] alg: No test for adler32 (adler32-zlib) [10692.253766] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [10692.549213] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [10694.232185] Key type lgssc registered [10695.429972] Lustre: Echo OBD driver; http://www.lustre.org/ [10791.841300] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10794.388728] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [10829.805889] Lustre: lustre-MDT0001-mdc-ffff9a8e05ddf000: Connection to lustre-MDT0001 (at 192.168.203.160@tcp) was lost; in progress operations using this service will wait for recovery to complete [10839.807479] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10850.133080] Lustre: Unmounted lustre-client [10874.125090] Key type lgssc unregistered [10874.338679] LNet: 276132:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10874.347338] LNetError: 276132:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10874.360989] LNet: Removed LNI 192.168.203.60@tcp [10874.951791] Key type .llcrypt unregistered [10874.953941] Key type ._llcrypt unregistered [10888.578159] Key type ._llcrypt registered [10888.580725] Key type .llcrypt registered [10890.150421] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 05:12:16 (1788340336) [10892.180858] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10893.731261] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 05:12:20 (1788340340) [10895.539805] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10897.417282] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 05:12:24 (1788340344) [10898.941356] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10900.568763] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 05:12:27 (1788340347) [10901.926430] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10903.630594] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 05:12:30 (1788340350) [10904.870517] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10906.345719] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 05:12:33 (1788340353) [10914.336550] Key type .llcrypt unregistered [10914.342427] Key type ._llcrypt unregistered [10921.234153] Key type ._llcrypt registered [10921.253350] Key type .llcrypt registered [10921.663358] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10921.685114] alg: No test for adler32 (adler32-zlib) [10922.774684] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [10923.058724] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [10924.761289] Key type lgssc registered [10926.222882] Lustre: Echo OBD driver; http://www.lustre.org/ [10986.008643] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10990.132327] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11008.980596] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11010.557845] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [11013.033853] Lustre: Unmounted lustre-client [11046.571277] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 05:14:53 (1788340493) [11073.438116] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11077.786307] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11106.364449] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11106.901791] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [11108.643568] Lustre: Unmounted lustre-client [11146.775670] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 05:16:34 (1788340594) [11160.674960] LNet: 1 local NIs in recovery (showing 1): 192.168.203.60@tcp [11760.172981] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11763.487582] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11788.818896] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11855.293915] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 05:28:22 (1788341302) [11862.748345] Key type lgssc unregistered [11862.931961] LNet: 289631:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11862.938823] LNetError: 289631:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11862.957729] LNet: Removed LNI 192.168.203.60@tcp [11863.409628] Key type .llcrypt unregistered [11863.412068] Key type ._llcrypt unregistered [11912.775923] Key type ._llcrypt registered [11912.778436] Key type .llcrypt registered [11913.113385] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11913.131170] alg: No test for adler32 (adler32-zlib) [11914.084733] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [11914.217525] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [11915.840205] Key type lgssc registered [11916.457759] Lustre: Echo OBD driver; http://www.lustre.org/ [11970.228262] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11973.768142] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11988.837573] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12014.624768] Key type lgssc unregistered [12014.825535] LNet: 293300:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12014.831126] LNetError: 293300:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12014.840492] LNet: Removed LNI 192.168.203.60@tcp [12015.412757] Key type .llcrypt unregistered [12015.415126] Key type ._llcrypt unregistered [12048.013203] Key type ._llcrypt registered [12048.020131] Key type .llcrypt registered [12048.937827] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 05:31:36 (1788341496) [12060.840039] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12060.852203] alg: No test for adler32 (adler32-zlib) [12061.828857] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [12062.011530] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [12063.648443] Key type lgssc registered [12064.310340] Lustre: Echo OBD driver; http://www.lustre.org/ [12091.394809] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 05:32:18 (1788341538) [12097.884792] Key type lgssc unregistered [12098.048412] LNet: 296847:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12098.053734] LNetError: 296847:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12098.064749] LNet: Removed LNI 192.168.203.60@tcp [12098.454088] Key type .llcrypt unregistered [12098.456090] Key type ._llcrypt unregistered [12104.229776] Key type ._llcrypt registered [12104.242276] Key type .llcrypt registered [12104.495071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12104.522073] alg: No test for adler32 (adler32-zlib) [12105.456467] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [12105.643646] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [12107.297740] Key type lgssc registered [12108.095346] Lustre: Echo OBD driver; http://www.lustre.org/ [12140.934037] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12144.143910] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12157.148907] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12445.251994] LNet: Added LNI 192.168.203.60@tcp50 [8/256/0/180] [12446.802983] LNet: Removed LNI 192.168.203.60@tcp [12448.659897] Lustre: 301247:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff9a8e21023000: config has no valid NIDs, force dynamic NIDs [12449.788849] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [12449.910398] Lustre: Unmounted lustre-client [12451.794090] Key type lgssc unregistered [12452.082265] LNet: 301506:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12452.087067] LNetError: 301506:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12452.102520] LNet: Removed LNI 192.168.203.60@tcp50 [12452.564815] Key type .llcrypt unregistered [12452.567028] Key type ._llcrypt unregistered [12463.372290] Key type ._llcrypt registered [12463.376067] Key type .llcrypt registered [12463.615146] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12463.626159] alg: No test for adler32 (adler32-zlib) [12464.632575] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [12464.831921] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [12466.464172] Key type lgssc registered [12467.385802] Lustre: Echo OBD driver; http://www.lustre.org/ [12502.810531] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12506.498596] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12511.197211] LNet: Added LNI 192.168.203.60@tcp50 [8/256/0/180] [12511.723900] LNet: Removed LNI 192.168.203.60@tcp [12512.844622] Lustre: 304188:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff9a8e209c8800: config has no valid NIDs, force dynamic NIDs [12513.977398] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [12514.434719] Lustre: Unmounted lustre-client [12548.770947] Key type lgssc unregistered [12548.981056] LNet: 305058:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12548.987641] LNetError: 305058:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12549.009945] LNet: Removed LNI 192.168.203.60@tcp50 [12549.470440] Key type .llcrypt unregistered [12549.476340] Key type ._llcrypt unregistered [12557.627701] Key type ._llcrypt registered [12557.629887] Key type .llcrypt registered [12558.513374] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 05:40:05 (1788342005) [12570.288898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12570.301994] alg: No test for adler32 (adler32-zlib) [12571.266583] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [12571.408170] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [12573.026331] Key type lgssc registered [12573.734748] Lustre: Echo OBD driver; http://www.lustre.org/ [12618.409308] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12621.129516] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12632.809956] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12655.016346] Key type lgssc unregistered [12655.178747] LNet: 309786:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12655.187400] LNetError: 309786:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12655.203065] LNet: Removed LNI 192.168.203.60@tcp [12655.562089] Key type .llcrypt unregistered [12655.564795] Key type ._llcrypt unregistered [12661.746938] Key type ._llcrypt registered [12661.750046] Key type .llcrypt registered [12662.639855] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 05:41:50 (1788342110) [12663.889071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12663.901826] alg: No test for adler32 (adler32-zlib) [12664.879912] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [12665.057638] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [12666.696817] Key type lgssc registered [12667.425969] Lustre: Echo OBD driver; http://www.lustre.org/ [12691.264599] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12693.958494] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12704.202695] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12710.892899] Lustre: Mounted lustre-client - version 2.17.57_104_g6cc0f2c [12739.460595] Lustre: Mounted fs15246-client - version 2.17.57_104_g6cc0f2c [12746.311706] Lustre: Unmounted fs15246-client [12762.493763] Lustre: Unmounted lustre-client [12790.212203] Key type lgssc unregistered [12790.337735] LNet: 314638:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12790.341704] LNetError: 314638:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12790.351826] LNet: Removed LNI 192.168.203.60@tcp [12790.633445] Key type .llcrypt unregistered [12790.634940] Key type ._llcrypt unregistered [12795.417578] Key type ._llcrypt registered [12795.419389] Key type .llcrypt registered [12796.056804] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 05:44:03 (1788342243) [12796.756748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12796.798496] alg: No test for adler32 (adler32-zlib) [12797.693343] Lustre: Lustre: Build Version: 2.17.57_104_g6cc0f2c [12797.806471] LNet: Added LNI 192.168.203.60@tcp [8/256/0/180] [12799.409083] Key type lgssc registered [12799.986469] Lustre: Echo OBD driver; http://www.lustre.org/ [12868.432730] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12870.795828] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12881.498657] Lustre: DEBUG MARKER: oleg360-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12932.982103] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 12621 sec ========= 05:46:20 (1788342380) [12933.798425] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 05:46:21 (1788342381) === [12935.436308] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 05:46:23 (1788342383) === [12950.576452] Key type lgssc unregistered [12950.710975] LNet: 323866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12950.716230] LNetError: 323866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12950.723507] LNet: Removed LNI 192.168.203.60@tcp [12951.008974] Key type .llcrypt unregistered [12951.010727] Key type ._llcrypt unregistered