[ 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 456265911 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002298] x2apic enabled [ 0.003005] Switched APIC routing to physical x2apic. [ 0.004015] kvm-guest: setup PV IPIs [ 0.006761] ..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.008016] pid_max: default: 32768 minimum: 301 [ 0.009141] LSM: Security Framework initializing [ 0.010078] Yama: becoming mindful. [ 0.011037] SELinux: Initializing. [ 0.012074] *** VALIDATE selinux *** [ 0.021228] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026081] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028163] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031003] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032153] *** VALIDATE tmpfs *** [ 0.033367] *** VALIDATE proc *** [ 0.034168] *** VALIDATE cgroup *** [ 0.035005] *** VALIDATE cgroup2 *** [ 0.036161] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037138] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039022] Spectre V2 : User space: Vulnerable [ 0.040006] Speculative Store Bypass: Vulnerable [ 0.043285] debug: unmapping init [mem 0xffffffffaa059000-0xffffffffaa060fff] [ 0.045121] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046477] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047019] ... version: 2 [ 0.048007] ... bit width: 48 [ 0.048883] ... generic registers: 4 [ 0.049010] ... value mask: 0000ffffffffffff [ 0.050008] ... max period: 00007fffffffffff [ 0.051010] ... fixed-purpose events: 3 [ 0.052008] ... event mask: 000000070000000f [ 0.053316] rcu: Hierarchical SRCU implementation. [ 0.055511] smp: Bringing up secondary CPUs ... [ 0.056572] x86: Booting SMP configuration: [ 0.057025] .... node #0, CPUs: #1 #2 #3 [ 0.060011] smp: Brought up 1 node, 4 CPUs [ 0.062012] smpboot: Max logical packages: 1 [ 0.063015] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.143016] node 0 deferred pages initialised in 79ms [ 0.146007] devtmpfs: initialized [ 0.146842] x86/mm: Memory block size: 128MB [ 0.149742] gcov: version magic: 0x41383552 [ 0.152139] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.153065] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.154253] pinctrl core: initialized pinctrl subsystem [ 0.155160] [ 0.155676] ************************************************************* [ 0.156014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.157013] ** ** [ 0.158009] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.159007] ** ** [ 0.160012] ** This means that this kernel is built to expose internal ** [ 0.161014] ** IOMMU data structures, which may compromise security on ** [ 0.162009] ** your system. ** [ 0.163007] ** ** [ 0.164010] ** If you see this message and you are not debugging the ** [ 0.165011] ** kernel, report this immediately to your vendor! ** [ 0.166011] ** ** [ 0.167015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.168015] ************************************************************* [ 0.169599] NET: Registered protocol family 16 [ 0.171390] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.173060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.175064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.179033] cpuidle: using governor menu [ 0.180687] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.183468] PCI: Using configuration type 1 for base access [ 0.186124] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.194072] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.196036] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.199127] cryptd: max_cpu_qlen set to 1000 [ 0.202195] ACPI: Added _OSI(Module Device) [ 0.203014] ACPI: Added _OSI(Processor Device) [ 0.205014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.206014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.211000] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.216415] ACPI: Interpreter enabled [ 0.218058] ACPI: PM: (supports S0 S3 S4 S5) [ 0.219011] ACPI: Using IOAPIC for interrupt routing [ 0.221107] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.224173] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.232760] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.235048] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.237022] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.241076] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.246283] acpiphp: Slot [2] registered [ 0.247094] acpiphp: Slot [5] registered [ 0.249131] acpiphp: Slot [6] registered [ 0.250148] acpiphp: Slot [3] registered [ 0.252082] acpiphp: Slot [4] registered [ 0.252905] acpiphp: Slot [7] registered [ 0.253066] acpiphp: Slot [8] registered [ 0.253996] acpiphp: Slot [9] registered [ 0.255060] acpiphp: Slot [10] registered [ 0.256080] acpiphp: Slot [11] registered [ 0.258098] acpiphp: Slot [12] registered [ 0.259107] acpiphp: Slot [13] registered [ 0.261095] acpiphp: Slot [14] registered [ 0.262092] acpiphp: Slot [15] registered [ 0.263126] acpiphp: Slot [16] registered [ 0.265095] acpiphp: Slot [17] registered [ 0.266089] acpiphp: Slot [18] registered [ 0.267093] acpiphp: Slot [19] registered [ 0.269066] acpiphp: Slot [20] registered [ 0.270079] acpiphp: Slot [21] registered [ 0.271117] acpiphp: Slot [22] registered [ 0.272080] acpiphp: Slot [23] registered [ 0.274081] acpiphp: Slot [24] registered [ 0.275070] acpiphp: Slot [25] registered [ 0.276098] acpiphp: Slot [26] registered [ 0.278092] acpiphp: Slot [27] registered [ 0.279089] acpiphp: Slot [28] registered [ 0.281113] acpiphp: Slot [29] registered [ 0.282063] acpiphp: Slot [30] registered [ 0.282897] acpiphp: Slot [31] registered [ 0.284063] PCI host bridge to bus 0000:00 [ 0.285027] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.287023] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.289021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.291022] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.293029] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.296030] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.299255] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.301980] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.304152] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.311011] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.313394] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.314011] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.316010] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.318015] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.319383] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.321450] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.323034] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.324634] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.327010] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.332613] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.336013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.342063] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.351020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.359015] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.377029] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.385000] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.393015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.400014] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.412015] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.422162] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.424417] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.426323] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.429371] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.431223] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.435139] iommu: Default domain type: Passthrough [ 0.438074] SCSI subsystem initialized [ 0.439169] ACPI: bus type USB registered [ 0.441109] usbcore: registered new interface driver usbfs [ 0.443072] usbcore: registered new interface driver hub [ 0.444072] usbcore: registered new device driver usb [ 0.446162] pps_core: LinuxPPS API ver. 1 registered [ 0.447010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.449081] PTP clock support registered [ 0.451136] EDAC MC: Ver: 3.0.0 [ 0.453133] PCI: Using ACPI for IRQ routing [ 0.454794] NetLabel: Initializing [ 0.455009] NetLabel: domain hash size = 128 [ 0.455890] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.458102] NetLabel: unlabeled traffic allowed by default [ 0.460059] vgaarb: loaded [ 0.461270] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.463014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.469295] clocksource: Switched to clocksource kvm-clock [ 0.564454] VFS: Disk quotas dquot_6.6.0 [ 0.565539] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.567126] *** VALIDATE ramfs *** [ 0.568036] *** VALIDATE hugetlbfs *** [ 0.569237] pnp: PnP ACPI init [ 0.571169] pnp: PnP ACPI: found 6 devices [ 0.595730] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.598928] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.601272] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.603453] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.605970] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.608607] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.611494] NET: Registered protocol family 2 [ 0.613793] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.618674] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.621837] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.626645] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.630250] TCP: Hash tables configured (established 65536 bind 65536) [ 0.633117] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.636297] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.638962] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.642202] NET: Registered protocol family 1 [ 0.645335] RPC: Registered named UNIX socket transport module. [ 0.647653] RPC: Registered udp transport module. [ 0.649253] RPC: Registered tcp transport module. [ 0.650756] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.652548] NET: Registered protocol family 44 [ 0.654201] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.656548] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.658409] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.659959] PCI: CLS 0 bytes, default 64 [ 0.661777] Unpacking initramfs... [ 1.988931] debug: unmapping init [mem 0xffffa02b7cc64000-0xffffa02b7ffcffff] [ 1.992810] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 1.994407] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 1.996368] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.428271] Initialise system trusted keyrings [ 2.429445] Key type blacklist registered [ 2.430709] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.437902] zbud: loaded [ 2.440150] *** VALIDATE nfs *** [ 2.440953] *** VALIDATE nfs4 *** [ 2.441870] pstore: using deflate compression [ 2.444513] Platform Keyring initialized [ 2.530983] NET: Registered protocol family 38 [ 2.532523] Key type asymmetric registered [ 2.533761] Asymmetric key parser 'x509' registered [ 2.534949] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.537459] io scheduler mq-deadline registered [ 2.538615] io scheduler kyber registered [ 2.539943] io scheduler bfq registered [ 2.541569] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.543891] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.546155] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.547985] ACPI: Power Button [PWRF] [ 2.551784] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.556359] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.569859] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.597228] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.628406] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.632808] Non-volatile memory driver v1.3 [ 2.634758] Linux agpgart interface v0.103 [ 2.665469] virtio_blk virtio1: [vda] 150400 512-byte logical blocks (77.0 MB/73.4 MiB) [ 2.667425] vda: detected capacity change from 0 to 77004800 [ 2.682684] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.685161] vdb: detected capacity change from 0 to 1073741824 [ 2.689533] libphy: Fixed MDIO Bus: probed [ 2.700039] usbcore: registered new interface driver usbserial_generic [ 2.701989] usbserial: USB Serial support registered for generic [ 2.703699] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.707794] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.710321] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.713109] mousedev: PS/2 mouse device common for all mice [ 2.716388] rtc_cmos 00:05: RTC can wake from S4 [ 2.719699] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.719792] rtc_cmos 00:05: registered as rtc0 [ 2.724852] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.727569] intel_pstate: CPU model not supported [ 2.730605] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.731778] hid: raw HID events driver (C) Jiri Kosina [ 2.736904] usbcore: registered new interface driver usbhid [ 2.739044] usbhid: USB HID core driver [ 2.740871] drop_monitor: Initializing network drop monitor service [ 2.740880] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.743343] Initializing XFRM netlink socket [ 2.749391] NET: Registered protocol family 10 [ 2.752379] Segment Routing with IPv6 [ 2.753880] NET: Registered protocol family 17 [ 2.756186] mpls_gso: MPLS GSO support [ 2.761035] RAS: Correctable Errors collector initialized. [ 2.762547] AVX version of gcm_enc/dec engaged. [ 2.763699] AES CTR mode by8 optimization enabled [ 2.826816] sched_clock: Marking stable (2826798449, 0)->(3687922953, -861124504) [ 2.829880] registered taskstats version 1 [ 2.831218] Loading compiled-in X.509 certificates [ 2.832466] zswap: loaded using pool lzo/zbud [ 2.852677] Key type big_key registered [ 2.863881] Key type encrypted registered [ 2.865817] ima: No TPM chip found, activating TPM-bypass! [ 2.868058] ima: Allocated hash algorithm: sha1 [ 2.869932] ima: No architecture policies found [ 2.871697] evm: Initialising EVM extended attributes: [ 2.873591] evm: security.selinux [ 2.874881] evm: security.ima [ 2.876053] evm: security.capability [ 2.877544] evm: HMAC attrs: 0x1 [ 2.880351] rtc_cmos 00:05: setting system clock to 2026-10-01 21:52:15 UTC (1790891535) [ 2.887604] debug: unmapping init [mem 0xffffffffab003000-0xffffffffab1fffff] [ 2.890763] debug: unmapping init [mem 0xffffffffa9d82000-0xffffffffaa058fff] [ 2.903124] Write protecting the kernel read-only data: 28672k [ 2.906683] debug: unmapping init [mem 0xffffffffa8403000-0xffffffffa85fffff] [ 2.909263] debug: unmapping init [mem 0xffffffffa8d14000-0xffffffffa8dfffff] [ 2.942380] 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) [ 2.951225] systemd[1]: Detected virtualization kvm. [ 2.953048] systemd[1]: Detected architecture x86-64. [ 2.955057] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 2.981574] systemd[1]: No hostname configured. [ 2.983484] systemd[1]: Set hostname to . [ 2.985752] random: systemd: uninitialized urandom read (16 bytes read) [ 2.988587] systemd[1]: Initializing machine ID from random generator. [ 3.036789] random: ln: uninitialized urandom read (6 bytes read) [ 3.104239] random: systemd: uninitialized urandom read (16 bytes read) [ 3.106781] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.111324] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.116059] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... Starting Create Volatile Files and Directories... [ OK ] Reached target Timers. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Swap. [ OK ] Reached target Slices. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Sockets. Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ 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... [ 3.642130] device-mapper: uevent: version 1.0.3 [ 3.644524] 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. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.276455] virtio_net virtio0 ens2: renamed from eth0 [ 4.393818] scsi host0: ata_piix [ 4.415600] scsi host1: ata_piix [ 4.417205] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.419716] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 7.972363] dracut-initqueue[577]: RTNETLINK answers: File exists [ 9.384621] random: crng init done [ 9.386059] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.633249] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 10.599148] printk: systemd: 26 output lines suppressed due to ratelimiting [ 10.791919] SELinux: Disabled at runtime. [ 10.847761] 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) [ 10.856363] systemd[1]: Detected virtualization kvm. [ 10.858322] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.286735] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.289829] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.294793] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.299250] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.302189] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.308286] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.311973] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on udev Control Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Starting Create list of required st…ce nodes for the current kernel... Mounting Huge Pages File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Starting Apply Kernel Variables... [ OK ] Reached target Slices. Mounting POSIX Message Queue File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target Paths. [ 11.446292] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ 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 ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Started udev Coldplug all Devices. [ 11.691900] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /mnt. [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 11.913671] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 11.978206] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.077074] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.087722] EDAC sbridge: Ver: 1.1.2 [ 12.966192] Key type dns_resolver registered [ 13.228524] NFS: Registering the id_resolver key type [ 13.231216] Key type id_resolver registered [ 13.233251] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Login Service... Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Authorization Manager. [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg234-client login: [ 48.060083] hrtimer: interrupt took 3995009 ns [ 75.679556] libcfs: loading out-of-tree module taints kernel. [ 75.799779] Key type ._llcrypt registered [ 75.805781] Key type .llcrypt registered [ 76.383298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 76.421258] alg: No test for adler32 (adler32-zlib) [ 77.732465] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 78.875328] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 80.679792] Key type lgssc registered [ 83.226834] Lustre: Echo OBD driver; http://www.lustre.org/ [ 261.716573] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 266.539943] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 278.285598] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing check_logdir /tmp/testlogs/ [ 285.491806] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing yml_node [ 287.200281] Lustre: lustre-OST0000-osc-ffffa02bd806c800: disconnect after 23s idle [ 290.102221] Lustre: DEBUG MARKER: Client: 2.17.58.63 [ 292.285978] Lustre: DEBUG MARKER: MDS: 2.17.58.63 [ 295.551573] Lustre: DEBUG MARKER: OSS: 2.17.58.63 [ 297.377673] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Oct 1 17:57:08 EDT 2026 [ 313.012235] Lustre: DEBUG MARKER: only running tests: 33-75 [ 314.475523] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 315.862462] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 317.826654] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 328.144934] Lustre: Unmounted lustre-client [ 445.631188] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 451.132708] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 473.748713] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 522.160885] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 18:00:53 (1790892053) [ 524.740555] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 526.409643] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 18:00:57 (1790892057) [ 560.915625] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 566.469975] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 590.110526] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 590.743712] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 599.919026] Lustre: Unmounted lustre-client [ 636.322771] Key type lgssc unregistered [ 636.623712] LNet: 15197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 636.631574] LNetError: 15197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 636.657106] LNet: Removed LNI 192.168.202.34@tcp [ 637.460225] Key type .llcrypt unregistered [ 637.463159] Key type ._llcrypt unregistered [ 651.895730] Key type ._llcrypt registered [ 651.899309] Key type .llcrypt registered [ 653.203452] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 18:03:04 (1790892184) [ 654.593111] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 654.633103] alg: No test for adler32 (adler32-zlib) [ 655.765696] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 655.917674] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 657.631278] Key type lgssc registered [ 658.754174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 732.513915] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 820.380274] Lustre: Unmounted lustre-client [ 849.851854] Key type lgssc unregistered [ 850.314130] LNet: 19023:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 850.325387] LNetError: 19023:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 850.351632] LNet: Removed LNI 192.168.202.34@tcp [ 850.996140] Key type .llcrypt unregistered [ 850.999427] Key type ._llcrypt unregistered [ 858.907301] Key type ._llcrypt registered [ 858.909836] Key type .llcrypt registered [ 860.395699] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 18:06:31 (1790892391) [ 862.438187] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 862.588605] alg: No test for adler32 (adler32-zlib) [ 863.728800] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 863.964647] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 865.609862] Key type lgssc registered [ 866.673456] Lustre: Echo OBD driver; http://www.lustre.org/ [ 918.575388] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 924.219297] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 945.269493] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 947.034889] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 959.736259] Lustre: Unmounted lustre-client [ 993.267425] Key type lgssc unregistered [ 993.711685] LNet: 22642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 993.722155] LNetError: 22642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 993.763108] LNet: Removed LNI 192.168.202.34@tcp [ 994.654637] Key type .llcrypt unregistered [ 994.659364] Key type ._llcrypt unregistered [ 1007.419014] Key type ._llcrypt registered [ 1007.423661] Key type .llcrypt registered [ 1009.340803] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 18:08:59 (1790892539) [ 1012.783918] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1012.821747] alg: No test for adler32 (adler32-zlib) [ 1014.011361] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 1014.330392] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 1016.128370] Key type lgssc registered [ 1017.734581] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1080.847969] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1090.001805] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1117.385459] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1120.583165] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 1127.534290] Lustre: Unmounted lustre-client [ 1158.641143] Key type lgssc unregistered [ 1159.031028] LNet: 25856:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1159.038684] LNetError: 25856:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1159.060339] LNet: Removed LNI 192.168.202.34@tcp [ 1159.714457] Key type .llcrypt unregistered [ 1159.724449] Key type ._llcrypt unregistered [ 1176.034477] Key type ._llcrypt registered [ 1176.036646] Key type .llcrypt registered [ 1177.424942] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 18:11:48 (1790892708) [ 1180.387981] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1180.607709] alg: No test for adler32 (adler32-zlib) [ 1182.206246] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 1182.754893] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 1184.616865] Key type lgssc registered [ 1186.405685] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1241.368468] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1247.093432] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1272.013341] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1274.932741] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 1279.991212] Lustre: lustre-MDT0000-mdc-ffffa02bc92de800: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1285.102151] Lustre: lustre-MDT0001-mdc-ffffa02bc92de800: Connection to lustre-MDT0001 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1300.447226] Lustre: 26822:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790892817/real 1790892817] req@000000003e960dd4 x1877887119529472/t0(0) o400->MGC192.168.202.134@tcp@192.168.202.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1790892833 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1300.506540] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [ 1300.762040] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1311.156828] Lustre: Unmounted lustre-client [ 1325.470642] Key type lgssc unregistered [ 1325.677605] LNet: 29531:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1325.683497] LNetError: 29531:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1325.699421] LNet: Removed LNI 192.168.202.34@tcp [ 1326.506071] Key type .llcrypt unregistered [ 1326.515383] Key type ._llcrypt unregistered [ 1345.676334] Key type ._llcrypt registered [ 1345.685862] Key type .llcrypt registered [ 1347.945898] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 18:14:38 (1790892878) [ 1350.984691] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1351.059676] alg: No test for adler32 (adler32-zlib) [ 1352.209506] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 1352.537500] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 1354.232798] Key type lgssc registered [ 1355.958816] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1411.979185] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1417.934168] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1441.123439] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1442.758756] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 1447.913395] Lustre: lustre-OST0000-osc-ffffa02bd01c9000: Connection to lustre-OST0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1456.168347] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1466.591236] Lustre: Unmounted lustre-client [ 1504.791954] Key type lgssc unregistered [ 1505.042738] LNet: 33165:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1505.047921] LNetError: 33165:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1505.073861] LNet: Removed LNI 192.168.202.34@tcp [ 1505.696251] Key type .llcrypt unregistered [ 1505.703618] Key type ._llcrypt unregistered [ 1523.126263] Key type ._llcrypt registered [ 1523.128363] Key type .llcrypt registered [ 1524.766529] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 18:17:35 (1790893055) [ 1527.345512] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1527.373692] alg: No test for adler32 (adler32-zlib) [ 1528.685305] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 1529.079197] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 1530.823300] Key type lgssc registered [ 1532.180828] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1585.899749] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1592.141088] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1616.596323] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1619.501107] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 1623.474709] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1627.078563] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1638.829788] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-10-0118h19m29s [ 1640.554484] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1645.027600] Lustre: lustre-MDT0000-mdc-ffffa02bd01cc000: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1651.417840] LustreError: 36973:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffffa02bd01cc000: can't stat MDS #0: rc = -19 [ 1652.730679] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1662.443465] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [ 1662.476779] Lustre: Evicted from MGS (at 192.168.202.134@tcp) after server handle changed from 0xe2e44c334131b272 to 0xe2e44c334131b535 [ 1662.489610] Lustre: MGC192.168.202.134@tcp: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 1663.532300] LustreError: lustre-MDT0000-mdc-ffffa02bd01cc000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1663.573515] Lustre: lustre-MDT0000-mdc-ffffa02bd01cc000: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 1668.568883] Lustre: DEBUG MARKER: Wait for df (36973) ... [ 1669.994469] Lustre: DEBUG MARKER: done [ 1671.775246] Lustre: Unmounted lustre-client [ 1698.559250] Key type lgssc unregistered [ 1699.000881] LNet: 37989:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1699.007869] LNetError: 37989:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1699.025348] LNet: Removed LNI 192.168.202.34@tcp [ 1699.944092] Key type .llcrypt unregistered [ 1699.953311] Key type ._llcrypt unregistered [ 1728.462814] Key type ._llcrypt registered [ 1728.464295] Key type .llcrypt registered [ 1729.544837] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 18:21:00 (1790893260) [ 1732.014381] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1732.028632] alg: No test for adler32 (adler32-zlib) [ 1733.172257] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 1733.421885] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 1735.135226] Key type lgssc registered [ 1736.134405] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1783.917467] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1789.339263] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1809.085653] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1811.946873] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 1816.035201] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-10-0118h22m27s [ 1817.657973] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1826.214563] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1828.483560] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1848.801135] Lustre: 42154:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790893361/real 1790893361] req@00000000d0824ee7 x1877887697296128/t0(0) o101->lustre-MDT0000-mdc-ffffa02bd815f800@192.168.202.134@tcp:12/10 lens 576/1152 e 0 to 1 dl 1790893381 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1848.826246] Lustre: lustre-MDT0000-mdc-ffffa02bd815f800: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1848.858867] Lustre: lustre-MDT0000-mdc-ffffa02bd815f800: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 1870.824394] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1874.143584] Lustre: DEBUG MARKER: done [ 1877.943882] Lustre: Unmounted lustre-client [ 1905.184479] Key type lgssc unregistered [ 1905.436139] LNet: 43035:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1905.448161] LNetError: 43035:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1905.487081] LNet: Removed LNI 192.168.202.34@tcp [ 1906.242985] Key type .llcrypt unregistered [ 1906.245521] Key type ._llcrypt unregistered [ 1937.341339] Key type ._llcrypt registered [ 1937.342984] Key type .llcrypt registered [ 1938.762558] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 18:24:29 (1790893469) [ 1940.301370] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1941.813769] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 18:24:33 (1790893473) [ 1945.372496] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1945.391472] alg: No test for adler32 (adler32-zlib) [ 1946.542676] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 1946.744027] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 1948.423967] Key type lgssc registered [ 1949.515793] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1976.678219] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 18:25:07 (1790893507) [ 2009.297519] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2015.087875] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2036.174643] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2039.030980] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 2042.655932] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2046.810037] Lustre: Unmounted lustre-client [ 2064.258534] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2110.512284] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2115.508836] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2116.144394] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 2121.001045] Lustre: Unmounted lustre-client [ 2184.129743] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2188.789370] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2189.600880] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 2192.278248] Lustre: Unmounted lustre-client [ 2210.288789] Lustre: DEBUG MARKER: files compared the same [ 2232.009499] Key type lgssc unregistered [ 2232.189566] LNet: 50681:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2232.194980] LNetError: 50681:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2233.255308] LNet: Removed LNI 192.168.202.34@tcp [ 2233.782435] Key type .llcrypt unregistered [ 2233.784268] Key type ._llcrypt unregistered [ 2248.316690] Key type ._llcrypt registered [ 2248.318917] Key type .llcrypt registered [ 2249.719128] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 18:29:40 (1790893780) [ 2252.080898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2252.113538] alg: No test for adler32 (adler32-zlib) [ 2253.198587] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 2253.588195] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 2255.255683] Key type lgssc registered [ 2256.406252] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2301.222922] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2306.560331] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2326.420881] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2327.852502] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 2331.500271] Lustre: Unmounted lustre-client [ 2358.280525] Key type lgssc unregistered [ 2358.507692] LNet: 54278:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2358.514825] LNetError: 54278:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2358.536562] LNet: Removed LNI 192.168.202.34@tcp [ 2359.167310] Key type .llcrypt unregistered [ 2359.177453] Key type ._llcrypt unregistered [ 2373.135806] Key type ._llcrypt registered [ 2373.137585] Key type .llcrypt registered [ 2374.152736] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 18:31:45 (1790893905) [ 2376.094968] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2376.218110] alg: No test for adler32 (adler32-zlib) [ 2377.210986] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 2377.416509] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 2379.079229] Key type lgssc registered [ 2380.163902] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2462.274325] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2494.536169] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2499.759343] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2525.915814] Key type lgssc unregistered [ 2526.115599] LNet: 57776:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2526.120097] LNetError: 57776:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2526.138774] LNet: Removed LNI 192.168.202.34@tcp [ 2526.530800] Key type .llcrypt unregistered [ 2526.532275] Key type ._llcrypt unregistered [ 2542.376283] Key type ._llcrypt registered [ 2542.380334] Key type .llcrypt registered [ 2544.040255] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 18:34:34 (1790894074) [ 2547.985820] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2548.023533] alg: No test for adler32 (adler32-zlib) [ 2549.211947] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 2549.442936] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 2551.167907] Key type lgssc registered [ 2552.860966] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2634.361856] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 2641.679024] Lustre: Unmounted lustre-client [ 2678.535689] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 18:36:49 (1790894209) [ 2800.490706] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2821.685526] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 2828.857174] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2828.860387] LustreError: 64258:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffffa02bd0010800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2828.869165] Lustre: 58766:0:(llite_lib.c:4348:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.134@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2839.220957] Lustre: Unmounted lustre-client [ 2892.467640] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 18:40:23 (1790894423) [ 2907.143647] Key type lgssc unregistered [ 2907.382892] LNet: 65471:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2907.389515] LNetError: 65471:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2908.462555] LNet: Removed LNI 192.168.202.34@tcp [ 2909.497994] Key type .llcrypt unregistered [ 2909.500939] Key type ._llcrypt unregistered [ 2923.235105] Key type ._llcrypt registered [ 2923.240511] Key type .llcrypt registered [ 2923.751734] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2923.767679] alg: No test for adler32 (adler32-zlib) [ 2924.817915] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 2925.025495] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 2926.751542] Key type lgssc registered [ 2928.041528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2977.958518] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2984.487112] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3006.024362] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3007.665636] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3011.760738] Lustre: Unmounted lustre-client [ 3038.865529] Key type lgssc unregistered [ 3039.104111] LNet: 68496:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3039.114571] LNetError: 68496:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3039.129969] LNet: Removed LNI 192.168.202.34@tcp [ 3040.135507] Key type .llcrypt unregistered [ 3040.140096] Key type ._llcrypt unregistered [ 3052.137512] Key type ._llcrypt registered [ 3052.146589] Key type .llcrypt registered [ 3052.492350] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3052.520409] alg: No test for adler32 (adler32-zlib) [ 3053.731434] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 3053.943404] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 3055.616560] Key type lgssc registered [ 3057.658538] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3174.486455] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3180.298452] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3201.474330] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3203.255213] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3211.115439] Lustre: Unmounted lustre-client [ 3238.830487] Key type lgssc unregistered [ 3239.222696] LNet: 71942:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3239.235929] LNetError: 71942:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3239.268554] LNet: Removed LNI 192.168.202.34@tcp [ 3240.073901] Key type .llcrypt unregistered [ 3240.075700] Key type ._llcrypt unregistered [ 3256.824410] Key type ._llcrypt registered [ 3256.826915] Key type .llcrypt registered [ 3258.289703] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 18:46:29 (1790894789) [ 3260.945230] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3260.997925] alg: No test for adler32 (adler32-zlib) [ 3262.043637] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 3262.256650] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 3263.903275] Key type lgssc registered [ 3265.231301] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3316.593884] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3322.704905] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3345.124974] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3346.750534] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3352.244673] Lustre: Unmounted lustre-client [ 3352.762802] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3356.335888] Lustre: Unmounted lustre-client [ 3385.395097] Key type lgssc unregistered [ 3385.782277] LNet: 75646:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3385.793951] LNetError: 75646:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3385.828760] LNet: Removed LNI 192.168.202.34@tcp [ 3386.678740] Key type .llcrypt unregistered [ 3386.684426] Key type ._llcrypt unregistered [ 3402.220693] Key type ._llcrypt registered [ 3402.231249] Key type .llcrypt registered [ 3402.710753] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3402.733985] alg: No test for adler32 (adler32-zlib) [ 3403.961922] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 3404.331902] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 3405.999662] Key type lgssc registered [ 3407.545820] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3463.917459] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3471.132761] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3496.091706] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3497.913880] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3502.492333] Lustre: Unmounted lustre-client [ 3533.486422] Key type lgssc unregistered [ 3533.688722] LNet: 78695:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3533.696285] LNetError: 78695:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3533.718526] LNet: Removed LNI 192.168.202.34@tcp [ 3534.957084] Key type .llcrypt unregistered [ 3534.960078] Key type ._llcrypt unregistered [ 3550.787444] Key type ._llcrypt registered [ 3550.791041] Key type .llcrypt registered [ 3552.979626] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 18:51:23 (1790895083) [ 3556.687081] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3556.924987] alg: No test for adler32 (adler32-zlib) [ 3558.472435] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 3559.119298] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 3561.135421] Key type lgssc registered [ 3562.826247] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3626.214179] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3632.893382] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3658.957838] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3666.021630] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3678.820890] Lustre: lustre: root_squash is set to 0:0 [ 3678.857313] Lustre: lustre: nosquash_nids is cleared [ 3684.027277] Lustre: lustre: root_squash is set to 500:500 [ 3701.862885] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.34@tcp 192.168.0.[2,10]@tcp [ 3712.122435] Lustre: lustre: nosquash_nids set to 192.168.202.34/24@tcp [ 3720.363396] Lustre: Unmounted lustre-client [ 3750.643721] Key type lgssc unregistered [ 3750.860575] LNet: 82699:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3750.865319] LNetError: 82699:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3750.876308] LNet: Removed LNI 192.168.202.34@tcp [ 3751.398881] Key type .llcrypt unregistered [ 3751.401659] Key type ._llcrypt unregistered [ 3772.517280] Key type ._llcrypt registered [ 3772.519322] Key type .llcrypt registered [ 3773.866843] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 18:55:04 (1790895304) [ 3776.933878] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3778.400860] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 18:55:09 (1790895309) [ 3781.693334] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3781.825326] alg: No test for adler32 (adler32-zlib) [ 3783.163827] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 3783.504387] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 3785.263215] Key type lgssc registered [ 3787.323135] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3837.153614] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3843.265684] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3866.161732] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3866.850289] Lustre: lustre: root_squash is set to 500:500 [ 3866.900835] Lustre: lustre: nosquash_nids set to 192.168.202.34/24@tcp [ 3868.008470] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 3877.824931] Lustre: Unmounted lustre-client [ 3907.229977] Key type lgssc unregistered [ 3907.591757] LNet: 86675:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3907.597812] LNetError: 86675:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3907.622565] LNet: Removed LNI 192.168.202.34@tcp [ 3908.759742] Key type .llcrypt unregistered [ 3908.763206] Key type ._llcrypt unregistered [ 3926.972317] Key type ._llcrypt registered [ 3926.973877] Key type .llcrypt registered [ 3928.873181] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3930.647594] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 18:57:41 (1790895461) [ 3950.255562] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3950.271341] alg: No test for adler32 (adler32-zlib) [ 3951.388359] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 3951.747099] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 3953.487244] Key type lgssc registered [ 3954.663467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4042.137519] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4049.225851] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4074.907699] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4152.392720] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4159.444827] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4184.139795] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4200.409660] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 4234.496317] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffffa02bd01ca800.ost_server_uuid 50 [ 4235.568261] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffffa02bd01ca800.ost_server_uuid in IDLE state after 0 sec [ 4236.035218] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 4239.139978] Lustre: Unmounted lustre-client [ 4240.341040] Lustre: Unmounted lustre-client [ 4287.817648] Key type lgssc unregistered [ 4288.046639] LNet: 94369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4288.055923] LNetError: 94369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4288.065385] LNet: Removed LNI 192.168.202.34@tcp [ 4288.824747] Key type .llcrypt unregistered [ 4288.827110] Key type ._llcrypt unregistered [ 4330.101527] Key type ._llcrypt registered [ 4330.104812] Key type .llcrypt registered [ 4332.045620] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 19:04:22 (1790895862) [ 4350.499124] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4350.545115] alg: No test for adler32 (adler32-zlib) [ 4351.620772] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 4351.876895] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 4353.567298] Key type lgssc registered [ 4355.227537] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4447.566732] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4454.236473] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4480.746309] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4482.532182] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 4504.032243] Lustre: 95739:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790896020/real 1790896020] req@0000000032f0823c x1877890442466432/t0(0) o400->lustre-OST0000-osc-ffffa02bd01c8800@192.168.202.134@tcp:28/4 lens 224/224 e 0 to 1 dl 1790896036 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4504.077368] Lustre: lustre-OST0000-osc-ffffa02bd01c8800: Connection to lustre-OST0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4508.961791] Lustre: 95739:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790896025/real 1790896025] req@000000005d6fd9e5 x1877890442466944/t0(0) o400->lustre-OST0000-osc-ffffa02bd01c8800@192.168.202.134@tcp:28/4 lens 224/224 e 0 to 1 dl 1790896041 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4514.273267] Lustre: 95740:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790896030/real 1790896030] req@00000000c274d2cf x1877890442467456/t0(0) o400->lustre-OST0000-osc-ffffa02bd01c8800@192.168.202.134@tcp:28/4 lens 224/224 e 0 to 1 dl 1790896046 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4515.128090] Lustre: lustre-OST0000-osc-ffffa02bd01c8800: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 4519.398747] Lustre: 95740:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790896035/real 1790896035] req@00000000acd5f0f5 x1877890442467968/t0(0) o400->lustre-OST0000-osc-ffffa02bd01c8800@192.168.202.134@tcp:28/4 lens 224/224 e 0 to 1 dl 1790896051 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4519.409113] Lustre: lustre-MDT0000-mdc-ffffa02bd01c8800: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4535.775251] Lustre: 95739:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790896052/real 1790896052] req@00000000fa469667 x1877890442470272/t0(0) o400->MGC192.168.202.134@tcp@192.168.202.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1790896068 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4535.799109] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [ 4546.039709] Lustre: Evicted from MGS (at 192.168.202.134@tcp) after server handle changed from 0xd1934fa4b0d4136d to 0xd1934fa4b0d415ff [ 4546.053091] Lustre: MGC192.168.202.134@tcp: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 4550.391577] Lustre: lustre-MDT0000-mdc-ffffa02bd01c8800: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 4557.474627] Lustre: Unmounted lustre-client [ 4593.089547] Key type lgssc unregistered [ 4593.418864] LNet: 100055:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4593.427248] LNetError: 100055:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4593.454734] LNet: Removed LNI 192.168.202.34@tcp [ 4594.513948] Key type .llcrypt unregistered [ 4594.516439] Key type ._llcrypt unregistered [ 4614.196212] Key type ._llcrypt registered [ 4614.201413] Key type .llcrypt registered [ 4616.189609] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 19:09:06 (1790896146) [ 4631.883844] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4631.906669] alg: No test for adler32 (adler32-zlib) [ 4633.116460] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 4633.439330] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 4635.287341] Key type lgssc registered [ 4637.237575] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4681.884742] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4791.869323] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4800.006738] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4831.279874] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4833.821297] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 4836.004085] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4837.381678] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 19:12:48 (1790896368) [ 5058.698359] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5069.028201] Lustre: Unmounted lustre-client [ 5199.978161] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5205.687098] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5229.041477] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5270.775772] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:20:02 (1790896802) [ 5371.348384] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5377.852174] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5402.397700] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5403.093522] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 5408.267663] Lustre: Unmounted lustre-client [ 5440.090452] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:22:51 (1790896971) [ 5530.942667] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5535.885611] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5562.169196] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5562.822233] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 5567.445215] Lustre: Unmounted lustre-client [ 5597.576351] Key type lgssc unregistered [ 5597.897248] LNet: 123088:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5597.901271] LNetError: 123088:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5598.950338] LNet: Removed LNI 192.168.202.34@tcp [ 5599.911179] Key type .llcrypt unregistered [ 5599.912924] Key type ._llcrypt unregistered [ 5616.035493] Key type ._llcrypt registered [ 5616.040561] Key type .llcrypt registered [ 5617.725695] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 19:25:48 (1790897148) [ 5619.531099] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5619.619280] alg: No test for adler32 (adler32-zlib) [ 5620.828812] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 5620.970602] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 5622.663543] Key type lgssc registered [ 5623.780722] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5679.402784] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5684.142887] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5702.567984] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5704.296320] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 5725.504833] Lustre: Unmounted lustre-client [ 5752.294195] Key type lgssc unregistered [ 5752.466251] LNet: 126692:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5752.475939] LNetError: 126692:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5752.487647] LNet: Removed LNI 192.168.202.34@tcp [ 5753.032694] Key type .llcrypt unregistered [ 5753.035115] Key type ._llcrypt unregistered [ 5769.202553] Key type ._llcrypt registered [ 5769.209458] Key type .llcrypt registered [ 5770.419283] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 19:28:21 (1790897301) [ 5773.176660] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5773.192115] alg: No test for adler32 (adler32-zlib) [ 5774.416872] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 5774.695858] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 5776.399261] Key type lgssc registered [ 5777.544864] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5827.082370] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5832.567966] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5854.397862] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5856.260875] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 5866.473557] Lustre: lustre-OST0000-osc-ffffa02bc38c3800: Connection to lustre-OST0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5877.022907] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffffa02bc38c3800.ost_server_uuid 50 [ 5878.325546] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5889.893302] Lustre: Unmounted lustre-client [ 5912.283796] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 19:30:43 (1790897443) [ 5947.926225] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5953.261699] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5977.073092] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6002.336660] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6002.975934] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 6008.292137] Lustre: lustre-OST0000-osc-ffffa02bc6478000: Connection to lustre-OST0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6033.502783] Lustre: Unmounted lustre-client [ 6081.364244] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 19:33:32 (1790897612) [ 6122.405675] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6129.245682] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6154.071067] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6179.043408] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6179.714307] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 6184.957768] Lustre: lustre-OST0000-osc-ffffa02bd1135000: Connection to lustre-OST0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6201.736818] Lustre: Unmounted lustre-client [ 6260.434305] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 19:36:31 (1790897791) [ 6360.127571] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6365.501303] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6394.517574] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6474.954289] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6480.725492] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6506.146758] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6539.775550] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 6585.221600] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6586.863914] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6589.056693] Lustre: Unmounted lustre-client [ 6619.847527] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 19:42:31 (1790898151) [ 6656.628563] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6661.897251] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6683.955609] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6721.778670] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6752.524414] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 6796.186628] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6798.119278] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6811.164923] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6821.481612] Lustre: Unmounted lustre-client [ 6875.679158] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 19:46:46 (1790898406) [ 6910.068734] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6915.738956] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6936.795608] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6937.251153] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 6957.333889] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6958.827844] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6974.901562] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffffa02bd2fa4000.ost_server_uuid 50 [ 6976.549361] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffffa02bd2fa4000.ost_server_uuid in IDLE state after 0 sec [ 6979.509980] Lustre: Unmounted lustre-client [ 6979.801235] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6979.808619] Lustre: Skipped 3 previous similar messages [ 6979.891605] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 6981.065186] LustreError: 150125:0:(sec.c:409:import_sec_validate_get()) import 00000000afcf26ff (NEW) with no sec [ 7037.892764] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 19:49:29 (1790898569) [ 7069.741098] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7075.911450] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7097.701684] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7122.889447] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7123.622889] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7123.752530] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 7139.624811] Lustre: Unmounted lustre-client [ 7139.629342] Lustre: Skipped 1 previous similar message [ 7185.004785] Key type lgssc unregistered [ 7185.266658] LNet: 153537:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7185.272184] LNetError: 153537:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7185.285276] LNet: Removed LNI 192.168.202.34@tcp [ 7185.999435] Key type .llcrypt unregistered [ 7186.001194] Key type ._llcrypt unregistered [ 7204.927615] Key type ._llcrypt registered [ 7204.929505] Key type .llcrypt registered [ 7206.267687] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 19:52:17 (1790898737) [ 7207.655989] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7207.714022] alg: No test for adler32 (adler32-zlib) [ 7208.900221] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 7209.121530] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 7210.768158] Key type lgssc registered [ 7212.101255] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7267.766127] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7273.575965] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7296.868508] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7317.904540] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7318.492172] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7319.606179] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 7328.266585] LustreError: lustre-MDT0001-mdc-ffffa02bc4d38800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7328.294317] Lustre: lustre-MDT0001-mdc-ffffa02bc4d38800: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 7335.524977] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7337.728451] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7360.003551] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7364.528560] Lustre: Unmounted lustre-client [ 7386.517094] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 19:55:17 (1790898917) [ 7487.510822] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7493.257831] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7516.490703] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7517.071477] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 7541.343311] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7543.478853] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7545.834634] Lustre: lustre-OST0001-osc-ffffa02bd1135800: Connection to lustre-OST0001 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7557.011327] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7567.373307] Lustre: Unmounted lustre-client [ 7602.164307] Key type lgssc unregistered [ 7602.508756] LNet: 163169:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7602.519628] LNetError: 163169:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7602.540376] LNet: Removed LNI 192.168.202.34@tcp [ 7603.264208] Key type .llcrypt unregistered [ 7603.265975] Key type ._llcrypt unregistered [ 7639.529125] Key type ._llcrypt registered [ 7639.530438] Key type .llcrypt registered [ 7640.959807] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 19:59:31 (1790899171) [ 7643.044322] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7643.100811] alg: No test for adler32 (adler32-zlib) [ 7644.395091] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 7644.698578] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 7646.359599] Key type lgssc registered [ 7647.753961] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7702.909251] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7709.076332] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7736.564968] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7738.053224] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 7783.173806] Lustre: Unmounted lustre-client [ 7826.994344] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7827.911662] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 7864.495149] Lustre: Unmounted lustre-client [ 7895.088351] Key type lgssc unregistered [ 7895.451770] LNet: 167642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7895.460712] LNetError: 167642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7895.499186] LNet: Removed LNI 192.168.202.34@tcp [ 7896.362320] Key type .llcrypt unregistered [ 7896.369058] Key type ._llcrypt unregistered [ 7914.202453] Key type ._llcrypt registered [ 7914.203870] Key type .llcrypt registered [ 7915.651794] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 20:04:06 (1790899446) [ 7918.279835] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7918.338065] alg: No test for adler32 (adler32-zlib) [ 7919.504826] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 7919.843584] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 7921.616127] Key type lgssc registered [ 7923.118180] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7977.126719] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7982.803634] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8005.159826] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8008.022183] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 8024.825192] Lustre: Unmounted lustre-client [ 8054.307828] Key type lgssc unregistered [ 8054.551146] LNet: 171417:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8054.564413] LNetError: 171417:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8054.579359] LNet: Removed LNI 192.168.202.34@tcp [ 8055.298351] Key type .llcrypt unregistered [ 8055.301036] Key type ._llcrypt unregistered [ 8068.643897] Key type ._llcrypt registered [ 8068.646587] Key type .llcrypt registered [ 8069.121613] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8069.141403] alg: No test for adler32 (adler32-zlib) [ 8070.503617] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 8070.872222] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 8072.631510] Key type lgssc registered [ 8074.264357] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8130.620927] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8135.843462] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8157.188650] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8158.766876] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 8166.129260] Lustre: Unmounted lustre-client [ 8193.784920] Key type lgssc unregistered [ 8194.097617] LNet: 174511:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8194.112949] LNetError: 174511:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8194.148143] LNet: Removed LNI 192.168.202.34@tcp [ 8194.821474] Key type .llcrypt unregistered [ 8194.822809] Key type ._llcrypt unregistered [ 8210.240241] Key type ._llcrypt registered [ 8210.243597] Key type .llcrypt registered [ 8211.851824] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 20:09:02 (1790899742) [ 8214.472661] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8214.537303] alg: No test for adler32 (adler32-zlib) [ 8215.729346] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 8216.018988] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 8217.743246] Key type lgssc registered [ 8219.356649] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8271.508843] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8277.622914] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8296.833698] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8298.517255] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 8322.777764] Lustre: Unmounted lustre-client [ 8354.608706] Key type lgssc unregistered [ 8354.864757] LNet: 178279:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8354.879836] LNetError: 178279:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8354.902758] LNet: Removed LNI 192.168.202.34@tcp [ 8355.756373] Key type .llcrypt unregistered [ 8355.757636] Key type ._llcrypt unregistered [ 8368.903759] Key type ._llcrypt registered [ 8368.908379] Key type .llcrypt registered [ 8369.493745] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8369.511834] alg: No test for adler32 (adler32-zlib) [ 8370.682092] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 8370.970886] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 8372.695625] Key type lgssc registered [ 8373.968589] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8429.078848] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8434.846929] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8455.046476] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8456.598500] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 8466.990561] Lustre: Unmounted lustre-client [ 8495.107347] Key type lgssc unregistered [ 8495.449412] LNet: 181356:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8495.468144] LNetError: 181356:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8495.521579] LNet: Removed LNI 192.168.202.34@tcp [ 8496.433721] Key type .llcrypt unregistered [ 8496.436500] Key type ._llcrypt unregistered [ 8516.199907] Key type ._llcrypt registered [ 8516.201277] Key type .llcrypt registered [ 8518.424728] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 20:14:08 (1790900048) [ 8540.853557] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8540.873192] alg: No test for adler32 (adler32-zlib) [ 8541.906326] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 8542.185425] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 8543.895377] Key type lgssc registered [ 8545.410356] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8632.204711] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8638.307781] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8665.318595] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8710.965616] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 20:17:22 (1790900242) [ 8744.689531] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8751.074865] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8772.678808] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8774.546424] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 8783.652287] Lustre: Unmounted lustre-client [ 8813.604624] Key type lgssc unregistered [ 8813.867731] LNet: 188466:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8813.874929] LNetError: 188466:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8813.887705] LNet: Removed LNI 192.168.202.34@tcp [ 8814.435433] Key type .llcrypt unregistered [ 8814.437619] Key type ._llcrypt unregistered [ 8828.166960] Key type ._llcrypt registered [ 8828.168923] Key type .llcrypt registered [ 8829.077866] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8830.627909] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 20:19:21 (1790900361) [ 8850.529357] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8850.575906] alg: No test for adler32 (adler32-zlib) [ 8851.633558] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 8851.849829] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 8853.503257] Key type lgssc registered [ 8854.636725] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8946.922288] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8953.996769] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8982.345186] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9003.048951] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9005.812108] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 9033.460741] Lustre: Unmounted lustre-client [ 9161.815555] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9166.887139] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9191.696379] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9232.066309] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 20:26:03 (1790900763) [ 9233.906991] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9235.804443] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 20:26:06 (1790900766) [ 9328.238901] Key type lgssc unregistered [ 9328.575762] LNet: 199916:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9328.585607] LNetError: 199916:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9328.618791] LNet: Removed LNI 192.168.202.34@tcp [ 9329.438773] Key type .llcrypt unregistered [ 9329.440567] Key type ._llcrypt unregistered [ 9347.242971] Key type ._llcrypt registered [ 9347.244951] Key type .llcrypt registered [ 9348.644759] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 20:27:59 (1790900879) [ 9391.521958] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9391.689942] alg: No test for adler32 (adler32-zlib) [ 9392.897952] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 9393.192051] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 9394.967804] Key type lgssc registered [ 9396.377259] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9442.542408] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9449.211361] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9485.827713] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9523.256922] Key type lgssc unregistered [ 9523.605199] LNet: 203681:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9523.609815] LNetError: 203681:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9523.625150] LNet: Removed LNI 192.168.202.34@tcp [ 9524.491794] Key type .llcrypt unregistered [ 9524.495205] Key type ._llcrypt unregistered [ 9542.264398] Key type ._llcrypt registered [ 9542.268462] Key type .llcrypt registered [ 9543.725151] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 20:31:14 (1790901074) [ 9546.700242] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9546.724203] alg: No test for adler32 (adler32-zlib) [ 9547.843798] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 9548.074957] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 9549.767818] Key type lgssc registered [ 9550.838736] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9606.364715] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9613.535977] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9638.495307] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9644.631956] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [ 9654.767851] Lustre: lustre-MDT0000-mdc-ffffa02bd1104000: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9665.002800] Lustre: lustre-MDT0001-mdc-ffffa02bd1104000: Connection to lustre-MDT0001 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9676.255344] Lustre: 204677:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790901192/real 1790901192] req@00000000d45b2c68 x1877895890944256/t0(0) o400->MGC192.168.202.134@tcp@192.168.202.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1790901208 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9676.323129] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [ 9685.607599] Lustre: Evicted from MGS (at 192.168.202.134@tcp) after server handle changed from 0x3cd9d53c5629bcbc to 0x3cd9d53c5629d7dc [ 9685.642371] Lustre: MGC192.168.202.134@tcp: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 9709.557296] LustreError: lustre-MDT0000-mdc-ffffa02bd1104000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9709.649812] Lustre: lustre-MDT0000-mdc-ffffa02bd1104000: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [ 9717.167379] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9719.423437] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9725.909436] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9727.803521] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9730.432279] Lustre: Unmounted lustre-client [ 9766.329954] Key type lgssc unregistered [ 9766.614401] LNet: 208641:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9766.644443] LNetError: 208641:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9766.673087] LNet: Removed LNI 192.168.202.34@tcp [ 9767.422361] Key type .llcrypt unregistered [ 9767.424829] Key type ._llcrypt unregistered [ 9783.611921] Key type ._llcrypt registered [ 9783.627595] Key type .llcrypt registered [ 9784.995251] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 20:35:16 (1790901316) [ 9788.835255] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9788.902511] alg: No test for adler32 (adler32-zlib) [ 9790.339467] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [ 9790.749739] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [ 9792.535418] Key type lgssc registered [ 9794.506801] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9846.870924] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9854.920550] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9918.528590] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9926.872315] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9974.011623] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9997.157078] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10038.174366] Key type lgssc unregistered [10038.496292] LNet: 213956:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10038.525455] LNetError: 213956:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10038.547243] LNet: Removed LNI 192.168.202.34@tcp [10039.714852] Key type .llcrypt unregistered [10039.719588] Key type ._llcrypt unregistered [10091.433542] Key type ._llcrypt registered [10091.437400] Key type .llcrypt registered [10092.620928] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 20:40:23 (1790901623) [10136.892770] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10137.005070] alg: No test for adler32 (adler32-zlib) [10138.089516] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [10138.282640] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [10140.055358] Key type lgssc registered [10141.503297] Lustre: Echo OBD driver; http://www.lustre.org/ [10238.387641] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10244.438914] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10268.464266] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10317.584212] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 20:44:08 (1790901848) [10328.339813] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 20:44:19 (1790901859) [10376.320249] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10383.738575] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10413.535891] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10416.372349] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [10422.115698] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10424.312342] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10425.844520] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10427.630944] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10431.989869] Lustre: lustre-MDT0000-mdc-ffffa02bd2fa4000: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [10448.351159] Lustre: 215858:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790901964/real 1790901964] req@000000003ced5c54 x1877896509531776/t0(0) o400->MGC192.168.202.134@tcp@192.168.202.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1790901980 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10448.398525] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [10458.616860] Lustre: Evicted from MGS (at 192.168.202.134@tcp) after server handle changed from 0x922f2aaf6aeb58cb to 0x922f2aaf6aeb5abc [10458.627823] Lustre: MGC192.168.202.134@tcp: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [10464.001514] Lustre: lustre-MDT0000-mdc-ffffa02bd2fa4000: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [10475.546373] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10477.640897] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10482.580520] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10489.336216] Lustre: lustre-MDT0000-mdc-ffffa02bd2fa4000: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [10504.672948] Lustre: 215861:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790902021/real 1790902021] req@0000000048a5d2bc x1877896509541248/t0(0) o400->MGC192.168.202.134@tcp@192.168.202.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1790902037 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10504.726681] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [10514.943200] Lustre: Evicted from MGS (at 192.168.202.134@tcp) after server handle changed from 0x922f2aaf6aeb5abc to 0x922f2aaf6aeb5d4e [10514.967904] Lustre: MGC192.168.202.134@tcp: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [10521.865697] Lustre: lustre-MDT0000-mdc-ffffa02bd2fa4000: Connection restored to 192.168.202.134@tcp (at 192.168.202.134@tcp) [10532.726258] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10534.649225] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10539.059814] Lustre: Unmounted lustre-client [10610.045261] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10617.068114] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10642.126935] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10653.287403] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [10656.250757] Lustre: Unmounted lustre-client [10685.141433] Key type lgssc unregistered [10685.458922] LNet: 226462:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10685.465904] LNetError: 226462:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10685.485781] LNet: Removed LNI 192.168.202.34@tcp [10686.260726] Key type .llcrypt unregistered [10686.266579] Key type ._llcrypt unregistered [10707.533532] Key type ._llcrypt registered [10707.535413] Key type .llcrypt registered [10709.790476] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 20:50:39 (1790902239) [10715.995341] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10716.007925] alg: No test for adler32 (adler32-zlib) [10717.309597] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [10717.646618] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [10719.400940] Key type lgssc registered [10722.184990] Lustre: Echo OBD driver; http://www.lustre.org/ [10778.857749] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10786.429069] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10810.966848] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10814.361942] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [10822.384919] Lustre: Unmounted lustre-client [10897.520644] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10903.241495] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10929.376105] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10940.504282] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [10950.364417] Lustre: Unmounted lustre-client [11016.332702] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11022.634350] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11044.670205] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11045.572389] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [11047.533231] Lustre: Unmounted lustre-client [11072.110578] Key type lgssc unregistered [11072.474195] LNet: 233542:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11072.497411] LNetError: 233542:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11072.537236] LNet: Removed LNI 192.168.202.34@tcp [11073.477280] Key type .llcrypt unregistered [11073.480210] Key type ._llcrypt unregistered [11093.548910] Key type ._llcrypt registered [11093.552170] Key type .llcrypt registered [11095.112882] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 20:57:06 (1790902626) [11099.080055] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11099.102131] alg: No test for adler32 (adler32-zlib) [11100.247406] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [11100.514347] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [11102.263262] Key type lgssc registered [11103.386922] Lustre: Echo OBD driver; http://www.lustre.org/ [11157.565548] Key type lgssc unregistered [11157.841819] LNet: 235879:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11157.856253] LNetError: 235879:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11157.881201] LNet: Removed LNI 192.168.202.34@tcp [11158.705238] Key type .llcrypt unregistered [11158.708269] Key type ._llcrypt unregistered [11191.919819] Key type ._llcrypt registered [11191.924434] Key type .llcrypt registered [11192.503057] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11192.529035] alg: No test for adler32 (adler32-zlib) [11193.864628] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [11194.120313] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [11195.871730] Key type lgssc registered [11197.235606] Lustre: Echo OBD driver; http://www.lustre.org/ [11280.159717] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11285.397415] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11309.654676] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11350.796877] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11352.829307] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 21:01:23 (1790902883) [11388.851813] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11394.704285] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11417.276752] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11440.407644] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11441.838644] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [11447.271986] Lustre: lustre-OST0001-osc-ffffa02bc4055000: Connection to lustre-OST0001 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [11453.685057] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11464.149874] Lustre: Unmounted lustre-client [11517.294879] Key type lgssc unregistered [11517.682996] LNet: 243027:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11517.691651] LNetError: 243027:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11518.757893] LNet: Removed LNI 192.168.202.34@tcp [11519.552285] Key type .llcrypt unregistered [11519.553439] Key type ._llcrypt unregistered [11552.996294] Key type ._llcrypt registered [11552.999751] Key type .llcrypt registered [11554.435242] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 21:04:45 (1790903085) [11568.256427] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11568.339984] alg: No test for adler32 (adler32-zlib) [11569.521847] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [11569.753829] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [11571.463814] Key type lgssc registered [11572.707320] Lustre: Echo OBD driver; http://www.lustre.org/ [11622.017227] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11627.638800] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11648.863889] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 21:06:20 (1790903180) [11682.221183] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11688.317979] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11707.076947] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11708.901670] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [11715.855965] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11727.562127] Lustre: Unmounted lustre-client [11820.691738] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11826.147156] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11880.376119] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11880.964552] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [11883.226185] Lustre: Unmounted lustre-client [11912.291840] Key type lgssc unregistered [11912.578563] LNet: 250750:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11912.586788] LNetError: 250750:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11912.608452] LNet: Removed LNI 192.168.202.34@tcp [11913.344243] Key type .llcrypt unregistered [11913.345947] Key type ._llcrypt unregistered [11942.868685] Key type ._llcrypt registered [11942.874103] Key type .llcrypt registered [11943.612729] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11943.642713] alg: No test for adler32 (adler32-zlib) [11944.880300] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [11945.178565] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [11946.855983] Key type lgssc registered [11948.213957] Lustre: Echo OBD driver; http://www.lustre.org/ [12024.735122] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12029.482291] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12051.479559] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12091.524917] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12092.986461] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 21:13:44 (1790903624) [12127.312941] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12133.407820] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12155.920940] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12160.643317] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [12163.210205] Lustre: Unmounted lustre-client [12190.246284] Key type lgssc unregistered [12190.611712] LNet: 257398:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12190.619771] LNetError: 257398:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12190.645606] LNet: Removed LNI 192.168.202.34@tcp [12191.363955] Key type .llcrypt unregistered [12191.366894] Key type ._llcrypt unregistered [12210.284904] Key type ._llcrypt registered [12210.288031] Key type .llcrypt registered [12211.883096] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12213.608719] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 21:15:44 (1790903744) [12223.868758] Key type .llcrypt unregistered [12223.870452] Key type ._llcrypt unregistered [12234.142853] Key type ._llcrypt registered [12234.149457] Key type .llcrypt registered [12234.687392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12234.715222] alg: No test for adler32 (adler32-zlib) [12235.897923] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [12236.262872] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [12237.991992] Key type lgssc registered [12239.940713] Lustre: Echo OBD driver; http://www.lustre.org/ [12298.963195] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12317.132555] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [12320.027381] Lustre: Unmounted lustre-client [12348.505377] Key type lgssc unregistered [12348.847908] LNet: 260868:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12348.863789] LNetError: 260868:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12348.892886] LNet: Removed LNI 192.168.202.34@tcp [12349.984260] Key type .llcrypt unregistered [12349.987423] Key type ._llcrypt unregistered [12366.712670] Key type ._llcrypt registered [12366.714917] Key type .llcrypt registered [12367.956587] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 21:18:19 (1790903899) [12370.443421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12370.611810] alg: No test for adler32 (adler32-zlib) [12371.652428] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [12371.907732] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [12373.591798] Key type lgssc registered [12375.178593] Lustre: Echo OBD driver; http://www.lustre.org/ [12464.430966] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12501.826865] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12507.717083] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12510.426088] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [12512.902354] Lustre: Unmounted lustre-client [12540.634403] Key type lgssc unregistered [12540.870272] LNet: 264426:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12540.875580] LNetError: 264426:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12540.896568] LNet: Removed LNI 192.168.202.34@tcp [12541.682116] Key type .llcrypt unregistered [12541.684447] Key type ._llcrypt unregistered [12559.286139] Key type ._llcrypt registered [12559.289028] Key type .llcrypt registered [12560.866768] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 21:21:31 (1790904091) [12563.267988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12563.391079] alg: No test for adler32 (adler32-zlib) [12564.493131] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [12564.701443] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [12566.391724] Key type lgssc registered [12567.388029] Lustre: Echo OBD driver; http://www.lustre.org/ [12612.462695] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12617.453980] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12642.931390] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12644.893151] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [12649.960405] Lustre: lustre-MDT0000-mdc-ffffa02bcacba800: Connection to lustre-MDT0000 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [12653.429190] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12653.453674] LustreError: 267596:0:(file.c:6187:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12653.876973] LustreError: MGC192.168.202.134@tcp: Connection to MGS (at 192.168.202.134@tcp) was lost; in progress operations using this service will fail [12653.947378] Lustre: Unmounted lustre-client [12673.453310] Key type lgssc unregistered [12673.678903] LNet: 268009:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12673.686200] LNetError: 268009:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12673.701579] LNet: Removed LNI 192.168.202.34@tcp [12674.575405] Key type .llcrypt unregistered [12674.578144] Key type ._llcrypt unregistered [12692.754969] Key type ._llcrypt registered [12692.758304] Key type .llcrypt registered [12694.156842] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 21:23:45 (1790904225) [12696.237104] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12696.446263] alg: No test for adler32 (adler32-zlib) [12697.503621] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [12697.756449] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [12699.447318] Key type lgssc registered [12700.761837] Lustre: Echo OBD driver; http://www.lustre.org/ [12755.465750] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12761.932519] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12788.496702] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12791.172036] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [12796.411283] Lustre: lustre-MDT0001-mdc-ffffa02bd0013000: Connection to lustre-MDT0001 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [12801.846908] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12804.302796] Lustre: Unmounted lustre-client [12826.556679] Key type lgssc unregistered [12826.865778] LNet: 271602:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12826.873282] LNetError: 271602:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12826.896286] LNet: Removed LNI 192.168.202.34@tcp [12827.557857] Key type .llcrypt unregistered [12827.563299] Key type ._llcrypt unregistered [12847.139549] Key type ._llcrypt registered [12847.143630] Key type .llcrypt registered [12848.571530] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 21:26:19 (1790904379) [12867.439803] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12867.457344] alg: No test for adler32 (adler32-zlib) [12868.495746] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [12868.798414] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [12870.487208] Key type lgssc registered [12872.311814] Lustre: Echo OBD driver; http://www.lustre.org/ [12994.960970] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12997.000647] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [13043.180304] Lustre: lustre-MDT0001-mdc-ffffa02bcacbc000: Connection to lustre-MDT0001 (at 192.168.202.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [13052.174307] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13062.525611] Lustre: Unmounted lustre-client [13098.191838] Key type lgssc unregistered [13098.472683] LNet: 277406:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13098.481451] LNetError: 277406:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13098.522455] LNet: Removed LNI 192.168.202.34@tcp [13099.460851] Key type .llcrypt unregistered [13099.464692] Key type ._llcrypt unregistered [13120.356342] Key type ._llcrypt registered [13120.359198] Key type .llcrypt registered [13121.791831] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 21:30:52 (1790904652) [13123.346552] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13125.145903] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 21:30:56 (1790904656) [13127.003283] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13129.289781] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 21:31:00 (1790904660) [13131.756434] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13133.538614] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 21:31:04 (1790904664) [13135.939661] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13138.530299] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 21:31:09 (1790904669) [13140.121264] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13141.589310] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 21:31:12 (1790904672) [13149.711436] Key type .llcrypt unregistered [13149.716128] Key type ._llcrypt unregistered [13158.188495] Key type ._llcrypt registered [13158.191973] Key type .llcrypt registered [13158.661314] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13158.669791] alg: No test for adler32 (adler32-zlib) [13159.820935] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [13160.080416] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [13161.784842] Key type lgssc registered [13163.124461] Lustre: Echo OBD driver; http://www.lustre.org/ [13237.990742] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13244.244487] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13268.099573] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13269.899842] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [13272.887098] Lustre: Unmounted lustre-client [13311.365080] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 21:34:02 (1790904842) [13347.533458] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13354.231514] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13392.433571] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13393.244812] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [13396.576855] Lustre: Unmounted lustre-client [13449.889378] LNet: 1 local NIs in recovery (showing 1): 192.168.202.34@tcp [13451.318276] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 21:36:22 (1790904982) [14117.236668] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14123.741892] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14163.075271] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14288.600557] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 21:50:19 (1790905819) [14300.835944] Key type lgssc unregistered [14301.093375] LNet: 290951:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14301.103332] LNetError: 290951:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14301.121868] LNet: Removed LNI 192.168.202.34@tcp [14301.880570] Key type .llcrypt unregistered [14301.883368] Key type ._llcrypt unregistered [14408.012680] Key type ._llcrypt registered [14408.015303] Key type .llcrypt registered [14408.284221] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14408.299136] alg: No test for adler32 (adler32-zlib) [14409.460814] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [14409.881198] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [14411.607293] Key type lgssc registered [14413.233189] Lustre: Echo OBD driver; http://www.lustre.org/ [14510.092266] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14515.467887] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14537.752914] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14581.480728] Key type lgssc unregistered [14581.806435] LNet: 294661:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14581.809886] LNetError: 294661:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14581.824968] LNet: Removed LNI 192.168.202.34@tcp [14582.376636] Key type .llcrypt unregistered [14582.378617] Key type ._llcrypt unregistered [14623.512528] Key type ._llcrypt registered [14623.514163] Key type .llcrypt registered [14625.122737] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 21:55:55 (1790906155) [14645.744315] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14645.805729] alg: No test for adler32 (adler32-zlib) [14646.931234] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [14647.151424] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [14648.817843] Key type lgssc registered [14649.992055] Lustre: Echo OBD driver; http://www.lustre.org/ [14698.526799] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 21:57:09 (1790906229) [14710.080111] Key type lgssc unregistered [14710.389506] LNet: 298234:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14710.399259] LNetError: 298234:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14710.423618] LNet: Removed LNI 192.168.202.34@tcp [14711.121264] Key type .llcrypt unregistered [14711.123610] Key type ._llcrypt unregistered [14723.084974] Key type ._llcrypt registered [14723.137697] Key type .llcrypt registered [14723.495583] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14723.515291] alg: No test for adler32 (adler32-zlib) [14724.586992] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [14724.909269] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [14726.631436] Key type lgssc registered [14727.996522] Lustre: Echo OBD driver; http://www.lustre.org/ [14783.262746] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14788.377282] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14811.564223] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15112.211330] LNet: Added LNI 192.168.202.34@tcp50 [8/256/0/180] [15114.515236] LNet: Removed LNI 192.168.202.34@tcp [15116.691639] Lustre: 302664:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffffa02bc8b18000: config has no valid NIDs, force dynamic NIDs [15117.971831] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [15118.204433] Lustre: Unmounted lustre-client [15121.113514] Key type lgssc unregistered [15121.593826] LNet: 302924:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15121.601731] LNetError: 302924:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15121.624870] LNet: Removed LNI 192.168.202.34@tcp50 [15122.338365] Key type .llcrypt unregistered [15122.340486] Key type ._llcrypt unregistered [15139.999871] Key type ._llcrypt registered [15140.013294] Key type .llcrypt registered [15140.675962] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15140.708819] alg: No test for adler32 (adler32-zlib) [15142.006120] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [15142.376601] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [15144.191259] Key type lgssc registered [15145.890457] Lustre: Echo OBD driver; http://www.lustre.org/ [15210.273990] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15216.968957] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15224.347579] LNet: Added LNI 192.168.202.34@tcp50 [8/256/0/180] [15225.185891] LNet: Removed LNI 192.168.202.34@tcp [15226.370885] Lustre: 305633:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffffa02bc92dd800: config has no valid NIDs, force dynamic NIDs [15227.605109] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [15228.173967] Lustre: Unmounted lustre-client [15269.503526] Key type lgssc unregistered [15269.906669] LNet: 306501:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15269.915072] LNetError: 306501:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15269.933357] LNet: Removed LNI 192.168.202.34@tcp50 [15270.513520] Key type .llcrypt unregistered [15270.525180] Key type ._llcrypt unregistered [15281.747497] Key type ._llcrypt registered [15281.749099] Key type .llcrypt registered [15283.181662] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 22:06:54 (1790906814) [15303.074863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15303.082143] alg: No test for adler32 (adler32-zlib) [15304.122979] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [15304.343100] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [15306.008559] Key type lgssc registered [15307.299667] Lustre: Echo OBD driver; http://www.lustre.org/ [15391.990434] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15398.018730] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15424.145977] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15465.634882] Key type lgssc unregistered [15465.900210] LNet: 311268:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15465.905230] LNetError: 311268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15465.920661] LNet: Removed LNI 192.168.202.34@tcp [15466.635784] Key type .llcrypt unregistered [15466.638469] Key type ._llcrypt unregistered [15478.899328] Key type ._llcrypt registered [15478.901128] Key type .llcrypt registered [15480.222809] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 22:10:11 (1790907011) [15482.377986] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15482.445618] alg: No test for adler32 (adler32-zlib) [15483.576830] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [15483.892567] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [15485.551965] Key type lgssc registered [15486.885859] Lustre: Echo OBD driver; http://www.lustre.org/ [15539.737910] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15545.462621] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15564.512808] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15566.272678] Lustre: Mounted lustre-client - version 2.17.58_63_g006d100 [15627.424343] Lustre: Mounted fs15246-client - version 2.17.58_63_g006d100 [15642.001540] Lustre: Unmounted fs15246-client [15670.068452] Lustre: Unmounted lustre-client [15696.029488] Key type lgssc unregistered [15696.349600] LNet: 316143:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15696.359594] LNetError: 316143:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15696.392354] LNet: Removed LNI 192.168.202.34@tcp [15697.188180] Key type .llcrypt unregistered [15697.190739] Key type ._llcrypt unregistered [15708.315478] Key type ._llcrypt registered [15708.317013] Key type .llcrypt registered [15709.648424] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 22:14:00 (1790907240) [15711.383528] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15711.605631] alg: No test for adler32 (adler32-zlib) [15712.847140] Lustre: Lustre: Build Version: 2.17.58_63_g006d100 [15713.140828] LNet: Added LNI 192.168.202.34@tcp [8/256/0/180] [15714.871321] Key type lgssc registered [15716.281563] Lustre: Echo OBD driver; http://www.lustre.org/ [15852.596725] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15859.137472] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15883.459987] Lustre: DEBUG MARKER: oleg234-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16004.766741] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15704 sec ========= 22:18:54 (1790907534) [16006.619606] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 22:18:57 (1790907537) === [16009.629992] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 22:19:01 (1790907541) === [16047.990180] Key type lgssc unregistered [16048.297465] LNet: 325427:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16048.327442] LNetError: 325427:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16048.352492] LNet: Removed LNI 192.168.202.34@tcp [16049.225909] Key type .llcrypt unregistered [16049.228786] Key type ._llcrypt unregistered