[ 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 443030943 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002245] x2apic enabled [ 0.003005] Switched APIC routing to physical x2apic. [ 0.004011] kvm-guest: setup PV IPIs [ 0.006812] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008009] pid_max: default: 32768 minimum: 301 [ 0.010063] LSM: Security Framework initializing [ 0.011088] Yama: becoming mindful. [ 0.012030] SELinux: Initializing. [ 0.013059] *** VALIDATE selinux *** [ 0.020674] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024411] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025104] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026096] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027099] *** VALIDATE tmpfs *** [ 0.029273] *** VALIDATE proc *** [ 0.030222] *** VALIDATE cgroup *** [ 0.031020] *** VALIDATE cgroup2 *** [ 0.033037] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035133] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037018] Spectre V2 : User space: Vulnerable [ 0.038004] Speculative Store Bypass: Vulnerable [ 0.040674] debug: unmapping init [mem 0xffffffff99a59000-0xffffffff99a60fff] [ 0.042163] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043584] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044015] ... version: 2 [ 0.044772] ... bit width: 48 [ 0.045008] ... generic registers: 4 [ 0.045767] ... value mask: 0000ffffffffffff [ 0.046011] ... max period: 00007fffffffffff [ 0.047011] ... fixed-purpose events: 3 [ 0.048020] ... event mask: 000000070000000f [ 0.049375] rcu: Hierarchical SRCU implementation. [ 0.051681] smp: Bringing up secondary CPUs ... [ 0.052585] x86: Booting SMP configuration: [ 0.053023] .... node #0, CPUs: #1 #2 #3 [ 0.057011] smp: Brought up 1 node, 4 CPUs [ 0.059021] smpboot: Max logical packages: 1 [ 0.060013] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.141689] node 0 deferred pages initialised in 79ms [ 0.146076] devtmpfs: initialized [ 0.147299] x86/mm: Memory block size: 128MB [ 0.151211] gcov: version magic: 0x41383552 [ 0.154243] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.158087] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.160490] pinctrl core: initialized pinctrl subsystem [ 0.162170] [ 0.162836] ************************************************************* [ 0.165013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.168012] ** ** [ 0.170010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.172011] ** ** [ 0.174012] ** This means that this kernel is built to expose internal ** [ 0.177012] ** IOMMU data structures, which may compromise security on ** [ 0.179009] ** your system. ** [ 0.181011] ** ** [ 0.183013] ** If you see this message and you are not debugging the ** [ 0.185011] ** kernel, report this immediately to your vendor! ** [ 0.187010] ** ** [ 0.190012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.192010] ************************************************************* [ 0.194702] NET: Registered protocol family 16 [ 0.196423] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.199054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.202060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.205104] cpuidle: using governor menu [ 0.207012] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.209545] PCI: Using configuration type 1 for base access [ 0.211127] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.221224] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.223014] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.226052] cryptd: max_cpu_qlen set to 1000 [ 0.227253] ACPI: Added _OSI(Module Device) [ 0.229011] ACPI: Added _OSI(Processor Device) [ 0.230015] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.231008] ACPI: Added _OSI(Processor Aggregator Device) [ 0.236123] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.241662] ACPI: Interpreter enabled [ 0.243143] ACPI: PM: (supports S0 S3 S4 S5) [ 0.245011] ACPI: Using IOAPIC for interrupt routing [ 0.247126] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.251405] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.260000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.263044] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.264015] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.268078] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.271449] acpiphp: Slot [2] registered [ 0.272129] acpiphp: Slot [5] registered [ 0.274117] acpiphp: Slot [6] registered [ 0.275098] acpiphp: Slot [3] registered [ 0.276154] acpiphp: Slot [4] registered [ 0.277073] acpiphp: Slot [7] registered [ 0.279071] acpiphp: Slot [8] registered [ 0.280100] acpiphp: Slot [9] registered [ 0.281093] acpiphp: Slot [10] registered [ 0.283098] acpiphp: Slot [11] registered [ 0.284095] acpiphp: Slot [12] registered [ 0.287125] acpiphp: Slot [13] registered [ 0.288117] acpiphp: Slot [14] registered [ 0.290740] acpiphp: Slot [15] registered [ 0.292118] acpiphp: Slot [16] registered [ 0.293090] acpiphp: Slot [17] registered [ 0.295157] acpiphp: Slot [18] registered [ 0.296093] acpiphp: Slot [19] registered [ 0.298093] acpiphp: Slot [20] registered [ 0.300158] acpiphp: Slot [21] registered [ 0.301114] acpiphp: Slot [22] registered [ 0.302105] acpiphp: Slot [23] registered [ 0.303092] acpiphp: Slot [24] registered [ 0.304160] acpiphp: Slot [25] registered [ 0.306118] acpiphp: Slot [26] registered [ 0.307097] acpiphp: Slot [27] registered [ 0.309149] acpiphp: Slot [28] registered [ 0.310124] acpiphp: Slot [29] registered [ 0.311085] acpiphp: Slot [30] registered [ 0.312077] acpiphp: Slot [31] registered [ 0.314084] PCI host bridge to bus 0000:00 [ 0.315017] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.317013] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.318014] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.321013] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.323023] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.325023] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.327185] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.330046] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.333378] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.341016] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.345053] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.348018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.350022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.353017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.355499] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.358909] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.362043] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.364764] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.369014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.379891] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.385019] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.390363] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.395014] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.400013] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.410013] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.417896] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.422014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.426894] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.439013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.450603] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.454400] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.456342] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.458328] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.461268] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.465455] iommu: Default domain type: Passthrough [ 0.467365] SCSI subsystem initialized [ 0.468131] ACPI: bus type USB registered [ 0.470092] usbcore: registered new interface driver usbfs [ 0.472089] usbcore: registered new interface driver hub [ 0.473073] usbcore: registered new device driver usb [ 0.475152] pps_core: LinuxPPS API ver. 1 registered [ 0.476008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.479053] PTP clock support registered [ 0.481035] EDAC MC: Ver: 3.0.0 [ 0.483077] PCI: Using ACPI for IRQ routing [ 0.484752] NetLabel: Initializing [ 0.486010] NetLabel: domain hash size = 128 [ 0.488008] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.490088] NetLabel: unlabeled traffic allowed by default [ 0.492090] vgaarb: loaded [ 0.493255] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.495010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.502050] clocksource: Switched to clocksource kvm-clock [ 0.613997] VFS: Disk quotas dquot_6.6.0 [ 0.615235] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.617377] *** VALIDATE ramfs *** [ 0.618364] *** VALIDATE hugetlbfs *** [ 0.619495] pnp: PnP ACPI init [ 0.621526] pnp: PnP ACPI: found 6 devices [ 0.640096] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.643547] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.645765] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.647445] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.649395] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.651294] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.653510] NET: Registered protocol family 2 [ 0.655395] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.659280] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.661968] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.667524] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.671339] TCP: Hash tables configured (established 65536 bind 65536) [ 0.674250] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.677161] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.679671] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.682347] NET: Registered protocol family 1 [ 0.684540] RPC: Registered named UNIX socket transport module. [ 0.686359] RPC: Registered udp transport module. [ 0.687504] RPC: Registered tcp transport module. [ 0.688574] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.690661] NET: Registered protocol family 44 [ 0.691991] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.693886] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.696056] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.698332] PCI: CLS 0 bytes, default 64 [ 0.699752] Unpacking initramfs... [ 2.110512] debug: unmapping init [mem 0xffff8abe7cc64000-0xffff8abe7ffcffff] [ 2.115413] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.117842] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.120557] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.245244] Initialise system trusted keyrings [ 3.247523] Key type blacklist registered [ 3.249870] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.262279] zbud: loaded [ 3.266744] *** VALIDATE nfs *** [ 3.268709] *** VALIDATE nfs4 *** [ 3.280205] pstore: using deflate compression [ 3.289583] Platform Keyring initialized [ 3.570341] NET: Registered protocol family 38 [ 3.576626] Key type asymmetric registered [ 3.579868] Asymmetric key parser 'x509' registered [ 3.586803] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.593577] io scheduler mq-deadline registered [ 3.596540] io scheduler kyber registered [ 3.601117] io scheduler bfq registered [ 3.604542] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.612095] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.617728] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.622831] ACPI: Power Button [PWRF] [ 3.630419] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.671579] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.701466] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.759974] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.801902] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.839314] Non-volatile memory driver v1.3 [ 3.847731] Linux agpgart interface v0.103 [ 4.028127] virtio_blk virtio1: [vda] 149816 512-byte logical blocks (76.7 MB/73.2 MiB) [ 4.033461] vda: detected capacity change from 0 to 76705792 [ 4.098374] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 4.105908] vdb: detected capacity change from 0 to 1073741824 [ 4.121165] libphy: Fixed MDIO Bus: probed [ 4.152311] usbcore: registered new interface driver usbserial_generic [ 4.157321] usbserial: USB Serial support registered for generic [ 4.163121] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 4.171450] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 4.175323] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 4.179966] mousedev: PS/2 mouse device common for all mice [ 4.186352] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 4.187226] rtc_cmos 00:05: RTC can wake from S4 [ 4.204862] rtc_cmos 00:05: registered as rtc0 [ 4.209665] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 4.214212] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 4.219627] intel_pstate: CPU model not supported [ 4.225715] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 4.229327] hid: raw HID events driver (C) Jiri Kosina [ 4.236368] usbcore: registered new interface driver usbhid [ 4.238556] usbhid: USB HID core driver [ 4.243542] drop_monitor: Initializing network drop monitor service [ 4.246604] Initializing XFRM netlink socket [ 4.251913] NET: Registered protocol family 10 [ 4.257414] Segment Routing with IPv6 [ 4.258941] NET: Registered protocol family 17 [ 4.262726] mpls_gso: MPLS GSO support [ 4.269950] RAS: Correctable Errors collector initialized. [ 4.273222] AVX version of gcm_enc/dec engaged. [ 4.275589] AES CTR mode by8 optimization enabled [ 4.460417] sched_clock: Marking stable (4460229201, 0)->(5248280501, -788051300) [ 4.467466] registered taskstats version 1 [ 4.471533] Loading compiled-in X.509 certificates [ 4.475172] zswap: loaded using pool lzo/zbud [ 4.596508] Key type big_key registered [ 4.757257] Key type encrypted registered [ 4.761985] ima: No TPM chip found, activating TPM-bypass! [ 4.766421] ima: Allocated hash algorithm: sha1 [ 4.770632] ima: No architecture policies found [ 4.773996] evm: Initialising EVM extended attributes: [ 4.777044] evm: security.selinux [ 4.778978] evm: security.ima [ 4.781148] evm: security.capability [ 4.784388] evm: HMAC attrs: 0x1 [ 4.789293] rtc_cmos 00:05: setting system clock to 2026-09-05 07:32:54 UTC (1788593574) [ 4.802647] debug: unmapping init [mem 0xffffffff9aa03000-0xffffffff9abfffff] [ 4.808943] debug: unmapping init [mem 0xffffffff99782000-0xffffffff99a58fff] [ 4.826666] Write protecting the kernel read-only data: 28672k [ 4.838364] debug: unmapping init [mem 0xffffffff97e03000-0xffffffff97ffffff] [ 4.855888] debug: unmapping init [mem 0xffffffff98714000-0xffffffff987fffff] [ 4.981297] 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) [ 5.007969] systemd[1]: Detected virtualization kvm. [ 5.013025] systemd[1]: Detected architecture x86-64. [ 5.016200] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 5.079441] systemd[1]: No hostname configured. [ 5.083169] systemd[1]: Set hostname to . [ 5.085650] random: systemd: uninitialized urandom read (16 bytes read) [ 5.089620] systemd[1]: Initializing machine ID from random generator. [ 5.244668] random: ln: uninitialized urandom read (6 bytes read) [ 5.503076] random: systemd: uninitialized urandom read (16 bytes read) [ 5.508295] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 5.523384] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 5.536233] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Slices. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket. Starting Create Volatile Files and Directories... [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... Starting Setup Virtual Console... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. Starting Apply Kernel Variables... [ OK ] Reached target Initrd Root Device. [ OK ] Started 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. 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... [ 7.319095] device-mapper: uevent: version 1.0.3 [ 7.336102] 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 [ 9.645356] virtio_net virtio0 ens2: renamed from eth0 ] Started Hardware RNG Entropy Gatherer Daemon. [ 9.777987] random: fast init done [ 9.824933] scsi host0: ata_piix [ 9.851916] scsi host1: ata_piix [ 9.858301] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 9.862502] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 15.316992] random: crng init done [ 15.323867] random: 7 urandom warning(s) missed due to ratelimiting [ 15.991049] dracut-initqueue[580]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 19.062392] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 22.938341] printk: systemd: 26 output lines suppressed due to ratelimiting [ 24.363908] SELinux: Disabled at runtime. [ 24.596910] 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) [ 24.615560] systemd[1]: Detected virtualization kvm. [ 24.626354] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 26.641377] systemd[1]: initrd-switch-root.service: Succeeded. [ 26.646369] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 26.663413] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 26.668738] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 26.673804] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 26.683984] systemd[1]: Starting Journal Service... Starting Journal Service... [ 26.697831] systemd[1]: Mounting Kernel Debug File System... Mounting Kernel Debug File System... Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-getty.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ 26.914904] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target Paths. Mounting POSIX Message Queue File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Mounting Huge Pages File System... [ OK ] Listening on udev Kernel Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Starting Apply Kernel Variables... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 27.914774] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 28.649542] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 28.732717] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 29.020441] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 29.155448] EDAC sbridge: Ver: 1.1.2 [ 32.205396] hrtimer: interrupt took 2770519 ns [ 32.621402] Key type dns_resolver registered [ 33.512641] NFS: Registering the id_resolver key type [ 33.517745] Key type id_resolver registered [ 33.519971] Key type id_legacy registered [* ] A start job is running for Configur…-only root support (7s / no limit) [** ] A start job is running for Configur…-only root support (7s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started RPC Bind. [ OK ] Started Update UTMP about System Boot/Shutdown. [ 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 ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. Starting Hostname Service... [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg445-client login: [ 89.084304] libcfs: loading out-of-tree module taints kernel. [ 89.174420] Key type ._llcrypt registered [ 89.178500] Key type .llcrypt registered [ 89.886960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 89.916728] alg: No test for adler32 (adler32-zlib) [ 91.656252] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 92.579520] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 94.383205] Key type lgssc registered [ 97.262945] Lustre: Echo OBD driver; http://www.lustre.org/ [ 264.858410] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 270.065719] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 281.313426] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing check_logdir /tmp/testlogs/ [ 286.319408] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing yml_node [ 290.278490] Lustre: lustre-OST0000-osc-ffff8abed03dc800: disconnect after 22s idle [ 290.875084] Lustre: DEBUG MARKER: Client: 2.17.58.2 [ 293.460872] Lustre: DEBUG MARKER: MDS: 2.17.58.2 [ 296.167903] Lustre: DEBUG MARKER: OSS: 2.17.58.2 [ 297.836354] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sat Sep 5 03:37:46 EDT 2026 [ 314.696899] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 316.466157] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 319.217224] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 329.563828] Lustre: Unmounted lustre-client [ 441.482186] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 448.297631] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 469.037728] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 504.298174] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 03:41:12 (1788594072) [ 506.453769] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 508.308482] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 03:41:16 (1788594076) [ 540.267401] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 545.829924] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 566.988679] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 567.965807] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 572.877027] Lustre: Unmounted lustre-client [ 600.398531] Key type lgssc unregistered [ 600.738466] LNet: 15020:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 600.747821] LNetError: 15020:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 600.769819] LNet: Removed LNI 192.168.204.45@tcp [ 601.934297] Key type .llcrypt unregistered [ 601.937450] Key type ._llcrypt unregistered [ 620.485690] Key type ._llcrypt registered [ 620.488130] Key type .llcrypt registered [ 621.803679] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 03:43:10 (1788594190) [ 623.288649] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 623.409552] alg: No test for adler32 (adler32-zlib) [ 624.622758] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 624.968091] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 626.767266] Key type lgssc registered [ 628.558345] Lustre: Echo OBD driver; http://www.lustre.org/ [ 707.480827] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 792.280417] Lustre: Unmounted lustre-client [ 818.332667] Key type lgssc unregistered [ 818.623583] LNet: 18822:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 818.647931] LNetError: 18822:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 818.668794] LNet: Removed LNI 192.168.204.45@tcp [ 819.619934] Key type .llcrypt unregistered [ 819.622192] Key type ._llcrypt unregistered [ 830.923555] Key type ._llcrypt registered [ 830.926548] Key type .llcrypt registered [ 832.345078] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 03:46:40 (1788594400) [ 834.621257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 834.674309] alg: No test for adler32 (adler32-zlib) [ 835.827791] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 836.135556] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 837.831240] Key type lgssc registered [ 839.224578] Lustre: Echo OBD driver; http://www.lustre.org/ [ 894.319962] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 899.759250] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 920.488387] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 922.069305] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 933.326338] Lustre: Unmounted lustre-client [ 959.033804] Key type lgssc unregistered [ 959.375548] LNet: 22423:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 959.383273] LNetError: 22423:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 959.398197] LNet: Removed LNI 192.168.204.45@tcp [ 960.140422] Key type .llcrypt unregistered [ 960.144628] Key type ._llcrypt unregistered [ 974.182133] Key type ._llcrypt registered [ 974.186240] Key type .llcrypt registered [ 975.777925] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 03:49:03 (1788594543) [ 978.224611] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 978.406401] alg: No test for adler32 (adler32-zlib) [ 979.468205] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 979.709224] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 981.423381] Key type lgssc registered [ 983.000534] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1045.956236] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1053.155555] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1078.653759] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1085.558927] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 1091.648803] Lustre: Unmounted lustre-client [ 1124.957300] Key type lgssc unregistered [ 1125.374548] LNet: 25613:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1125.384708] LNetError: 25613:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1125.429866] LNet: Removed LNI 192.168.204.45@tcp [ 1126.443452] Key type .llcrypt unregistered [ 1126.448793] Key type ._llcrypt unregistered [ 1145.742715] Key type ._llcrypt registered [ 1145.746509] Key type .llcrypt registered [ 1147.527893] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 03:51:55 (1788594715) [ 1150.199161] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1150.219163] alg: No test for adler32 (adler32-zlib) [ 1151.387448] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 1151.676989] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1153.455328] Key type lgssc registered [ 1155.189580] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1217.933687] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1226.082671] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1254.311281] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1257.147919] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 1262.595964] Lustre: lustre-MDT0000-mdc-ffff8abec7827000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1272.817974] Lustre: lustre-MDT0001-mdc-ffff8abec7827000: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1280.760959] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1284.063422] Lustre: 26570:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788594837/real 1788594837] req@00000000d576047d x1875477498172928/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1788594853 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1284.118511] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 1291.110798] Lustre: Unmounted lustre-client [ 1312.212148] Key type lgssc unregistered [ 1312.564958] LNet: 29276:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1312.573054] LNetError: 29276:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1312.597292] LNet: Removed LNI 192.168.204.45@tcp [ 1313.575096] Key type .llcrypt unregistered [ 1313.579931] Key type ._llcrypt unregistered [ 1331.137329] Key type ._llcrypt registered [ 1331.142233] Key type .llcrypt registered [ 1332.953356] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 03:55:00 (1788594900) [ 1335.623823] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1335.735128] alg: No test for adler32 (adler32-zlib) [ 1336.900751] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 1337.311487] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1339.055197] Key type lgssc registered [ 1340.505403] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1401.031784] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1407.692650] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1431.437625] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1443.400890] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 1453.546355] Lustre: lustre-OST0000-osc-ffff8abec8721000: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1457.488241] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1467.852641] Lustre: Unmounted lustre-client [ 1497.297625] Key type lgssc unregistered [ 1497.618803] LNet: 32885:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1497.624900] LNetError: 32885:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1497.639865] LNet: Removed LNI 192.168.204.45@tcp [ 1498.616560] Key type .llcrypt unregistered [ 1498.619875] Key type ._llcrypt unregistered [ 1515.832091] Key type ._llcrypt registered [ 1515.834386] Key type .llcrypt registered [ 1517.215607] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 03:58:05 (1788595085) [ 1520.135629] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1520.345831] alg: No test for adler32 (adler32-zlib) [ 1521.602938] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 1522.051348] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1523.847321] Key type lgssc registered [ 1525.530770] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1579.162320] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1585.675706] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1607.692815] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1609.520232] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 1616.395903] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1619.639416] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1631.072368] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-05 3h59m59s [ 1632.800649] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1635.318439] Lustre: lustre-MDT0000-mdc-ffff8abec8722800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1643.169201] LustreError: 36677:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8abec8722800: can't stat MDS #0: rc = -19 [ 1645.072439] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1652.713037] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 1652.734046] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0x7712b0eaac2a961d to 0x7712b0eaac2a98cb [ 1652.741768] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 1653.832965] LustreError: lustre-MDT0000-mdc-ffff8abec8722800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1653.861768] Lustre: lustre-MDT0000-mdc-ffff8abec8722800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 1663.114056] Lustre: DEBUG MARKER: Wait for df (36677) ... [ 1664.737674] Lustre: DEBUG MARKER: done [ 1667.424813] Lustre: Unmounted lustre-client [ 1695.257414] Key type lgssc unregistered [ 1695.617327] LNet: 37705:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1695.624995] LNetError: 37705:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1695.649072] LNet: Removed LNI 192.168.204.45@tcp [ 1696.803640] Key type .llcrypt unregistered [ 1696.809752] Key type ._llcrypt unregistered [ 1730.440968] Key type ._llcrypt registered [ 1730.443430] Key type .llcrypt registered [ 1731.874146] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 04:01:40 (1788595300) [ 1734.322891] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1734.383081] alg: No test for adler32 (adler32-zlib) [ 1735.508629] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 1735.769292] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1737.448381] Key type lgssc registered [ 1738.603370] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1790.199985] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1796.016971] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1817.870892] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1820.656511] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 1825.346274] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-05 4h03m13s [ 1827.013431] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1834.652197] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1837.444495] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1857.503210] Lustre: 41844:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788595407/real 1788595407] req@00000000450b98ce x1875478110542592/t0(0) o101->lustre-MDT0000-mdc-ffff8abec7546000@192.168.204.145@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788595427 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1857.523377] Lustre: lustre-MDT0000-mdc-ffff8abec7546000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1857.558108] Lustre: lustre-MDT0000-mdc-ffff8abec7546000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 1879.179308] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1882.449548] Lustre: DEBUG MARKER: done [ 1886.076627] Lustre: Unmounted lustre-client [ 1912.621434] Key type lgssc unregistered [ 1912.826399] LNet: 42728:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1912.838938] LNetError: 42728:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1912.852682] LNet: Removed LNI 192.168.204.45@tcp [ 1913.512636] Key type .llcrypt unregistered [ 1913.515714] Key type ._llcrypt unregistered [ 1945.668680] Key type ._llcrypt registered [ 1945.672044] Key type .llcrypt registered [ 1946.854845] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 04:05:15 (1788595515) [ 1948.154187] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1949.872535] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 04:05:18 (1788595518) [ 1954.777703] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1954.812852] alg: No test for adler32 (adler32-zlib) [ 1956.031799] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 1956.443694] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1958.279230] Key type lgssc registered [ 1959.960701] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1987.248313] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 04:05:55 (1788595555) [ 2018.592661] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2024.193692] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2045.984470] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2048.671584] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 2052.828952] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2056.428460] Lustre: Unmounted lustre-client [ 2073.626189] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2121.121178] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2126.877396] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2127.538628] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 2131.580855] Lustre: Unmounted lustre-client [ 2198.314980] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2204.965454] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2205.775158] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 2209.850853] Lustre: Unmounted lustre-client [ 2235.232409] Lustre: DEBUG MARKER: files compared the same [ 2259.979891] Key type lgssc unregistered [ 2260.414854] LNet: 50344:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2260.429291] LNetError: 50344:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2260.446848] LNet: Removed LNI 192.168.204.45@tcp [ 2261.184526] Key type .llcrypt unregistered [ 2261.187668] Key type ._llcrypt unregistered [ 2276.545947] Key type ._llcrypt registered [ 2276.551665] Key type .llcrypt registered [ 2277.858788] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 04:10:46 (1788595846) [ 2280.260941] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2280.290622] alg: No test for adler32 (adler32-zlib) [ 2281.482942] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 2281.691325] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2283.343909] Key type lgssc registered [ 2284.628569] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2335.374416] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2341.081794] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2362.909452] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2364.576873] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 2371.913284] Lustre: Unmounted lustre-client [ 2415.811862] Key type lgssc unregistered [ 2416.079756] LNet: 53923:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2416.088513] LNetError: 53923:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2416.108844] LNet: Removed LNI 192.168.204.45@tcp [ 2416.763675] Key type .llcrypt unregistered [ 2416.767265] Key type ._llcrypt unregistered [ 2430.926323] Key type ._llcrypt registered [ 2430.927586] Key type .llcrypt registered [ 2432.277257] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 04:13:20 (1788596000) [ 2434.296263] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2434.328604] alg: No test for adler32 (adler32-zlib) [ 2435.447444] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 2435.764753] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2437.487216] Key type lgssc registered [ 2438.731184] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2523.909335] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2556.177277] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2561.791093] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2598.605751] Key type lgssc unregistered [ 2598.892025] LNet: 57402:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2598.900592] LNetError: 57402:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2598.921990] LNet: Removed LNI 192.168.204.45@tcp [ 2599.605585] Key type .llcrypt unregistered [ 2599.609192] Key type ._llcrypt unregistered [ 2615.868612] Key type ._llcrypt registered [ 2615.870499] Key type .llcrypt registered [ 2617.266800] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 04:16:25 (1788596185) [ 2620.922715] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2620.973739] alg: No test for adler32 (adler32-zlib) [ 2622.049359] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 2622.338237] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2624.031231] Key type lgssc registered [ 2625.364635] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2703.308679] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 2710.492481] Lustre: Unmounted lustre-client [ 2749.817760] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 04:18:37 (1788596317) [ 2879.515203] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2902.091762] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 2909.623550] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2909.629968] LustreError: 63877:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8abec6cfe800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2909.650594] Lustre: 58383:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.145@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2919.976972] Lustre: Unmounted lustre-client [ 2965.068683] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 04:22:13 (1788596533) [ 2976.702926] Key type lgssc unregistered [ 2976.959305] LNet: 65087:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2976.966075] LNetError: 65087:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2976.993261] LNet: Removed LNI 192.168.204.45@tcp [ 2977.967995] Key type .llcrypt unregistered [ 2977.970889] Key type ._llcrypt unregistered [ 2993.401339] Key type ._llcrypt registered [ 2993.407395] Key type .llcrypt registered [ 2993.727293] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2993.737201] alg: No test for adler32 (adler32-zlib) [ 2995.015093] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 2995.254575] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2996.911250] Key type lgssc registered [ 2998.520894] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3056.736752] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3063.759475] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3086.650578] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3098.160145] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3103.090797] Lustre: Unmounted lustre-client [ 3132.182360] Key type lgssc unregistered [ 3132.537692] LNet: 68105:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3132.545266] LNetError: 68105:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3132.561200] LNet: Removed LNI 192.168.204.45@tcp [ 3133.389411] Key type .llcrypt unregistered [ 3133.398164] Key type ._llcrypt unregistered [ 3145.286679] Key type ._llcrypt registered [ 3145.295495] Key type .llcrypt registered [ 3145.673725] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3145.693619] alg: No test for adler32 (adler32-zlib) [ 3146.700436] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 3146.953683] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3148.679199] Key type lgssc registered [ 3150.190612] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3269.014376] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3275.306893] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3299.081989] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3300.807594] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3303.352638] Lustre: Unmounted lustre-client [ 3328.267972] Key type lgssc unregistered [ 3328.661242] LNet: 71535:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3328.670483] LNetError: 71535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3328.698827] LNet: Removed LNI 192.168.204.45@tcp [ 3329.461860] Key type .llcrypt unregistered [ 3329.467293] Key type ._llcrypt unregistered [ 3347.483774] Key type ._llcrypt registered [ 3347.488653] Key type .llcrypt registered [ 3348.955623] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 04:28:37 (1788596917) [ 3351.671873] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3351.710152] alg: No test for adler32 (adler32-zlib) [ 3352.834472] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 3353.212393] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3354.896933] Key type lgssc registered [ 3356.315672] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3417.924634] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3424.382295] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3449.194932] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3460.662102] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3468.397264] Lustre: Unmounted lustre-client [ 3468.866916] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3472.228266] Lustre: Unmounted lustre-client [ 3511.314227] Key type lgssc unregistered [ 3511.612645] LNet: 75227:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3511.625793] LNetError: 75227:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3511.646421] LNet: Removed LNI 192.168.204.45@tcp [ 3512.688284] Key type .llcrypt unregistered [ 3512.690279] Key type ._llcrypt unregistered [ 3527.309575] Key type ._llcrypt registered [ 3527.321478] Key type .llcrypt registered [ 3527.892738] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3527.907875] alg: No test for adler32 (adler32-zlib) [ 3529.324295] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 3529.653900] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3531.447207] Key type lgssc registered [ 3532.919204] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3588.119417] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3595.733338] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3621.411528] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3623.218414] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3627.956475] Lustre: Unmounted lustre-client [ 3654.249938] Key type lgssc unregistered [ 3654.680713] LNet: 78256:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3654.694370] LNetError: 78256:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3654.734869] LNet: Removed LNI 192.168.204.45@tcp [ 3655.919407] Key type .llcrypt unregistered [ 3655.924633] Key type ._llcrypt unregistered [ 3674.521447] Key type ._llcrypt registered [ 3674.523237] Key type .llcrypt registered [ 3676.033501] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 04:34:04 (1788597244) [ 3678.945529] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3679.005388] alg: No test for adler32 (adler32-zlib) [ 3680.102156] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 3680.349772] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3682.071333] Key type lgssc registered [ 3683.428420] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3739.903483] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3746.061289] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3769.660277] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3771.297115] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3777.531206] Lustre: lustre: root_squash is set to 0:0 [ 3784.241805] Lustre: lustre: nosquash_nids is cleared [ 3792.396165] Lustre: lustre: root_squash is set to 500:500 [ 3802.192210] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.45@tcp 192.168.0.[2,10]@tcp [ 3807.704458] Lustre: lustre: nosquash_nids set to 192.168.204.45/24@tcp [ 3812.140644] Lustre: Unmounted lustre-client [ 3850.324132] Key type lgssc unregistered [ 3850.608507] LNet: 82211:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3850.616962] LNetError: 82211:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3850.631732] LNet: Removed LNI 192.168.204.45@tcp [ 3851.619668] Key type .llcrypt unregistered [ 3851.621631] Key type ._llcrypt unregistered [ 3869.884730] Key type ._llcrypt registered [ 3869.886891] Key type .llcrypt registered [ 3871.675770] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 04:37:19 (1788597439) [ 3874.628829] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3876.898961] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 04:37:24 (1788597444) [ 3880.273493] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3880.509632] alg: No test for adler32 (adler32-zlib) [ 3881.682255] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 3882.023865] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3883.727791] Key type lgssc registered [ 3885.220376] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3945.188472] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3951.617819] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3975.041374] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3975.626804] Lustre: lustre: root_squash is set to 500:500 [ 3975.658958] Lustre: lustre: nosquash_nids set to 192.168.204.45/24@tcp [ 3986.026277] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 3993.782287] Lustre: Unmounted lustre-client [ 4023.812450] Key type lgssc unregistered [ 4024.073905] LNet: 86167:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4024.088947] LNetError: 86167:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4025.127758] LNet: Removed LNI 192.168.204.45@tcp [ 4025.947993] Key type .llcrypt unregistered [ 4025.950216] Key type ._llcrypt unregistered [ 4043.378598] Key type ._llcrypt registered [ 4043.380163] Key type .llcrypt registered [ 4045.041227] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4047.042269] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 04:40:15 (1788597615) [ 4069.338221] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4069.353510] alg: No test for adler32 (adler32-zlib) [ 4070.427882] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 4070.721392] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 4072.447393] Key type lgssc registered [ 4073.852875] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4173.719430] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4181.181307] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4209.120254] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4295.588466] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4302.863150] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4329.796908] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4345.718660] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 4386.854293] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8abec6385800.ost_server_uuid 50 [ 4388.477501] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8abec6385800.ost_server_uuid in IDLE state after 0 sec [ 4389.121401] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 4393.474820] Lustre: Unmounted lustre-client [ 4395.933351] Lustre: Unmounted lustre-client [ 4454.974651] Key type lgssc unregistered [ 4455.266596] LNet: 93835:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4455.271842] LNetError: 93835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4455.291527] LNet: Removed LNI 192.168.204.45@tcp [ 4456.137750] Key type .llcrypt unregistered [ 4456.140616] Key type ._llcrypt unregistered [ 4492.931051] Key type ._llcrypt registered [ 4492.939732] Key type .llcrypt registered [ 4494.286384] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 04:47:42 (1788598062) [ 4513.106800] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4513.155101] alg: No test for adler32 (adler32-zlib) [ 4514.257426] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 4514.509504] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 4516.167289] Key type lgssc registered [ 4517.438089] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4611.013759] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4618.401800] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4646.759339] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4648.868424] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 4654.072712] Lustre: lustre-OST0000-osc-ffff8abec6e92800: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4694.016053] Lustre: lustre-MDT0000-mdc-ffff8abec6e92800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4694.121465] Lustre: lustre-OST0000-osc-ffff8abec6e92800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 4709.345343] Lustre: 95197:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788598263/real 1788598263] req@00000000605a27f0 x1875481024537216/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1788598279 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4709.411481] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 4719.611213] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0xdc347927425775fa to 0xdc34792742577789 [ 4719.624822] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 4726.529827] Lustre: lustre-MDT0000-mdc-ffff8abec6e92800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 4734.382745] Lustre: Unmounted lustre-client [ 4769.669892] Key type lgssc unregistered [ 4770.282224] LNet: 99503:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4770.299956] LNetError: 99503:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4770.345549] LNet: Removed LNI 192.168.204.45@tcp [ 4771.322298] Key type .llcrypt unregistered [ 4771.325860] Key type ._llcrypt unregistered [ 4793.889443] Key type ._llcrypt registered [ 4793.901773] Key type .llcrypt registered [ 4795.883923] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 04:52:43 (1788598363) [ 4812.463882] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4812.498117] alg: No test for adler32 (adler32-zlib) [ 4813.852539] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 4814.335037] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 4816.127219] Key type lgssc registered [ 4817.950758] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4867.575023] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4990.414238] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4997.379066] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5028.721268] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5031.726392] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 5034.503392] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5036.903584] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 04:56:44 (1788598604) [ 5308.769229] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5319.077786] Lustre: Unmounted lustre-client [ 5463.174094] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5470.941663] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5497.213642] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5541.468432] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:05:09 (1788599109) [ 5642.300752] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5649.665434] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5674.470590] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5675.051796] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 5679.981829] Lustre: Unmounted lustre-client [ 5720.295040] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:08:08 (1788599288) [ 5823.635795] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5829.974595] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5853.616175] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5854.277705] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 5859.532299] Lustre: Unmounted lustre-client [ 5896.773994] Key type lgssc unregistered [ 5897.149255] LNet: 122550:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5897.169838] LNetError: 122550:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5898.216445] LNet: Removed LNI 192.168.204.45@tcp [ 5898.945738] Key type .llcrypt unregistered [ 5898.947650] Key type ._llcrypt unregistered [ 5915.384900] Key type ._llcrypt registered [ 5915.387698] Key type .llcrypt registered [ 5917.144866] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 05:11:24 (1788599484) [ 5919.316714] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5919.341541] alg: No test for adler32 (adler32-zlib) [ 5920.448898] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 5920.582814] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 5922.235132] Key type lgssc registered [ 5924.198485] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5979.044494] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5984.527587] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6007.200295] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6009.902913] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 6024.060785] Lustre: Unmounted lustre-client [ 6060.053315] Key type lgssc unregistered [ 6060.283059] LNet: 126154:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6060.292380] LNetError: 126154:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6060.317225] LNet: Removed LNI 192.168.204.45@tcp [ 6061.073473] Key type .llcrypt unregistered [ 6061.078474] Key type ._llcrypt unregistered [ 6076.800183] Key type ._llcrypt registered [ 6076.804065] Key type .llcrypt registered [ 6078.387337] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 05:14:06 (1788599646) [ 6080.665916] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6080.692584] alg: No test for adler32 (adler32-zlib) [ 6081.702545] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 6081.908076] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 6083.567199] Key type lgssc registered [ 6084.886588] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6135.810646] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6143.082909] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6168.845883] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6171.926754] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 6177.274621] Lustre: lustre-OST0000-osc-ffff8abec4873800: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6190.780779] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8abec4873800.ost_server_uuid 50 [ 6192.844166] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6205.057143] Lustre: Unmounted lustre-client [ 6230.165943] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 05:16:38 (1788599798) [ 6267.936375] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6276.062530] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6298.648636] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6326.970400] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6327.818567] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 6332.920996] Lustre: lustre-OST0000-osc-ffff8abec65c0000: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6362.032367] Lustre: Unmounted lustre-client [ 6415.752620] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 05:19:43 (1788599983) [ 6451.517564] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6457.507978] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6477.614490] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6501.677431] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6502.402437] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 6507.503637] Lustre: lustre-OST0000-osc-ffff8abec5113800: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6524.331761] Lustre: Unmounted lustre-client [ 6573.524922] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 05:22:21 (1788600141) [ 6666.269333] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6671.886150] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6694.965373] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6773.923629] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6779.806348] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6801.782471] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6832.406275] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 6874.533235] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6879.424613] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6881.858203] Lustre: Unmounted lustre-client [ 6914.893702] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 05:28:03 (1788600483) [ 6950.696574] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6957.000170] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6980.973909] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7018.990592] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7052.907142] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 7097.732732] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7099.629722] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7112.480875] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7122.898192] Lustre: Unmounted lustre-client [ 7180.961834] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 05:32:29 (1788600749) [ 7216.626935] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7222.708394] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7246.331341] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7246.996836] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 7271.406379] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7273.563673] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7291.347614] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8abed23b0000.ost_server_uuid 50 [ 7292.853357] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8abed23b0000.ost_server_uuid in IDLE state after 0 sec [ 7295.752267] Lustre: Unmounted lustre-client [ 7296.135719] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7296.143133] Lustre: Skipped 3 previous similar messages [ 7296.228357] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 7297.423628] LustreError: 149579:0:(sec.c:403:import_sec_validate_get()) import 0000000089294fac (NEW) with no sec [ 7356.214903] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 05:35:24 (1788600924) [ 7393.423341] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7398.498522] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7420.096815] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7441.392665] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7441.971487] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7442.138666] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 7456.463694] Lustre: Unmounted lustre-client [ 7456.471429] Lustre: Skipped 1 previous similar message [ 7493.855826] Key type lgssc unregistered [ 7494.173440] LNet: 152996:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7494.183688] LNetError: 152996:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7494.205923] LNet: Removed LNI 192.168.204.45@tcp [ 7494.907946] Key type .llcrypt unregistered [ 7494.913679] Key type ._llcrypt unregistered [ 7510.606161] Key type ._llcrypt registered [ 7510.607984] Key type .llcrypt registered [ 7511.757875] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 05:38:00 (1788601080) [ 7512.948784] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7512.967029] alg: No test for adler32 (adler32-zlib) [ 7514.087700] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 7514.412455] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 7516.119222] Key type lgssc registered [ 7517.450894] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7566.659476] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7573.181277] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7594.887210] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7617.993418] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7619.640647] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7620.835162] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 7628.833154] LustreError: lustre-MDT0001-mdc-ffff8abed23b2000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7628.889303] Lustre: lustre-MDT0001-mdc-ffff8abed23b2000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 7634.816812] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7636.427794] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7659.530745] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7663.483832] Lustre: Unmounted lustre-client [ 7690.966433] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 05:40:59 (1788601259) [ 7789.661593] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7795.306977] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7818.680545] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7819.440568] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 7847.292253] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7849.196920] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7860.187295] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7870.520228] Lustre: Unmounted lustre-client [ 7906.155279] Key type lgssc unregistered [ 7906.526263] LNet: 162600:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7906.546561] LNetError: 162600:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7906.569668] LNet: Removed LNI 192.168.204.45@tcp [ 7907.069621] Key type .llcrypt unregistered [ 7907.072551] Key type ._llcrypt unregistered [ 7937.888930] Key type ._llcrypt registered [ 7937.891078] Key type .llcrypt registered [ 7939.134828] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 05:45:07 (1788601507) [ 7941.845517] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7941.882073] alg: No test for adler32 (adler32-zlib) [ 7942.982784] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 7943.310822] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 7945.063264] Key type lgssc registered [ 7946.545871] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7997.630294] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8002.749135] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8026.814467] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8029.690967] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 8075.607772] Lustre: Unmounted lustre-client [ 8121.247446] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8122.106978] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 8159.017527] Lustre: Unmounted lustre-client [ 8188.386299] Key type lgssc unregistered [ 8188.734461] LNet: 167042:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8188.754882] LNetError: 167042:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8188.795322] LNet: Removed LNI 192.168.204.45@tcp [ 8189.885721] Key type .llcrypt unregistered [ 8189.897089] Key type ._llcrypt unregistered [ 8207.794118] Key type ._llcrypt registered [ 8207.796454] Key type .llcrypt registered [ 8209.292130] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 05:49:37 (1788601777) [ 8211.315048] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8211.534989] alg: No test for adler32 (adler32-zlib) [ 8212.797740] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 8213.104991] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8214.777058] Key type lgssc registered [ 8216.345617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8269.488814] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8276.362105] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8301.746871] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8304.716857] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 8325.621950] Lustre: Unmounted lustre-client [ 8362.776371] Key type lgssc unregistered [ 8363.054805] LNet: 170791:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8363.059466] LNetError: 170791:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8363.081387] LNet: Removed LNI 192.168.204.45@tcp [ 8364.114416] Key type .llcrypt unregistered [ 8364.117544] Key type ._llcrypt unregistered [ 8379.332385] Key type ._llcrypt registered [ 8379.341472] Key type .llcrypt registered [ 8380.064768] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8380.097103] alg: No test for adler32 (adler32-zlib) [ 8381.312869] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 8381.558291] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8383.335496] Key type lgssc registered [ 8385.023082] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8438.515536] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8444.503507] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8466.450661] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8468.122068] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 8476.822355] Lustre: Unmounted lustre-client [ 8505.304738] Key type lgssc unregistered [ 8505.599826] LNet: 173849:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8505.608037] LNetError: 173849:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8505.644438] LNet: Removed LNI 192.168.204.45@tcp [ 8506.426139] Key type .llcrypt unregistered [ 8506.433160] Key type ._llcrypt unregistered [ 8522.180305] Key type ._llcrypt registered [ 8522.182174] Key type .llcrypt registered [ 8523.316118] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 05:54:51 (1788602091) [ 8525.189108] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8525.211234] alg: No test for adler32 (adler32-zlib) [ 8526.255644] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 8526.542767] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8528.263200] Key type lgssc registered [ 8529.400321] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8579.132735] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8584.989330] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8606.679853] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8609.557060] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 8627.916031] Lustre: Unmounted lustre-client [ 8656.318062] Key type lgssc unregistered [ 8656.679475] LNet: 177597:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8656.685472] LNetError: 177597:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8657.716391] LNet: Removed LNI 192.168.204.45@tcp [ 8658.518391] Key type .llcrypt unregistered [ 8658.521890] Key type ._llcrypt unregistered [ 8672.012915] Key type ._llcrypt registered [ 8672.020556] Key type .llcrypt registered [ 8672.722273] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8672.734810] alg: No test for adler32 (adler32-zlib) [ 8673.844325] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 8674.056765] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8675.695637] Key type lgssc registered [ 8676.855699] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8733.122630] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8739.397425] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8762.862904] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8764.538064] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 8773.986197] Lustre: Unmounted lustre-client [ 8803.148923] Key type lgssc unregistered [ 8803.569515] LNet: 180655:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8803.580236] LNetError: 180655:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8803.619427] LNet: Removed LNI 192.168.204.45@tcp [ 8804.376455] Key type .llcrypt unregistered [ 8804.379611] Key type ._llcrypt unregistered [ 8823.368819] Key type ._llcrypt registered [ 8823.370764] Key type .llcrypt registered [ 8824.940356] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 05:59:52 (1788602392) [ 8849.573933] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8849.734382] alg: No test for adler32 (adler32-zlib) [ 8850.829560] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 8851.148660] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8852.888084] Key type lgssc registered [ 8854.374246] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8945.521897] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8951.868289] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8975.631741] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9020.351189] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 06:03:08 (1788602588) [ 9055.987604] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9061.455939] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9081.972342] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9084.679864] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 9093.249138] Lustre: Unmounted lustre-client [ 9123.100699] Key type lgssc unregistered [ 9123.425710] LNet: 187762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9123.436348] LNetError: 187762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9123.463619] LNet: Removed LNI 192.168.204.45@tcp [ 9124.435313] Key type .llcrypt unregistered [ 9124.451742] Key type ._llcrypt unregistered [ 9141.053166] Key type ._llcrypt registered [ 9141.055361] Key type .llcrypt registered [ 9142.775926] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9144.491333] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 06:05:12 (1788602712) [ 9164.150576] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9164.188585] alg: No test for adler32 (adler32-zlib) [ 9165.250924] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 9165.434924] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9167.095428] Key type lgssc registered [ 9168.373235] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9264.850887] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9270.997962] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9298.758179] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9321.044538] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9323.678422] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 9346.902396] Lustre: Unmounted lustre-client [ 9482.643954] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9487.708750] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9509.542562] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9559.643647] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 06:12:07 (1788603127) [ 9561.365667] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9563.355147] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 06:12:11 (1788603131) [ 9659.892892] Key type lgssc unregistered [ 9660.111976] LNet: 199197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9660.120518] LNetError: 199197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9660.138288] LNet: Removed LNI 192.168.204.45@tcp [ 9660.804975] Key type .llcrypt unregistered [ 9660.809816] Key type ._llcrypt unregistered [ 9674.565768] Key type ._llcrypt registered [ 9674.567956] Key type .llcrypt registered [ 9675.737449] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 06:14:04 (1788603244) [ 9716.752486] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9716.768183] alg: No test for adler32 (adler32-zlib) [ 9718.027430] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 9718.338524] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9720.007655] Key type lgssc registered [ 9721.485732] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9767.652948] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9773.074178] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9807.933845] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9836.754870] Key type lgssc unregistered [ 9837.059826] LNet: 202930:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9837.066530] LNetError: 202930:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9837.098927] LNet: Removed LNI 192.168.204.45@tcp [ 9837.876708] Key type .llcrypt unregistered [ 9837.883747] Key type ._llcrypt unregistered [ 9856.239982] Key type ._llcrypt registered [ 9856.241447] Key type .llcrypt registered [ 9857.712654] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 06:17:05 (1788603425) [ 9860.645994] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9860.665288] alg: No test for adler32 (adler32-zlib) [ 9861.815314] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [ 9862.096777] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9863.799182] Key type lgssc registered [ 9865.140843] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9916.223836] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9921.532783] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9944.999958] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9946.635533] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [ 9961.967682] Lustre: lustre-MDT0000-mdc-ffff8abec8c50000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9972.200396] Lustre: lustre-MDT0001-mdc-ffff8abec8c50000: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9982.431524] Lustre: 203918:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788603536/real 1788603536] req@00000000ce78a09c x1875486631346816/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1788603552 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9982.477269] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 9992.815683] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0x472ce707791cf22e to 0x472ce707791d0da2 [ 9992.827644] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10017.785841] LustreError: lustre-MDT0000-mdc-ffff8abec8c50000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10017.871669] Lustre: lustre-MDT0000-mdc-ffff8abec8c50000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10023.413789] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10025.336851] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10030.856530] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10032.016524] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10035.222888] Lustre: Unmounted lustre-client [10062.183811] Key type lgssc unregistered [10062.405636] LNet: 207867:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10062.424080] LNetError: 207867:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10062.444661] LNet: Removed LNI 192.168.204.45@tcp [10063.202871] Key type .llcrypt unregistered [10063.205599] Key type ._llcrypt unregistered [10078.701857] Key type ._llcrypt registered [10078.708899] Key type .llcrypt registered [10080.004784] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 06:20:48 (1788603648) [10082.499496] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10082.516837] alg: No test for adler32 (adler32-zlib) [10083.586141] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [10083.804689] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [10085.487216] Key type lgssc registered [10086.670317] Lustre: Echo OBD driver; http://www.lustre.org/ [10135.620349] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10141.940723] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10196.068658] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10201.968568] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10235.709470] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10258.045351] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10297.026608] Key type lgssc unregistered [10297.333764] LNet: 213153:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10297.348697] LNetError: 213153:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10297.378914] LNet: Removed LNI 192.168.204.45@tcp [10298.185645] Key type .llcrypt unregistered [10298.188519] Key type ._llcrypt unregistered [10341.628660] Key type ._llcrypt registered [10341.630724] Key type .llcrypt registered [10342.602473] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 06:25:11 (1788603911) [10380.121244] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10380.156971] alg: No test for adler32 (adler32-zlib) [10381.228579] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [10381.426672] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [10383.079806] Key type lgssc registered [10384.271406] Lustre: Echo OBD driver; http://www.lustre.org/ [10466.487887] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10472.252753] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10493.449590] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10535.158901] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 06:28:23 (1788604103) [10543.386701] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 06:28:31 (1788604111) [10576.206739] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10581.870925] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10605.327512] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10607.019033] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [10613.051752] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10614.916981] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10616.251990] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10617.774274] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10622.465486] Lustre: lustre-MDT0000-mdc-ffff8abec6c5b000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [10638.815142] Lustre: 215046:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788604192/real 1788604192] req@00000000d4b4c43d x1875487176533632/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1788604208 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10638.841573] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [10638.872476] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0xd1e1a4cac58cd9a6 to 0xd1e1a4cac58cdb19 [10638.897172] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10653.969968] Lustre: lustre-MDT0000-mdc-ffff8abec6c5b000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10662.235588] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10663.871583] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10667.509812] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10669.557262] Lustre: lustre-MDT0000-mdc-ffff8abec6c5b000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [10690.031589] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [10690.068244] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0xd1e1a4cac58cdb19 to 0xd1e1a4cac58cdf25 [10690.090659] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10694.412842] Lustre: lustre-MDT0000-mdc-ffff8abec6c5b000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10703.286395] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10704.621398] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10708.248262] Lustre: Unmounted lustre-client [10774.477172] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10779.735968] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10801.099773] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10801.595856] LustreError: 215044:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [10801.654643] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [10803.954204] Lustre: Unmounted lustre-client [10831.153946] Key type lgssc unregistered [10831.480559] LNet: 225611:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10831.495328] LNetError: 225611:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10831.531460] LNet: Removed LNI 192.168.204.45@tcp [10832.311700] Key type .llcrypt unregistered [10832.316085] Key type ._llcrypt unregistered [10847.247660] Key type ._llcrypt registered [10847.249821] Key type .llcrypt registered [10848.615556] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 06:33:36 (1788604416) [10852.855514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10852.872958] alg: No test for adler32 (adler32-zlib) [10853.995586] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [10854.344684] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [10856.111239] Key type lgssc registered [10857.790447] Lustre: Echo OBD driver; http://www.lustre.org/ [10910.026683] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10915.789760] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10936.995171] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10939.549691] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [10949.165393] Lustre: Unmounted lustre-client [11014.497140] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11019.378294] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11040.067176] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11041.024451] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [11052.046188] Lustre: Unmounted lustre-client [11122.174856] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11127.443410] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11151.195779] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11151.799328] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [11154.747922] Lustre: Unmounted lustre-client [11181.599824] Key type lgssc unregistered [11181.833991] LNet: 232651:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11181.842292] LNetError: 232651:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11181.860574] LNet: Removed LNI 192.168.204.45@tcp [11182.607495] Key type .llcrypt unregistered [11182.609174] Key type ._llcrypt unregistered [11198.804937] Key type ._llcrypt registered [11198.808548] Key type .llcrypt registered [11200.057808] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 06:39:28 (1788604768) [11203.558605] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11203.593338] alg: No test for adler32 (adler32-zlib) [11204.642588] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [11204.930637] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [11206.615925] Key type lgssc registered [11208.040247] Lustre: Echo OBD driver; http://www.lustre.org/ [11255.973963] Key type lgssc unregistered [11256.205498] LNet: 234971:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11256.215857] LNetError: 234971:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11256.232788] LNet: Removed LNI 192.168.204.45@tcp [11257.000898] Key type .llcrypt unregistered [11257.007977] Key type ._llcrypt unregistered [11288.359446] Key type ._llcrypt registered [11288.373114] Key type .llcrypt registered [11288.941570] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11288.957584] alg: No test for adler32 (adler32-zlib) [11290.104369] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [11290.419663] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [11292.120448] Key type lgssc registered [11293.452423] Lustre: Echo OBD driver; http://www.lustre.org/ [11380.460636] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11387.351552] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11414.037095] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11458.070539] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11459.828354] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 06:43:48 (1788605028) [11498.041347] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11503.922549] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11526.350273] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11553.517739] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11555.292570] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [11560.470164] Lustre: lustre-OST0001-osc-ffff8abec5cad800: Connection to lustre-OST0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [11568.377477] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11578.750126] Lustre: Unmounted lustre-client [11614.289858] Key type lgssc unregistered [11614.557556] LNet: 242090:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11614.569257] LNetError: 242090:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11614.593449] LNet: Removed LNI 192.168.204.45@tcp [11615.495899] Key type .llcrypt unregistered [11615.498336] Key type ._llcrypt unregistered [11651.803595] Key type ._llcrypt registered [11651.807430] Key type .llcrypt registered [11653.545291] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 06:47:01 (1788605221) [11667.437204] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11667.470653] alg: No test for adler32 (adler32-zlib) [11668.655909] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [11669.038110] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [11670.760655] Key type lgssc registered [11672.349273] Lustre: Echo OBD driver; http://www.lustre.org/ [11729.950772] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11736.734333] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11760.158639] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 06:48:48 (1788605328) [11796.237328] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11802.441475] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11828.376920] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11831.094879] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [11845.663068] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11851.219296] Lustre: Unmounted lustre-client [11965.459568] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11972.676221] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12026.098676] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12027.114204] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [12029.437669] Lustre: Unmounted lustre-client [12058.346536] Key type lgssc unregistered [12058.744364] LNet: 249798:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12058.754722] LNetError: 249798:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12058.772326] LNet: Removed LNI 192.168.204.45@tcp [12059.446447] Key type .llcrypt unregistered [12059.448482] Key type ._llcrypt unregistered [12092.283292] Key type ._llcrypt registered [12092.289940] Key type .llcrypt registered [12092.619951] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12092.639222] alg: No test for adler32 (adler32-zlib) [12093.805605] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [12094.045814] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12095.791321] Key type lgssc registered [12097.458324] Lustre: Echo OBD driver; http://www.lustre.org/ [12183.019495] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12188.531404] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12213.040411] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12263.574611] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12265.557505] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 06:57:13 (1788605833) [12300.312910] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12307.505189] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12330.663529] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12336.909434] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [12342.544546] Lustre: Unmounted lustre-client [12372.176881] Key type lgssc unregistered [12372.506793] LNet: 256437:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12372.527179] LNetError: 256437:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12372.542838] LNet: Removed LNI 192.168.204.45@tcp [12373.297951] Key type .llcrypt unregistered [12373.300978] Key type ._llcrypt unregistered [12389.696935] Key type ._llcrypt registered [12389.700360] Key type .llcrypt registered [12390.782695] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12392.811830] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 06:59:21 (1788605961) [12403.511955] Key type .llcrypt unregistered [12403.517910] Key type ._llcrypt unregistered [12412.772202] Key type ._llcrypt registered [12412.776141] Key type .llcrypt registered [12413.230133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12413.248329] alg: No test for adler32 (adler32-zlib) [12414.372312] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [12414.659343] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12416.351700] Key type lgssc registered [12417.566504] Lustre: Echo OBD driver; http://www.lustre.org/ [12467.323330] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12484.313955] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [12486.900588] Lustre: Unmounted lustre-client [12510.475132] Key type lgssc unregistered [12510.901289] LNet: 259906:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12510.908978] LNetError: 259906:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12510.934557] LNet: Removed LNI 192.168.204.45@tcp [12511.659926] Key type .llcrypt unregistered [12511.664672] Key type ._llcrypt unregistered [12529.384858] Key type ._llcrypt registered [12529.387579] Key type .llcrypt registered [12530.489485] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 07:01:38 (1788606098) [12532.581922] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12532.610400] alg: No test for adler32 (adler32-zlib) [12533.674997] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [12533.904826] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12535.559445] Key type lgssc registered [12536.726744] Lustre: Echo OBD driver; http://www.lustre.org/ [12621.578527] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12656.603863] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12662.384295] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12665.108743] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [12667.600178] Lustre: Unmounted lustre-client [12689.278932] Key type lgssc unregistered [12689.563353] LNet: 263451:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12689.578583] LNetError: 263451:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12689.601547] LNet: Removed LNI 192.168.204.45@tcp [12690.233526] Key type .llcrypt unregistered [12690.235359] Key type ._llcrypt unregistered [12705.723795] Key type ._llcrypt registered [12705.726742] Key type .llcrypt registered [12706.914810] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 07:04:35 (1788606275) [12708.787882] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12708.807986] alg: No test for adler32 (adler32-zlib) [12709.793832] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [12710.003498] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12711.679196] Key type lgssc registered [12712.844438] Lustre: Echo OBD driver; http://www.lustre.org/ [12766.284471] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12771.916628] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12792.976902] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12794.812898] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [12799.986971] Lustre: lustre-MDT0000-mdc-ffff8abec3f3a800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [12805.432872] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12805.465417] LustreError: 266607:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12805.972967] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [12806.036890] Lustre: Unmounted lustre-client [12824.314763] Key type lgssc unregistered [12824.572308] LNet: 267019:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12824.579413] LNetError: 267019:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12824.610277] LNet: Removed LNI 192.168.204.45@tcp [12825.261993] Key type .llcrypt unregistered [12825.267551] Key type ._llcrypt unregistered [12841.239227] Key type ._llcrypt registered [12841.242358] Key type .llcrypt registered [12842.241992] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 07:06:50 (1788606410) [12843.927922] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12843.964389] alg: No test for adler32 (adler32-zlib) [12845.198796] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [12845.410850] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12847.079183] Key type lgssc registered [12848.922228] Lustre: Echo OBD driver; http://www.lustre.org/ [12896.412925] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12900.804540] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12921.809756] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12923.378736] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [12928.489430] Lustre: lustre-MDT0001-mdc-ffff8abed17fd800: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [12929.757101] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12931.776662] Lustre: Unmounted lustre-client [12952.197756] Key type lgssc unregistered [12952.640313] LNet: 270596:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12952.653682] LNetError: 270596:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12952.673851] LNet: Removed LNI 192.168.204.45@tcp [12953.498929] Key type .llcrypt unregistered [12953.500547] Key type ._llcrypt unregistered [12970.948381] Key type ._llcrypt registered [12970.950524] Key type .llcrypt registered [12972.293434] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 07:09:00 (1788606540) [12993.949996] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12994.053478] alg: No test for adler32 (adler32-zlib) [12995.154836] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [12995.488859] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12997.255258] Key type lgssc registered [12998.850567] Lustre: Echo OBD driver; http://www.lustre.org/ [13113.363923] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13116.014959] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [13154.796732] Lustre: lustre-MDT0001-mdc-ffff8abec6384000: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [13165.750956] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13176.092847] Lustre: Unmounted lustre-client [13205.330433] Key type lgssc unregistered [13205.524930] LNet: 276382:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13205.531497] LNetError: 276382:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13205.559400] LNet: Removed LNI 192.168.204.45@tcp [13206.325192] Key type .llcrypt unregistered [13206.333742] Key type ._llcrypt unregistered [13224.521947] Key type ._llcrypt registered [13224.523850] Key type .llcrypt registered [13225.662179] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 07:13:14 (1788606794) [13227.169905] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13228.772823] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 07:13:17 (1788606797) [13230.200591] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13232.242236] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 07:13:20 (1788606800) [13233.851697] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13236.400600] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 07:13:24 (1788606804) [13238.545943] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13240.922641] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 07:13:28 (1788606808) [13243.021144] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13245.379491] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 07:13:33 (1788606813) [13254.717328] Key type .llcrypt unregistered [13254.719962] Key type ._llcrypt unregistered [13263.438821] Key type ._llcrypt registered [13263.447255] Key type .llcrypt registered [13264.078155] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13264.094837] alg: No test for adler32 (adler32-zlib) [13265.257425] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [13265.543606] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [13267.288558] Key type lgssc registered [13268.746800] Lustre: Echo OBD driver; http://www.lustre.org/ [13348.072711] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13354.625974] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13378.722883] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13380.443379] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [13383.209414] Lustre: Unmounted lustre-client [13421.348411] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 07:16:29 (1788606989) [13454.884843] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13460.425478] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13495.803319] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13501.492728] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [13503.257268] Lustre: Unmounted lustre-client [13542.856518] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 07:18:31 (1788607111) [13554.335928] LNet: 1 local NIs in recovery (showing 1): 192.168.204.45@tcp [14191.012276] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14195.843630] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14228.136300] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14327.796338] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 07:31:36 (1788607896) [14339.748515] Key type lgssc unregistered [14340.011913] LNet: 289910:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14340.024112] LNetError: 289910:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14340.037233] LNet: Removed LNI 192.168.204.45@tcp [14340.703696] Key type .llcrypt unregistered [14340.706795] Key type ._llcrypt unregistered [14479.600172] Key type ._llcrypt registered [14479.602411] Key type .llcrypt registered [14480.414226] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14480.456303] alg: No test for adler32 (adler32-zlib) [14481.647752] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [14482.005252] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [14483.791588] Key type lgssc registered [14485.354637] Lustre: Echo OBD driver; http://www.lustre.org/ [14567.979151] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14572.600128] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14591.722417] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14638.977897] Key type lgssc unregistered [14639.190574] LNet: 293609:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14639.195382] LNetError: 293609:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14639.215558] LNet: Removed LNI 192.168.204.45@tcp [14639.931795] Key type .llcrypt unregistered [14639.933543] Key type ._llcrypt unregistered [14675.854685] Key type ._llcrypt registered [14675.856776] Key type .llcrypt registered [14676.960790] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 07:37:25 (1788608245) [14697.142837] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14697.153988] alg: No test for adler32 (adler32-zlib) [14698.163341] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [14698.333495] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [14699.999203] Key type lgssc registered [14701.324995] Lustre: Echo OBD driver; http://www.lustre.org/ [14754.944369] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 07:38:42 (1788608322) [14768.564586] Key type lgssc unregistered [14768.848796] LNet: 297163:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14768.863153] LNetError: 297163:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14768.885242] LNet: Removed LNI 192.168.204.45@tcp [14769.704731] Key type .llcrypt unregistered [14769.708383] Key type ._llcrypt unregistered [14783.219456] Key type ._llcrypt registered [14783.222143] Key type .llcrypt registered [14783.576755] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14783.588724] alg: No test for adler32 (adler32-zlib) [14784.553478] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [14784.829890] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [14786.591190] Key type lgssc registered [14787.842437] Lustre: Echo OBD driver; http://www.lustre.org/ [14846.707645] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14852.503677] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14874.830910] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15214.602062] LNet: Added LNI 192.168.204.45@tcp50 [8/256/0/180] [15217.674143] LNet: Removed LNI 192.168.204.45@tcp [15220.157737] Lustre: 301564:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8abec58aa800: config has no valid NIDs, force dynamic NIDs [15221.507978] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [15221.783372] Lustre: Unmounted lustre-client [15225.921661] Key type lgssc unregistered [15226.358789] LNet: 301824:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15226.368485] LNetError: 301824:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15226.399307] LNet: Removed LNI 192.168.204.45@tcp50 [15227.260038] Key type .llcrypt unregistered [15227.268392] Key type ._llcrypt unregistered [15246.568494] Key type ._llcrypt registered [15246.569848] Key type .llcrypt registered [15246.983399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15247.023889] alg: No test for adler32 (adler32-zlib) [15248.152941] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [15248.421694] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15250.119182] Key type lgssc registered [15251.516537] Lustre: Echo OBD driver; http://www.lustre.org/ [15317.058499] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15324.243262] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15332.158650] LNet: Added LNI 192.168.204.45@tcp50 [8/256/0/180] [15333.169462] LNet: Removed LNI 192.168.204.45@tcp [15334.412695] Lustre: 304513:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8abec3f39800: config has no valid NIDs, force dynamic NIDs [15335.669547] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [15336.144196] Lustre: Unmounted lustre-client [15372.723866] Key type lgssc unregistered [15373.082112] LNet: 305380:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15373.088650] LNetError: 305380:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15373.111511] LNet: Removed LNI 192.168.204.45@tcp50 [15373.559631] Key type .llcrypt unregistered [15373.564113] Key type ._llcrypt unregistered [15385.277397] Key type ._llcrypt registered [15385.279556] Key type .llcrypt registered [15386.750392] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 07:49:14 (1788608954) [15408.586856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15408.618234] alg: No test for adler32 (adler32-zlib) [15409.659450] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [15410.041287] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15411.807384] Key type lgssc registered [15412.821699] Lustre: Echo OBD driver; http://www.lustre.org/ [15503.751847] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15510.562305] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15537.347565] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15571.425933] Key type lgssc unregistered [15571.734879] LNet: 310123:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15571.750382] LNetError: 310123:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15571.773336] LNet: Removed LNI 192.168.204.45@tcp [15572.475847] Key type .llcrypt unregistered [15572.484880] Key type ._llcrypt unregistered [15586.557428] Key type ._llcrypt registered [15586.560511] Key type .llcrypt registered [15588.243376] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 07:52:36 (1788609156) [15590.781068] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15590.888710] alg: No test for adler32 (adler32-zlib) [15592.167596] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [15592.562556] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15594.263515] Key type lgssc registered [15595.465842] Lustre: Echo OBD driver; http://www.lustre.org/ [15650.423945] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15657.166973] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15679.258647] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15681.862512] Lustre: Mounted lustre-client - version 2.17.58_2_gae7f7f4 [15737.880406] Lustre: Mounted fs15246-client - version 2.17.58_2_gae7f7f4 [15757.705781] Lustre: Unmounted fs15246-client [15786.208266] Lustre: Unmounted lustre-client [15812.634402] Key type lgssc unregistered [15812.891253] LNet: 314978:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15812.901437] LNetError: 314978:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15813.937395] LNet: Removed LNI 192.168.204.45@tcp [15814.714527] Key type .llcrypt unregistered [15814.718529] Key type ._llcrypt unregistered [15826.143382] Key type ._llcrypt registered [15826.145211] Key type .llcrypt registered [15827.292399] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 07:56:35 (1788609395) [15828.989238] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15829.018127] alg: No test for adler32 (adler32-zlib) [15830.052833] Lustre: Lustre: Build Version: 2.17.58_2_gae7f7f4 [15830.232600] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15831.855172] Key type lgssc registered [15833.283446] Lustre: Echo OBD driver; http://www.lustre.org/ [15961.348813] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15966.755104] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15991.633931] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16089.863585] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15791 sec ========= 08:00:58 (1788609658) [16091.634110] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 08:00:59 (1788609659) === [16095.188339] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 08:01:03 (1788609663) === [16130.670401] Key type lgssc unregistered [16130.926189] LNet: 324251:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16130.935413] LNetError: 324251:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16130.948849] LNet: Removed LNI 192.168.204.45@tcp [16131.619831] Key type .llcrypt unregistered [16131.626076] Key type ._llcrypt unregistered