[ 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 503099891 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003105] x2apic enabled [ 0.004005] Switched APIC routing to physical x2apic. [ 0.005010] kvm-guest: setup PV IPIs [ 0.008430] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009027] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010016] pid_max: default: 32768 minimum: 301 [ 0.011186] LSM: Security Framework initializing [ 0.012073] Yama: becoming mindful. [ 0.013048] SELinux: Initializing. [ 0.015090] *** VALIDATE selinux *** [ 0.023781] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028480] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029150] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030119] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031118] *** VALIDATE tmpfs *** [ 0.033068] *** VALIDATE proc *** [ 0.034290] *** VALIDATE cgroup *** [ 0.035012] *** VALIDATE cgroup2 *** [ 0.036246] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037117] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039032] Spectre V2 : User space: Vulnerable [ 0.040006] Speculative Store Bypass: Vulnerable [ 0.043037] debug: unmapping init [mem 0xffffffff8ea59000-0xffffffff8ea60fff] [ 0.045865] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046577] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047033] ... version: 2 [ 0.048013] ... bit width: 48 [ 0.049015] ... generic registers: 4 [ 0.050019] ... value mask: 0000ffffffffffff [ 0.051012] ... max period: 00007fffffffffff [ 0.052016] ... fixed-purpose events: 3 [ 0.053016] ... event mask: 000000070000000f [ 0.054309] rcu: Hierarchical SRCU implementation. [ 0.056536] smp: Bringing up secondary CPUs ... [ 0.057624] x86: Booting SMP configuration: [ 0.058028] .... node #0, CPUs: #1 #2 #3 [ 0.064272] smp: Brought up 1 node, 4 CPUs [ 0.066013] smpboot: Max logical packages: 1 [ 0.067014] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.134087] node 0 deferred pages initialised in 65ms [ 0.138071] devtmpfs: initialized [ 0.139259] x86/mm: Memory block size: 128MB [ 0.144087] gcov: version magic: 0x41383552 [ 0.147310] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.151091] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.153324] pinctrl core: initialized pinctrl subsystem [ 0.155202] [ 0.155843] ************************************************************* [ 0.158013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.160012] ** ** [ 0.162016] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.164010] ** ** [ 0.167013] ** This means that this kernel is built to expose internal ** [ 0.169011] ** IOMMU data structures, which may compromise security on ** [ 0.172014] ** your system. ** [ 0.174013] ** ** [ 0.177012] ** If you see this message and you are not debugging the ** [ 0.179012] ** kernel, report this immediately to your vendor! ** [ 0.182012] ** ** [ 0.184010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.187017] ************************************************************* [ 0.189822] NET: Registered protocol family 16 [ 0.192448] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.195066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.198066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.202014] cpuidle: using governor menu [ 0.203909] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.204458] PCI: Using configuration type 1 for base access [ 0.205131] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.213054] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.214027] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.217141] cryptd: max_cpu_qlen set to 1000 [ 0.221288] ACPI: Added _OSI(Module Device) [ 0.224020] ACPI: Added _OSI(Processor Device) [ 0.226025] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.227015] ACPI: Added _OSI(Processor Aggregator Device) [ 0.232269] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.237410] ACPI: Interpreter enabled [ 0.239068] ACPI: PM: (supports S0 S3 S4 S5) [ 0.241015] ACPI: Using IOAPIC for interrupt routing [ 0.243112] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.246422] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.258980] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.261043] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.263033] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.267110] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.272585] acpiphp: Slot [2] registered [ 0.274169] acpiphp: Slot [5] registered [ 0.276216] acpiphp: Slot [6] registered [ 0.277130] acpiphp: Slot [3] registered [ 0.279241] acpiphp: Slot [4] registered [ 0.281183] acpiphp: Slot [7] registered [ 0.282175] acpiphp: Slot [8] registered [ 0.284165] acpiphp: Slot [9] registered [ 0.286174] acpiphp: Slot [10] registered [ 0.288104] acpiphp: Slot [11] registered [ 0.289118] acpiphp: Slot [12] registered [ 0.291121] acpiphp: Slot [13] registered [ 0.292142] acpiphp: Slot [14] registered [ 0.294094] acpiphp: Slot [15] registered [ 0.295078] acpiphp: Slot [16] registered [ 0.297120] acpiphp: Slot [17] registered [ 0.299129] acpiphp: Slot [18] registered [ 0.300111] acpiphp: Slot [19] registered [ 0.302140] acpiphp: Slot [20] registered [ 0.304194] acpiphp: Slot [21] registered [ 0.305121] acpiphp: Slot [22] registered [ 0.307158] acpiphp: Slot [23] registered [ 0.309086] acpiphp: Slot [24] registered [ 0.310155] acpiphp: Slot [25] registered [ 0.311070] acpiphp: Slot [26] registered [ 0.312033] acpiphp: Slot [27] registered [ 0.312734] acpiphp: Slot [28] registered [ 0.313114] acpiphp: Slot [29] registered [ 0.315105] acpiphp: Slot [30] registered [ 0.317144] acpiphp: Slot [31] registered [ 0.318046] PCI host bridge to bus 0000:00 [ 0.318971] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.320016] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.322017] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.324027] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.326019] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.328023] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.329232] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.333025] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.336312] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.344016] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.348058] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.351025] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.353019] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.355079] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.358517] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.361837] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.364051] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.367850] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.373013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.384021] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.389022] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.394483] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.402018] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.413020] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.432018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.446501] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.453014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.464020] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.487031] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.499046] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.502372] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.505501] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.508379] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.511268] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.518093] iommu: Default domain type: Passthrough [ 0.520408] SCSI subsystem initialized [ 0.522132] ACPI: bus type USB registered [ 0.523175] usbcore: registered new interface driver usbfs [ 0.525072] usbcore: registered new interface driver hub [ 0.527065] usbcore: registered new device driver usb [ 0.528147] pps_core: LinuxPPS API ver. 1 registered [ 0.529008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.531049] PTP clock support registered [ 0.532119] EDAC MC: Ver: 3.0.0 [ 0.533672] PCI: Using ACPI for IRQ routing [ 0.534859] NetLabel: Initializing [ 0.535016] NetLabel: domain hash size = 128 [ 0.536035] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.537096] NetLabel: unlabeled traffic allowed by default [ 0.540251] vgaarb: loaded [ 0.542264] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.543010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.548714] clocksource: Switched to clocksource kvm-clock [ 0.654728] VFS: Disk quotas dquot_6.6.0 [ 0.656527] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.659478] *** VALIDATE ramfs *** [ 0.660596] *** VALIDATE hugetlbfs *** [ 0.661929] pnp: PnP ACPI init [ 0.664340] pnp: PnP ACPI: found 6 devices [ 0.681217] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.684900] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.687288] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.689688] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.692366] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.695016] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.697245] NET: Registered protocol family 2 [ 0.699766] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.704740] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.708508] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.713642] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.716904] TCP: Hash tables configured (established 65536 bind 65536) [ 0.719941] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.723135] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.726433] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.729586] NET: Registered protocol family 1 [ 0.732809] RPC: Registered named UNIX socket transport module. [ 0.735318] RPC: Registered udp transport module. [ 0.737299] RPC: Registered tcp transport module. [ 0.739232] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.741836] NET: Registered protocol family 44 [ 0.743027] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.745207] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.746921] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.749191] PCI: CLS 0 bytes, default 64 [ 0.751488] Unpacking initramfs... [ 2.073470] debug: unmapping init [mem 0xffff8d53fcc64000-0xffff8d53fffcffff] [ 2.077325] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.079598] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.082515] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.531312] Initialise system trusted keyrings [ 2.532959] Key type blacklist registered [ 2.534778] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.543175] zbud: loaded [ 2.546319] *** VALIDATE nfs *** [ 2.548238] *** VALIDATE nfs4 *** [ 2.550035] pstore: using deflate compression [ 2.553653] Platform Keyring initialized [ 2.653864] NET: Registered protocol family 38 [ 2.655487] Key type asymmetric registered [ 2.657075] Asymmetric key parser 'x509' registered [ 2.658594] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.660892] io scheduler mq-deadline registered [ 2.662142] io scheduler kyber registered [ 2.663323] io scheduler bfq registered [ 2.664711] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.666940] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.669180] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.672567] ACPI: Power Button [PWRF] [ 2.677216] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.684096] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.692864] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.720564] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.748676] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.753472] Non-volatile memory driver v1.3 [ 2.755173] Linux agpgart interface v0.103 [ 2.784971] virtio_blk virtio1: [vda] 145912 512-byte logical blocks (74.7 MB/71.2 MiB) [ 2.789460] vda: detected capacity change from 0 to 74706944 [ 2.806260] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.810905] vdb: detected capacity change from 0 to 1073741824 [ 2.818310] libphy: Fixed MDIO Bus: probed [ 2.830708] usbcore: registered new interface driver usbserial_generic [ 2.833738] usbserial: USB Serial support registered for generic [ 2.836693] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.841303] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.843404] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.845832] mousedev: PS/2 mouse device common for all mice [ 2.848386] rtc_cmos 00:05: RTC can wake from S4 [ 2.850864] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.854076] rtc_cmos 00:05: registered as rtc0 [ 2.855937] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.856812] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.862492] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.862876] intel_pstate: CPU model not supported [ 2.868477] hid: raw HID events driver (C) Jiri Kosina [ 2.870745] usbcore: registered new interface driver usbhid [ 2.872161] usbhid: USB HID core driver [ 2.873525] drop_monitor: Initializing network drop monitor service [ 2.876245] Initializing XFRM netlink socket [ 2.878301] NET: Registered protocol family 10 [ 2.881259] Segment Routing with IPv6 [ 2.882356] NET: Registered protocol family 17 [ 2.883877] mpls_gso: MPLS GSO support [ 2.889090] RAS: Correctable Errors collector initialized. [ 2.891360] AVX version of gcm_enc/dec engaged. [ 2.893252] AES CTR mode by8 optimization enabled [ 2.967823] sched_clock: Marking stable (2967800904, 0)->(3797835563, -830034659) [ 2.971150] registered taskstats version 1 [ 2.973415] Loading compiled-in X.509 certificates [ 2.975840] zswap: loaded using pool lzo/zbud [ 2.997100] Key type big_key registered [ 3.006440] Key type encrypted registered [ 3.008311] ima: No TPM chip found, activating TPM-bypass! [ 3.010798] ima: Allocated hash algorithm: sha1 [ 3.012862] ima: No architecture policies found [ 3.014903] evm: Initialising EVM extended attributes: [ 3.017118] evm: security.selinux [ 3.018539] evm: security.ima [ 3.019872] evm: security.capability [ 3.021906] evm: HMAC attrs: 0x1 [ 3.024415] rtc_cmos 00:05: setting system clock to 2026-08-14 23:16:02 UTC (1786749362) [ 3.031382] debug: unmapping init [mem 0xffffffff8fa03000-0xffffffff8fbfffff] [ 3.034882] debug: unmapping init [mem 0xffffffff8e782000-0xffffffff8ea58fff] [ 3.047092] Write protecting the kernel read-only data: 28672k [ 3.050757] debug: unmapping init [mem 0xffffffff8ce03000-0xffffffff8cffffff] [ 3.054253] debug: unmapping init [mem 0xffffffff8d714000-0xffffffff8d7fffff] [ 3.088178] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.098274] systemd[1]: Detected virtualization kvm. [ 3.100316] systemd[1]: Detected architecture x86-64. [ 3.102423] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.131208] systemd[1]: No hostname configured. [ 3.134028] systemd[1]: Set hostname to . [ 3.136265] random: systemd: uninitialized urandom read (16 bytes read) [ 3.138804] systemd[1]: Initializing machine ID from random generator. [ 3.180405] random: ln: uninitialized urandom read (6 bytes read) [ 3.274151] random: systemd: uninitialized urandom read (16 bytes read) [ 3.276155] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.279882] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.284058] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Local File Systems. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. [ OK ] Reached target Timers. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Listening on Journal Socket. [ OK ] Reached target Sockets. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... Starting Journal Service... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.877266] random: fast init done [ 3.928590] device-mapper: uevent: version 1.0.3 [ 3.930853] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.679881] virtio_net virtio0 ens2: renamed from eth0 [ 4.765962] scsi host0: ata_piix [ 4.779611] scsi host1: ata_piix [ 4.781452] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.784503] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.176758] dracut-initqueue[599]: RTNETLINK answers: File exists [ 9.528305] random: crng init done [ 9.529828] 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. [ 10.100967] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.461532] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.704466] SELinux: Disabled at runtime. [ 11.768157] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.774923] systemd[1]: Detected virtualization kvm. [ 11.776213] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.244968] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.249439] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.257159] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.260265] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.262700] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.271785] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.279698] systemd[1]: Activating swap /dev/disk/by-label/SWAP... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-getty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice User and Session Slice. [ OK ] Reached target rpc_pipefs.target. [FAILED[ 12.316852] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS ] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Kernel Socket. Mounting Huge Pages File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Reached target Paths. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. Starting Remount Root and Kernel File Systems... Mounting POSIX Message Queue File System... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Mounting Kernel Debug File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.808763] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.367149] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.397226] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.467871] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.499508] EDAC sbridge: Ver: 1.1.2 [ 14.798419] Key type dns_resolver registered [ 15.103540] NFS: Registering the id_resolver key type [ 15.105578] Key type id_resolver registered [ 15.107065] 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 Create Volatile Files and Directories... Starting Load/Save Random Seed... [ 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 dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ 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 System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg133-client login: [ 57.321668] hrtimer: interrupt took 3941138 ns [ 77.411777] libcfs: loading out-of-tree module taints kernel. [ 77.476023] Key type ._llcrypt registered [ 77.478824] Key type .llcrypt registered [ 78.183421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 78.212425] alg: No test for adler32 (adler32-zlib) [ 79.767461] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 80.612624] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 82.516180] Key type lgssc registered [ 85.140561] Lustre: Echo OBD driver; http://www.lustre.org/ [ 274.158958] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 279.549581] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 294.560620] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing check_logdir /tmp/testlogs/ [ 299.999353] Lustre: lustre-OST0000-osc-ffff8d54521a0000: disconnect after 23s idle [ 300.738496] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing yml_node [ 307.442406] Lustre: DEBUG MARKER: Client: 2.17.57.2 [ 310.160326] Lustre: DEBUG MARKER: MDS: 2.17.57.2 [ 313.387453] Lustre: DEBUG MARKER: OSS: 2.17.57.2 [ 315.749962] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Aug 14 19:21:13 EDT 2026 [ 334.177927] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 336.163573] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 338.757357] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 349.075502] Lustre: Unmounted lustre-client [ 483.224946] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 490.101429] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 517.999150] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 566.022643] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 19:25:24 (1786749924) [ 569.041314] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 570.642794] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 19:25:28 (1786749928) [ 605.220748] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 610.889328] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 634.027968] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 634.728114] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 643.458802] Lustre: Unmounted lustre-client [ 680.495263] Key type lgssc unregistered [ 680.791221] LNet: 15060:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 680.801985] LNetError: 15060:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 680.834364] LNet: Removed LNI 192.168.201.33@tcp [ 681.816183] Key type .llcrypt unregistered [ 681.817683] Key type ._llcrypt unregistered [ 697.642390] Key type ._llcrypt registered [ 697.644906] Key type .llcrypt registered [ 699.197649] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 19:27:36 (1786750056) [ 701.017320] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 701.167592] alg: No test for adler32 (adler32-zlib) [ 702.201232] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 702.539952] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 704.367338] Key type lgssc registered [ 705.635440] Lustre: Echo OBD driver; http://www.lustre.org/ [ 790.540153] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 878.345507] Lustre: Unmounted lustre-client [ 909.699620] Key type lgssc unregistered [ 909.961726] LNet: 18847:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 909.971350] LNetError: 18847:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 911.020375] LNet: Removed LNI 192.168.201.33@tcp [ 912.165352] Key type .llcrypt unregistered [ 912.171515] Key type ._llcrypt unregistered [ 923.001820] Key type ._llcrypt registered [ 923.006425] Key type .llcrypt registered [ 924.342229] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 19:31:22 (1786750282) [ 926.477805] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 926.496380] alg: No test for adler32 (adler32-zlib) [ 927.593305] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 927.922947] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 929.647333] Key type lgssc registered [ 931.201792] Lustre: Echo OBD driver; http://www.lustre.org/ [ 990.089308] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 997.919836] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1023.405617] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1030.692839] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 1042.730766] Lustre: Unmounted lustre-client [ 1069.776834] Key type lgssc unregistered [ 1070.108586] LNet: 22452:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1070.126602] LNetError: 22452:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1070.161128] LNet: Removed LNI 192.168.201.33@tcp [ 1071.291758] Key type .llcrypt unregistered [ 1071.294449] Key type ._llcrypt unregistered [ 1083.682277] Key type ._llcrypt registered [ 1083.683896] Key type .llcrypt registered [ 1085.136497] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 19:34:02 (1786750442) [ 1088.042172] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1088.375326] alg: No test for adler32 (adler32-zlib) [ 1089.513130] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 1089.903937] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 1091.727221] Key type lgssc registered [ 1093.281829] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1148.149403] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1154.651253] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1183.338873] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1186.121699] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 1191.690724] Lustre: Unmounted lustre-client [ 1221.086923] Key type lgssc unregistered [ 1221.399157] LNet: 25647:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1221.403996] LNetError: 25647:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1221.414864] LNet: Removed LNI 192.168.201.33@tcp [ 1222.248410] Key type .llcrypt unregistered [ 1222.250383] Key type ._llcrypt unregistered [ 1240.295512] Key type ._llcrypt registered [ 1240.300344] Key type .llcrypt registered [ 1242.342612] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 19:36:39 (1786750599) [ 1245.030996] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1245.266312] alg: No test for adler32 (adler32-zlib) [ 1246.316984] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 1246.567106] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 1248.255755] Key type lgssc registered [ 1249.537420] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1305.662579] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1311.858884] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1336.307276] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1339.194349] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 1344.496617] Lustre: lustre-MDT0000-mdc-ffff8d5449949000: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1354.730616] Lustre: lustre-MDT0001-mdc-ffff8d5449949000: Connection to lustre-MDT0001 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1362.367129] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1370.975893] Lustre: 26603:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786750714/real 1786750714] req@00000000db7f2446 x1873543803443200/t0(0) o400->MGC192.168.201.133@tcp@192.168.201.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1786750730 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1371.022516] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [ 1372.755538] Lustre: Unmounted lustre-client [ 1395.525495] Key type lgssc unregistered [ 1395.928529] LNet: 29304:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1395.948180] LNetError: 29304:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1395.988725] LNet: Removed LNI 192.168.201.33@tcp [ 1397.007654] Key type .llcrypt unregistered [ 1397.011404] Key type ._llcrypt unregistered [ 1416.393248] Key type ._llcrypt registered [ 1416.395822] Key type .llcrypt registered [ 1417.965271] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 19:39:35 (1786750775) [ 1421.152942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1421.182444] alg: No test for adler32 (adler32-zlib) [ 1422.387751] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 1422.735617] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 1424.480524] Key type lgssc registered [ 1426.127690] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1478.985906] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1484.751973] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1507.259920] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1510.051841] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 1520.615432] Lustre: lustre-OST0000-osc-ffff8d544587e800: Connection to lustre-OST0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1526.462761] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1536.854953] Lustre: Unmounted lustre-client [ 1565.132674] Key type lgssc unregistered [ 1565.443594] LNet: 32918:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1565.451918] LNetError: 32918:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1565.474539] LNet: Removed LNI 192.168.201.33@tcp [ 1566.398882] Key type .llcrypt unregistered [ 1566.402512] Key type ._llcrypt unregistered [ 1582.164664] Key type ._llcrypt registered [ 1582.167966] Key type .llcrypt registered [ 1583.805331] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 19:42:21 (1786750941) [ 1586.353874] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1586.500979] alg: No test for adler32 (adler32-zlib) [ 1587.576452] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 1587.799556] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 1589.527232] Key type lgssc registered [ 1590.886075] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1647.625599] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1654.349030] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1676.282492] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1678.012498] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 1685.604267] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1689.892950] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1701.647257] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-1419h44m19s [ 1704.897438] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1709.027304] Lustre: lustre-MDT0000-mdc-ffff8d544471b800: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1723.367662] LustreError: 36708:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8d544471b800: can't stat MDS #0: rc = -19 [ 1725.222663] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1734.639456] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [ 1734.701707] Lustre: Evicted from MGS (at 192.168.201.133@tcp) after server handle changed from 0x35f8a50e279cf12d to 0x35f8a50e279cf2ca [ 1734.713944] Lustre: MGC192.168.201.133@tcp: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 1739.770805] LustreError: lustre-MDT0000-mdc-ffff8d544471b800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1739.792910] Lustre: lustre-MDT0000-mdc-ffff8d544471b800: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 1745.881828] Lustre: DEBUG MARKER: Wait for df (36708) ... [ 1748.897761] Lustre: DEBUG MARKER: done [ 1751.510876] Lustre: Unmounted lustre-client [ 1780.335118] Key type lgssc unregistered [ 1780.651211] LNet: 37728:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1780.661879] LNetError: 37728:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1780.677352] LNet: Removed LNI 192.168.201.33@tcp [ 1781.622267] Key type .llcrypt unregistered [ 1781.625380] Key type ._llcrypt unregistered [ 1817.099620] Key type ._llcrypt registered [ 1817.102536] Key type .llcrypt registered [ 1818.492402] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 19:46:16 (1786751176) [ 1822.312681] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1822.414301] alg: No test for adler32 (adler32-zlib) [ 1823.721333] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 1824.117583] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 1825.895301] Key type lgssc registered [ 1827.343502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1879.784723] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1886.250391] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1910.925497] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1913.939930] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 1918.292562] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-1419h47m56s [ 1920.338510] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1928.740769] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1932.699434] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1953.247159] Lustre: 41883:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786751292/real 1786751292] req@00000000033cf82b x1873544408472320/t0(0) o101->lustre-MDT0000-mdc-ffff8d5445878000@192.168.201.133@tcp:12/10 lens 576/1152 e 0 to 1 dl 1786751312 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1953.281210] Lustre: lustre-MDT0000-mdc-ffff8d5445878000: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1953.351950] Lustre: lustre-MDT0000-mdc-ffff8d5445878000: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 1975.144609] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1978.718141] Lustre: DEBUG MARKER: done [ 1984.776829] Lustre: Unmounted lustre-client [ 2023.051799] Key type lgssc unregistered [ 2023.356045] LNet: 42766:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2023.367273] LNetError: 42766:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2023.394966] LNet: Removed LNI 192.168.201.33@tcp [ 2024.293513] Key type .llcrypt unregistered [ 2024.300511] Key type ._llcrypt unregistered [ 2064.215054] Key type ._llcrypt registered [ 2064.223134] Key type .llcrypt registered [ 2065.823414] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 19:50:23 (1786751423) [ 2068.071441] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2070.203456] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 19:50:28 (1786751428) [ 2077.187769] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2077.214181] alg: No test for adler32 (adler32-zlib) [ 2078.514753] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 2078.876247] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 2080.679186] Key type lgssc registered [ 2082.113144] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2113.035980] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 19:51:10 (1786751470) [ 2153.919343] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2161.574568] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2188.800042] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2191.981588] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 2196.570193] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2202.941036] Lustre: Unmounted lustre-client [ 2218.471917] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2271.622319] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2278.620853] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2279.727150] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 2285.170800] Lustre: Unmounted lustre-client [ 2364.391970] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2372.201626] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2373.482397] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 2377.079907] Lustre: Unmounted lustre-client [ 2395.835859] Lustre: DEBUG MARKER: files compared the same [ 2420.175583] Key type lgssc unregistered [ 2420.443863] LNet: 50401:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2420.452538] LNetError: 50401:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2420.484905] LNet: Removed LNI 192.168.201.33@tcp [ 2421.168590] Key type .llcrypt unregistered [ 2421.170054] Key type ._llcrypt unregistered [ 2438.810678] Key type ._llcrypt registered [ 2438.813035] Key type .llcrypt registered [ 2440.510439] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 19:56:38 (1786751798) [ 2443.174488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2443.247137] alg: No test for adler32 (adler32-zlib) [ 2444.500688] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 2444.783110] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 2446.447310] Key type lgssc registered [ 2447.973894] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2502.707124] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2510.699718] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2535.890703] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2538.992200] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 2544.163846] Lustre: Unmounted lustre-client [ 2575.888080] Key type lgssc unregistered [ 2576.116363] LNet: 53990:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2576.121740] LNetError: 53990:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2576.134977] LNet: Removed LNI 192.168.201.33@tcp [ 2576.732101] Key type .llcrypt unregistered [ 2576.733837] Key type ._llcrypt unregistered [ 2596.838560] Key type ._llcrypt registered [ 2596.840065] Key type .llcrypt registered [ 2598.207204] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 19:59:16 (1786751956) [ 2601.263461] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2601.321386] alg: No test for adler32 (adler32-zlib) [ 2602.462382] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 2602.876035] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 2604.615387] Key type lgssc registered [ 2606.351343] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2691.812723] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2734.582225] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2740.752339] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2769.311876] Key type lgssc unregistered [ 2769.564039] LNet: 57498:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2769.568213] LNetError: 57498:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2769.588813] LNet: Removed LNI 192.168.201.33@tcp [ 2770.436643] Key type .llcrypt unregistered [ 2770.438977] Key type ._llcrypt unregistered [ 2789.292766] Key type ._llcrypt registered [ 2789.294363] Key type .llcrypt registered [ 2790.592513] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 20:02:28 (1786752148) [ 2794.572153] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2794.614103] alg: No test for adler32 (adler32-zlib) [ 2795.715593] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 2795.986458] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 2797.656449] Key type lgssc registered [ 2798.510586] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2876.217567] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 2883.598497] Lustre: Unmounted lustre-client [ 2925.602496] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 20:04:43 (1786752283) [ 3069.491878] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3089.028238] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3096.974904] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3096.978731] LustreError: 63972:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8d545128e000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3097.038331] Lustre: 58481:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.133@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3107.383980] Lustre: Unmounted lustre-client [ 3157.193365] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 20:08:35 (1786752515) [ 3171.417419] Key type lgssc unregistered [ 3171.778936] LNet: 65187:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3171.788296] LNetError: 65187:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3171.802327] LNet: Removed LNI 192.168.201.33@tcp [ 3172.540842] Key type .llcrypt unregistered [ 3172.544550] Key type ._llcrypt unregistered [ 3189.144277] Key type ._llcrypt registered [ 3189.155886] Key type .llcrypt registered [ 3189.711902] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3189.723649] alg: No test for adler32 (adler32-zlib) [ 3190.910781] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 3191.195051] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 3192.865814] Key type lgssc registered [ 3194.084930] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3250.546270] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3257.290773] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3288.296894] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3295.334658] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3299.710559] Lustre: Unmounted lustre-client [ 3329.344561] Key type lgssc unregistered [ 3329.616524] LNet: 68204:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3329.632712] LNetError: 68204:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3329.650705] LNet: Removed LNI 192.168.201.33@tcp [ 3330.489879] Key type .llcrypt unregistered [ 3330.491569] Key type ._llcrypt unregistered [ 3341.839913] Key type ._llcrypt registered [ 3341.851141] Key type .llcrypt registered [ 3342.336878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3342.347450] alg: No test for adler32 (adler32-zlib) [ 3343.540442] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 3343.864873] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 3345.530578] Key type lgssc registered [ 3347.088602] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3468.505893] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3474.311840] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3498.622361] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3500.480208] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3503.010633] Lustre: Unmounted lustre-client [ 3532.109883] Key type lgssc unregistered [ 3532.505270] LNet: 71635:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3532.517482] LNetError: 71635:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3532.544768] LNet: Removed LNI 192.168.201.33@tcp [ 3533.481537] Key type .llcrypt unregistered [ 3533.483335] Key type ._llcrypt unregistered [ 3554.264459] Key type ._llcrypt registered [ 3554.266452] Key type .llcrypt registered [ 3555.316930] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 20:15:13 (1786752913) [ 3558.192224] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3558.233447] alg: No test for adler32 (adler32-zlib) [ 3559.263293] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 3559.492550] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 3561.151205] Key type lgssc registered [ 3562.572298] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3625.366562] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3631.501561] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3657.584291] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3660.482382] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3666.906853] Lustre: Unmounted lustre-client [ 3667.238230] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3670.577736] Lustre: Unmounted lustre-client [ 3700.269593] Key type lgssc unregistered [ 3700.587804] LNet: 75337:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3700.591550] LNetError: 75337:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3700.615719] LNet: Removed LNI 192.168.201.33@tcp [ 3701.333179] Key type .llcrypt unregistered [ 3701.336766] Key type ._llcrypt unregistered [ 3713.642545] Key type ._llcrypt registered [ 3713.648363] Key type .llcrypt registered [ 3713.925415] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3713.933931] alg: No test for adler32 (adler32-zlib) [ 3715.058484] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 3715.354187] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 3717.056196] Key type lgssc registered [ 3718.389852] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3773.532647] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3778.588974] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3801.427066] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3803.139040] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3807.238677] Lustre: Unmounted lustre-client [ 3841.859521] Key type lgssc unregistered [ 3842.117224] LNet: 78373:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3842.123339] LNetError: 78373:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3842.136922] LNet: Removed LNI 192.168.201.33@tcp [ 3842.847820] Key type .llcrypt unregistered [ 3842.850957] Key type ._llcrypt unregistered [ 3858.182601] Key type ._llcrypt registered [ 3858.185181] Key type .llcrypt registered [ 3859.610189] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 20:20:17 (1786753217) [ 3861.885098] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3861.992478] alg: No test for adler32 (adler32-zlib) [ 3863.148872] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 3863.397901] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 3865.023328] Key type lgssc registered [ 3865.820541] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3914.488588] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3920.247738] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3941.122529] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3942.882195] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 3959.868358] Lustre: lustre: nosquash_nids is cleared [ 3959.902251] Lustre: lustre: root_squash is set to 500:500 [ 3979.852075] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.33@tcp 192.168.0.[2,10]@tcp [ 3985.666882] Lustre: lustre: nosquash_nids set to 192.168.201.33/24@tcp [ 3989.427568] Lustre: Unmounted lustre-client [ 4012.275631] Key type lgssc unregistered [ 4012.447344] LNet: 82328:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4012.450675] LNetError: 82328:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4012.467214] LNet: Removed LNI 192.168.201.33@tcp [ 4013.022403] Key type .llcrypt unregistered [ 4013.024409] Key type ._llcrypt unregistered [ 4026.988884] Key type ._llcrypt registered [ 4026.990909] Key type .llcrypt registered [ 4028.076755] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 20:23:06 (1786753386) [ 4030.408740] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4032.278948] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 20:23:10 (1786753390) [ 4034.273588] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4034.307391] alg: No test for adler32 (adler32-zlib) [ 4035.292220] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 4035.491899] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 4037.185088] Key type lgssc registered [ 4038.128971] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4084.327120] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4089.569415] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4111.682644] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4113.327490] Lustre: lustre: root_squash is set to 500:500 [ 4113.361715] Lustre: lustre: nosquash_nids set to 192.168.201.33/24@tcp [ 4114.412798] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 4120.532196] Lustre: Unmounted lustre-client [ 4150.276398] Key type lgssc unregistered [ 4150.519891] LNet: 86285:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4150.525536] LNetError: 86285:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4150.542217] LNet: Removed LNI 192.168.201.33@tcp [ 4151.264304] Key type .llcrypt unregistered [ 4151.270360] Key type ._llcrypt unregistered [ 4168.197128] Key type ._llcrypt registered [ 4168.199606] Key type .llcrypt registered [ 4169.921528] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4171.938909] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 20:25:29 (1786753529) [ 4189.780816] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4189.810677] alg: No test for adler32 (adler32-zlib) [ 4191.156997] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 4191.576797] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 4193.425204] Key type lgssc registered [ 4195.052942] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4284.289268] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4290.445687] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4315.565326] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4394.135968] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4403.693127] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4428.599305] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4442.008685] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 4479.463764] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8d5444719000.ost_server_uuid 50 [ 4481.030799] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8d5444719000.ost_server_uuid in IDLE state after 0 sec [ 4481.754477] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 4486.279597] Lustre: Unmounted lustre-client [ 4488.362644] Lustre: Unmounted lustre-client [ 4540.932706] Key type lgssc unregistered [ 4541.147825] LNet: 93954:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4541.152987] LNetError: 93954:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4541.168171] LNet: Removed LNI 192.168.201.33@tcp [ 4541.805066] Key type .llcrypt unregistered [ 4541.807675] Key type ._llcrypt unregistered [ 4575.073391] Key type ._llcrypt registered [ 4575.075291] Key type .llcrypt registered [ 4576.224403] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 20:32:14 (1786753934) [ 4598.862669] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4598.916825] alg: No test for adler32 (adler32-zlib) [ 4600.261635] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 4600.554739] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 4602.255209] Key type lgssc registered [ 4603.496485] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4695.573618] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4701.296820] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4727.261493] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4729.059409] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 4749.732773] Lustre: 95318:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786754093/real 1786754093] req@00000000930a2956 x1873547320366208/t0(0) o400->lustre-OST0000-osc-ffff8d54505fb000@192.168.201.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1786754109 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4749.808302] Lustre: lustre-OST0000-osc-ffff8d54505fb000: Connection to lustre-OST0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4755.935997] Lustre: 95317:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786754099/real 1786754099] req@0000000068ba72ff x1873547320366720/t0(0) o400->lustre-OST0000-osc-ffff8d54505fb000@192.168.201.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1786754115 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4760.102971] Lustre: lustre-OST0000-osc-ffff8d54505fb000: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 4761.122304] Lustre: 95317:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786754104/real 1786754104] req@000000006121a8be x1873547320367232/t0(0) o400->lustre-OST0000-osc-ffff8d54505fb000@192.168.201.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1786754120 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4765.159836] Lustre: lustre-MDT0000-mdc-ffff8d54505fb000: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4766.177550] Lustre: 95317:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786754109/real 1786754109] req@000000009088a4a3 x1873547320367744/t0(0) o400->lustre-OST0000-osc-ffff8d54505fb000@192.168.201.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1786754125 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4781.535204] Lustre: 95317:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786754124/real 1786754124] req@000000004ea632ba x1873547320369536/t0(0) o400->MGC192.168.201.133@tcp@192.168.201.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1786754140 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4781.593409] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [ 4791.799742] Lustre: Evicted from MGS (at 192.168.201.133@tcp) after server handle changed from 0xc4062c25e86ee21 to 0xc4062c25e86f0b3 [ 4791.852300] Lustre: MGC192.168.201.133@tcp: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 4796.235171] Lustre: lustre-MDT0000-mdc-ffff8d54505fb000: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 4803.635091] Lustre: Unmounted lustre-client [ 4834.588524] Key type lgssc unregistered [ 4834.882175] LNet: 99632:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4834.889758] LNetError: 99632:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4834.912545] LNet: Removed LNI 192.168.201.33@tcp [ 4835.972596] Key type .llcrypt unregistered [ 4835.985894] Key type ._llcrypt unregistered [ 4855.833554] Key type ._llcrypt registered [ 4855.836419] Key type .llcrypt registered [ 4857.388789] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 20:36:55 (1786754215) [ 4872.749087] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4872.832996] alg: No test for adler32 (adler32-zlib) [ 4873.888710] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 4874.109389] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 4875.767395] Key type lgssc registered [ 4877.070804] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4918.977471] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5027.675793] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5033.301758] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5057.121774] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5058.873715] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 5060.873037] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5062.729867] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 20:40:20 (1786754420) [ 5309.057784] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5319.415639] Lustre: Unmounted lustre-client [ 5456.000906] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5462.937825] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5486.132161] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5528.583954] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 20:48:06 (1786754886) [ 5640.165407] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5647.134486] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5672.486708] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5673.293398] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 5677.394568] Lustre: Unmounted lustre-client [ 5709.814949] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 20:51:07 (1786755067) [ 5808.810397] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5814.127565] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5838.605275] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5839.183431] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 5844.870116] Lustre: Unmounted lustre-client [ 5873.640595] Key type lgssc unregistered [ 5873.918095] LNet: 122657:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5873.926666] LNetError: 122657:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5873.950782] LNet: Removed LNI 192.168.201.33@tcp [ 5874.771272] Key type .llcrypt unregistered [ 5874.776111] Key type ._llcrypt unregistered [ 5892.104338] Key type ._llcrypt registered [ 5892.106507] Key type .llcrypt registered [ 5893.263752] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 20:54:11 (1786755251) [ 5895.601705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5895.644109] alg: No test for adler32 (adler32-zlib) [ 5896.764792] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 5897.045218] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 5898.767278] Key type lgssc registered [ 5900.086752] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5951.362367] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5957.207988] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5981.978537] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5984.827668] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 5999.061457] Lustre: Unmounted lustre-client [ 6030.671878] Key type lgssc unregistered [ 6030.975125] LNet: 126253:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6030.986683] LNetError: 126253:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6031.013687] LNet: Removed LNI 192.168.201.33@tcp [ 6031.725256] Key type .llcrypt unregistered [ 6031.731957] Key type ._llcrypt unregistered [ 6049.585354] Key type ._llcrypt registered [ 6049.589767] Key type .llcrypt registered [ 6051.343533] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 20:56:48 (1786755408) [ 6053.965399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6054.032079] alg: No test for adler32 (adler32-zlib) [ 6055.072614] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 6055.359478] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 6057.072149] Key type lgssc registered [ 6058.120494] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6111.177187] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6117.423458] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6144.352186] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6146.105257] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 6151.163308] Lustre: lustre-OST0000-osc-ffff8d5447b9b800: Connection to lustre-OST0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6167.093539] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8d5447b9b800.ost_server_uuid 50 [ 6169.393877] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6180.563652] Lustre: Unmounted lustre-client [ 6201.873492] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 20:59:19 (1786755559) [ 6240.846119] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6247.233215] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6268.941412] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6296.215064] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6297.117569] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 6302.184174] Lustre: lustre-OST0000-osc-ffff8d54505ff800: Connection to lustre-OST0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6331.511414] Lustre: Unmounted lustre-client [ 6386.096475] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 21:02:23 (1786755743) [ 6421.419778] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6427.112276] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6447.624598] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6469.733912] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6470.474366] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 6475.755414] Lustre: lustre-OST0000-osc-ffff8d544471c000: Connection to lustre-OST0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6492.458879] Lustre: Unmounted lustre-client [ 6539.558638] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 21:04:57 (1786755897) [ 6634.661442] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6640.697190] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6664.313483] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6739.970428] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6746.337484] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6770.358518] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6807.467663] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 6854.735680] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6856.300814] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6858.522446] Lustre: Unmounted lustre-client [ 6898.758627] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 21:10:56 (1786756256) [ 6929.206176] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6935.131504] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6955.486625] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6987.769686] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7019.977270] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 7062.977063] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7064.332955] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7076.550514] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7086.938482] Lustre: Unmounted lustre-client [ 7147.770917] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 21:15:05 (1786756505) [ 7182.030524] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7188.683100] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7210.844694] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7211.573787] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 7235.685811] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7237.370075] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7253.628210] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8d54459ae800.ost_server_uuid 50 [ 7255.126399] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8d54459ae800.ost_server_uuid in IDLE state after 0 sec [ 7258.084626] Lustre: Unmounted lustre-client [ 7258.374871] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7258.379614] Lustre: Skipped 3 previous similar messages [ 7258.436196] LustreError: 127212:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 7258.484465] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 7259.478846] LustreError: 149692:0:(sec.c:403:import_sec_validate_get()) import 000000002b8b5637 (NEW) with no sec [ 7322.885736] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 21:18:00 (1786756680) [ 7362.799038] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7369.794866] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7394.827906] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7420.185939] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7421.322479] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7421.574988] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 7432.952442] Lustre: Unmounted lustre-client [ 7432.960406] Lustre: Skipped 1 previous similar message [ 7477.067301] Key type lgssc unregistered [ 7477.294186] LNet: 153095:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7477.320729] LNetError: 153095:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7477.350316] LNet: Removed LNI 192.168.201.33@tcp [ 7478.179922] Key type .llcrypt unregistered [ 7478.183055] Key type ._llcrypt unregistered [ 7500.323773] Key type ._llcrypt registered [ 7500.329634] Key type .llcrypt registered [ 7501.701648] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 21:20:59 (1786756859) [ 7502.869527] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7502.920941] alg: No test for adler32 (adler32-zlib) [ 7503.918773] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 7504.165414] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 7505.831440] Key type lgssc registered [ 7507.308617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7572.251949] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7580.676628] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7605.342758] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7628.243301] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7628.696730] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7629.894503] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 7634.207350] LustreError: lustre-MDT0001-mdc-ffff8d544471b000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7634.238210] Lustre: lustre-MDT0001-mdc-ffff8d544471b000: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [ 7640.552879] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7642.725688] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7665.707141] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7670.507972] Lustre: Unmounted lustre-client [ 7702.750261] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 21:24:20 (1786757060) [ 7816.274086] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7824.510669] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7848.729173] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7849.456353] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 7878.486850] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7880.367361] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7883.263824] Lustre: lustre-OST0001-osc-ffff8d54482a1800: Connection to lustre-OST0001 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7894.350557] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7904.675212] Lustre: Unmounted lustre-client [ 7958.477587] Key type lgssc unregistered [ 7958.916642] LNet: 162703:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7958.921134] LNetError: 162703:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7958.937780] LNet: Removed LNI 192.168.201.33@tcp [ 7959.590846] Key type .llcrypt unregistered [ 7959.593626] Key type ._llcrypt unregistered [ 7997.461793] Key type ._llcrypt registered [ 7997.464520] Key type .llcrypt registered [ 7999.434725] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 21:29:16 (1786757356) [ 8002.675245] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8002.719529] alg: No test for adler32 (adler32-zlib) [ 8004.061423] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 8004.528190] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 8006.360751] Key type lgssc registered [ 8007.465339] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8065.437624] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8072.858174] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8098.118995] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8101.053458] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 8156.067807] Lustre: Unmounted lustre-client [ 8199.688709] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8200.414834] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 8238.429829] Lustre: Unmounted lustre-client [ 8268.467660] Key type lgssc unregistered [ 8268.760208] LNet: 167164:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8268.767772] LNetError: 167164:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8268.789745] LNet: Removed LNI 192.168.201.33@tcp [ 8269.577457] Key type .llcrypt unregistered [ 8269.579927] Key type ._llcrypt unregistered [ 8289.908557] Key type ._llcrypt registered [ 8289.911320] Key type .llcrypt registered [ 8292.103842] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 21:34:09 (1786757649) [ 8294.622589] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8294.845185] alg: No test for adler32 (adler32-zlib) [ 8296.176858] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 8296.454073] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 8298.239841] Key type lgssc registered [ 8299.259516] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8368.103357] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8374.914655] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8403.678788] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8406.789197] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 8430.926588] Lustre: Unmounted lustre-client [ 8461.023480] Key type lgssc unregistered [ 8461.496620] LNet: 170930:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8461.502896] LNetError: 170930:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8461.537070] LNet: Removed LNI 192.168.201.33@tcp [ 8462.549106] Key type .llcrypt unregistered [ 8462.552329] Key type ._llcrypt unregistered [ 8477.937850] Key type ._llcrypt registered [ 8477.939586] Key type .llcrypt registered [ 8478.687929] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8478.729918] alg: No test for adler32 (adler32-zlib) [ 8480.039840] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 8480.486393] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 8482.255250] Key type lgssc registered [ 8484.020155] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8541.828588] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8550.430910] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8576.738835] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8583.257612] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 8592.764723] Lustre: Unmounted lustre-client [ 8633.600776] Key type lgssc unregistered [ 8633.920840] LNet: 174006:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8633.925864] LNetError: 174006:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8633.944851] LNet: Removed LNI 192.168.201.33@tcp [ 8634.816658] Key type .llcrypt unregistered [ 8634.818462] Key type ._llcrypt unregistered [ 8651.584534] Key type ._llcrypt registered [ 8651.591708] Key type .llcrypt registered [ 8653.125119] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 21:40:10 (1786758010) [ 8655.754460] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8655.787242] alg: No test for adler32 (adler32-zlib) [ 8656.850141] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 8657.175301] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 8658.807331] Key type lgssc registered [ 8660.621330] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8714.039467] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8721.312168] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8745.170441] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8747.308782] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 8774.325924] Lustre: Unmounted lustre-client [ 8805.039558] Key type lgssc unregistered [ 8805.305049] LNet: 177765:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8805.310773] LNetError: 177765:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8805.328844] LNet: Removed LNI 192.168.201.33@tcp [ 8806.043320] Key type .llcrypt unregistered [ 8806.050817] Key type ._llcrypt unregistered [ 8820.316393] Key type ._llcrypt registered [ 8820.317884] Key type .llcrypt registered [ 8820.782801] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8820.809791] alg: No test for adler32 (adler32-zlib) [ 8821.955907] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 8822.298701] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 8824.023277] Key type lgssc registered [ 8825.293186] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8878.426902] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8885.099861] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8908.515753] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8910.260270] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 8920.009157] Lustre: Unmounted lustre-client [ 8946.354158] Key type lgssc unregistered [ 8946.564113] LNet: 180831:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8946.567799] LNetError: 180831:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8946.586819] LNet: Removed LNI 192.168.201.33@tcp [ 8947.094975] Key type .llcrypt unregistered [ 8947.097117] Key type ._llcrypt unregistered [ 8964.014194] Key type ._llcrypt registered [ 8964.017109] Key type .llcrypt registered [ 8965.726474] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 21:45:23 (1786758323) [ 8988.284704] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8988.338445] alg: No test for adler32 (adler32-zlib) [ 8989.449311] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 8989.680225] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 8991.328497] Key type lgssc registered [ 8992.648372] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9086.628568] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9092.688248] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9114.975739] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9154.620343] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 21:48:32 (1786758512) [ 9185.810731] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9191.351682] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9212.582906] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9215.394703] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 9219.717460] Lustre: Unmounted lustre-client [ 9245.118359] Key type lgssc unregistered [ 9245.399865] LNet: 187936:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9245.405750] LNetError: 187936:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9245.428991] LNet: Removed LNI 192.168.201.33@tcp [ 9246.089971] Key type .llcrypt unregistered [ 9246.092079] Key type ._llcrypt unregistered [ 9257.919958] Key type ._llcrypt registered [ 9257.924852] Key type .llcrypt registered [ 9259.353943] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9260.840333] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 21:50:19 (1786758619) [ 9278.418221] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9278.436655] alg: No test for adler32 (adler32-zlib) [ 9279.467877] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 9279.812687] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 9281.495209] Key type lgssc registered [ 9282.753245] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9369.345376] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9374.802953] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9399.238619] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9419.340775] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9421.209724] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [ 9444.423109] Lustre: Unmounted lustre-client [ 9567.468271] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9574.485717] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9598.072462] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9638.357794] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 21:56:36 (1786758996) [ 9639.536084] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9641.051058] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 21:56:39 (1786758999) [ 9736.718844] Key type lgssc unregistered [ 9736.912768] LNet: 199384:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9736.921855] LNetError: 199384:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9736.935331] LNet: Removed LNI 192.168.201.33@tcp [ 9737.446705] Key type .llcrypt unregistered [ 9737.448818] Key type ._llcrypt unregistered [ 9753.512126] Key type ._llcrypt registered [ 9753.516248] Key type .llcrypt registered [ 9754.740228] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 21:58:32 (1786759112) [ 9798.244573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9798.252490] alg: No test for adler32 (adler32-zlib) [ 9799.403348] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 9799.836619] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 9801.687760] Key type lgssc registered [ 9803.743532] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9855.827119] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9861.246840] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9895.915422] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9933.720051] Key type lgssc unregistered [ 9933.919085] LNet: 203133:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9933.924086] LNetError: 203133:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9933.939346] LNet: Removed LNI 192.168.201.33@tcp [ 9934.714117] Key type .llcrypt unregistered [ 9934.716523] Key type ._llcrypt unregistered [ 9954.311655] Key type ._llcrypt registered [ 9954.314744] Key type .llcrypt registered [ 9956.019210] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 22:01:53 (1786759313) [ 9959.104692] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9959.141627] alg: No test for adler32 (adler32-zlib) [ 9960.331517] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [ 9960.605620] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [ 9962.376840] Key type lgssc registered [ 9963.302507] Lustre: Echo OBD driver; http://www.lustre.org/ [10022.372748] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10029.050416] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10057.332668] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10069.608130] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [10079.739710] Lustre: lustre-MDT0000-mdc-ffff8d54505ff800: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [10089.978600] Lustre: lustre-MDT0001-mdc-ffff8d54505ff800: Connection to lustre-MDT0001 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [10101.023892] Lustre: 204125:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786759444/real 1786759444] req@000000002ff09d44 x1873552940810880/t0(0) o400->MGC192.168.201.133@tcp@192.168.201.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1786759460 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10101.071588] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [10111.339276] Lustre: Evicted from MGS (at 192.168.201.133@tcp) after server handle changed from 0x7fb6df4faba3dcfd to 0x7fb6df4faba3f7d0 [10111.376658] Lustre: MGC192.168.201.133@tcp: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [10135.045619] LustreError: lustre-MDT0000-mdc-ffff8d54505ff800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10135.108357] Lustre: lustre-MDT0000-mdc-ffff8d54505ff800: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [10139.513718] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10141.091385] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10145.851761] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10147.581782] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10150.329261] Lustre: Unmounted lustre-client [10176.803476] Key type lgssc unregistered [10177.190625] LNet: 208084:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10177.200683] LNetError: 208084:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10177.214168] LNet: Removed LNI 192.168.201.33@tcp [10178.099976] Key type .llcrypt unregistered [10178.102370] Key type ._llcrypt unregistered [10196.133557] Key type ._llcrypt registered [10196.135557] Key type .llcrypt registered [10197.522057] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 22:05:55 (1786759555) [10200.537123] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10200.568972] alg: No test for adler32 (adler32-zlib) [10201.840596] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [10202.235186] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [10204.120143] Key type lgssc registered [10206.585436] Lustre: Echo OBD driver; http://www.lustre.org/ [10267.732868] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10273.408636] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10330.270461] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10337.579982] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10375.141460] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10401.851543] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10455.486738] Key type lgssc unregistered [10455.710882] LNet: 213387:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10455.726578] LNetError: 213387:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10455.748472] LNet: Removed LNI 192.168.201.33@tcp [10456.675797] Key type .llcrypt unregistered [10456.682903] Key type ._llcrypt unregistered [10499.209182] Key type ._llcrypt registered [10499.211664] Key type .llcrypt registered [10500.579858] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 22:10:58 (1786759858) [10540.247462] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10540.267569] alg: No test for adler32 (adler32-zlib) [10541.510524] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [10541.909425] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [10543.711202] Key type lgssc registered [10545.244488] Lustre: Echo OBD driver; http://www.lustre.org/ [10638.846913] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10646.293922] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10671.779289] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10712.000584] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 22:14:30 (1786760070) [10719.855822] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 22:14:37 (1786760077) [10757.215860] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10765.748861] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10788.785776] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10791.238256] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [10797.049660] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10798.962886] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10801.307983] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10803.806509] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10806.762782] Lustre: lustre-MDT0000-mdc-ffff8d54505fc000: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [10823.135580] Lustre: 215283:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786760166/real 1786760166] req@000000001b82f15a x1873553549960832/t0(0) o400->MGC192.168.201.133@tcp@192.168.201.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1786760182 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10823.164847] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [10833.420214] Lustre: Evicted from MGS (at 192.168.201.133@tcp) after server handle changed from 0x82dc62025e111351 to 0x82dc62025e1114c4 [10833.483484] Lustre: MGC192.168.201.133@tcp: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [10840.935170] Lustre: lustre-MDT0000-mdc-ffff8d54505fc000: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [10852.562838] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10853.985877] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10857.522819] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10864.127636] Lustre: lustre-MDT0000-mdc-ffff8d54505fc000: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [10879.468990] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [10879.488069] Lustre: Evicted from MGS (at 192.168.201.133@tcp) after server handle changed from 0x82dc62025e1114c4 to 0x82dc62025e1117d4 [10879.498986] Lustre: MGC192.168.201.133@tcp: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [10886.656942] Lustre: 221275:0:(mgc_request.c:1899:mgc_process_log()) MGC192.168.201.133@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [10893.666356] Lustre: lustre-MDT0000-mdc-ffff8d54505fc000: Connection restored to 192.168.201.133@tcp (at 192.168.201.133@tcp) [10901.525469] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10903.016281] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10907.024145] Lustre: Unmounted lustre-client [10977.967612] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10982.775455] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11001.371439] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11002.391932] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [11004.400296] Lustre: Unmounted lustre-client [11035.164478] Key type lgssc unregistered [11035.457886] LNet: 225867:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11035.463373] LNetError: 225867:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11035.484411] LNet: Removed LNI 192.168.201.33@tcp [11036.058148] Key type .llcrypt unregistered [11036.059938] Key type ._llcrypt unregistered [11052.768578] Key type ._llcrypt registered [11052.770766] Key type .llcrypt registered [11053.993978] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 22:20:12 (1786760412) [11058.381505] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11058.478197] alg: No test for adler32 (adler32-zlib) [11059.672725] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [11059.911323] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [11061.555845] Key type lgssc registered [11063.027547] Lustre: Echo OBD driver; http://www.lustre.org/ [11112.335545] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11116.779277] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11136.039381] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11138.217094] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [11145.236464] Lustre: Unmounted lustre-client [11206.623396] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11213.331942] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11237.206823] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11237.974364] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [11246.601478] Lustre: Unmounted lustre-client [11322.002777] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11327.385990] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11348.723652] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11349.439436] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [11351.835832] Lustre: Unmounted lustre-client [11380.720453] Key type lgssc unregistered [11381.140556] LNet: 232914:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11381.148207] LNetError: 232914:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11381.175872] LNet: Removed LNI 192.168.201.33@tcp [11381.887643] Key type .llcrypt unregistered [11381.890854] Key type ._llcrypt unregistered [11397.429996] Key type ._llcrypt registered [11397.432482] Key type .llcrypt registered [11398.474194] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 22:25:56 (1786760756) [11401.882773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11401.891562] alg: No test for adler32 (adler32-zlib) [11402.919275] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [11403.112632] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [11404.751777] Key type lgssc registered [11405.840136] Lustre: Echo OBD driver; http://www.lustre.org/ [11449.978427] Key type lgssc unregistered [11450.326935] LNet: 235240:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11450.336271] LNetError: 235240:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11450.383221] LNet: Removed LNI 192.168.201.33@tcp [11451.176683] Key type .llcrypt unregistered [11451.179071] Key type ._llcrypt unregistered [11482.361435] Key type ._llcrypt registered [11482.371348] Key type .llcrypt registered [11483.008524] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11483.026134] alg: No test for adler32 (adler32-zlib) [11484.346651] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [11484.729849] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [11486.511240] Key type lgssc registered [11487.778580] Lustre: Echo OBD driver; http://www.lustre.org/ [11584.530161] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11590.351200] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11616.430474] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11677.745033] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11679.654643] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 22:30:37 (1786761037) [11724.114244] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11732.928789] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11760.591793] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11789.235718] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11791.146128] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [11796.469674] Lustre: lustre-OST0001-osc-ffff8d5450143000: Connection to lustre-OST0001 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [11803.667350] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11814.027171] Lustre: Unmounted lustre-client [11858.061748] Key type lgssc unregistered [11858.479323] LNet: 242361:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11858.495363] LNetError: 242361:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11858.523457] LNet: Removed LNI 192.168.201.33@tcp [11859.344869] Key type .llcrypt unregistered [11859.350107] Key type ._llcrypt unregistered [11894.564068] Key type ._llcrypt registered [11894.567554] Key type .llcrypt registered [11896.163932] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 22:34:13 (1786761253) [11909.494832] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11909.592214] alg: No test for adler32 (adler32-zlib) [11910.707421] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [11911.029843] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [11912.815281] Key type lgssc registered [11914.295789] Lustre: Echo OBD driver; http://www.lustre.org/ [11983.921666] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11992.431433] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12018.223971] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 22:36:16 (1786761376) [12053.301033] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12058.774868] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12082.590178] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12084.439615] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [12096.044543] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12105.144452] Lustre: Unmounted lustre-client [12217.579408] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12225.523571] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12280.010475] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12281.018483] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [12283.048021] Lustre: Unmounted lustre-client [12315.891854] Key type lgssc unregistered [12316.105975] LNet: 250077:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12316.113952] LNetError: 250077:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12316.148104] LNet: Removed LNI 192.168.201.33@tcp [12316.959806] Key type .llcrypt unregistered [12316.964320] Key type ._llcrypt unregistered [12349.929690] Key type ._llcrypt registered [12349.933323] Key type .llcrypt registered [12350.505611] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12350.517634] alg: No test for adler32 (adler32-zlib) [12351.563547] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [12351.803189] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [12353.471232] Key type lgssc registered [12354.747161] Lustre: Echo OBD driver; http://www.lustre.org/ [12444.725353] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12452.321346] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12480.498149] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12524.938281] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12527.185748] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 22:44:44 (1786761884) [12566.467980] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12573.052797] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12596.646155] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12601.619495] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [12605.754194] Lustre: Unmounted lustre-client [12634.810237] Key type lgssc unregistered [12635.071749] LNet: 256725:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12635.076821] LNetError: 256725:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12635.088599] LNet: Removed LNI 192.168.201.33@tcp [12635.803894] Key type .llcrypt unregistered [12635.805975] Key type ._llcrypt unregistered [12652.979407] Key type ._llcrypt registered [12652.981649] Key type .llcrypt registered [12654.329682] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12656.680622] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 22:46:54 (1786762014) [12666.292465] Key type .llcrypt unregistered [12666.296993] Key type ._llcrypt unregistered [12676.986275] Key type ._llcrypt registered [12676.997757] Key type .llcrypt registered [12677.597185] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12677.607370] alg: No test for adler32 (adler32-zlib) [12678.780834] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [12679.048625] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [12680.743208] Key type lgssc registered [12682.066180] Lustre: Echo OBD driver; http://www.lustre.org/ [12740.190450] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12759.883509] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [12763.992200] Lustre: Unmounted lustre-client [12793.889991] Key type lgssc unregistered [12794.153878] LNet: 260189:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12794.158793] LNetError: 260189:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12794.173258] LNet: Removed LNI 192.168.201.33@tcp [12794.962723] Key type .llcrypt unregistered [12794.967687] Key type ._llcrypt unregistered [12813.392598] Key type ._llcrypt registered [12813.394813] Key type .llcrypt registered [12815.120369] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 22:49:32 (1786762172) [12818.499035] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12818.609388] alg: No test for adler32 (adler32-zlib) [12819.814716] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [12820.022207] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [12821.671286] Key type lgssc registered [12823.129881] Lustre: Echo OBD driver; http://www.lustre.org/ [12912.171703] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12952.389789] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12958.623979] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12961.307780] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [12965.046494] Lustre: Unmounted lustre-client [12995.745345] Key type lgssc unregistered [12996.063073] LNet: 263739:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12996.075480] LNetError: 263739:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12996.096524] LNet: Removed LNI 192.168.201.33@tcp [12996.694595] Key type .llcrypt unregistered [12996.696348] Key type ._llcrypt unregistered [13015.939819] Key type ._llcrypt registered [13015.942601] Key type .llcrypt registered [13017.374128] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 22:52:55 (1786762375) [13020.019897] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13020.155041] alg: No test for adler32 (adler32-zlib) [13021.233654] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [13021.579453] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [13023.431819] Key type lgssc registered [13024.916632] Lustre: Echo OBD driver; http://www.lustre.org/ [13085.586959] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13091.566729] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13116.528448] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13118.680406] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [13124.090371] Lustre: lustre-MDT0000-mdc-ffff8d54505fb000: Connection to lustre-MDT0000 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [13130.279805] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13130.306535] LustreError: 266901:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13130.689928] LustreError: MGC192.168.201.133@tcp: Connection to MGS (at 192.168.201.133@tcp) was lost; in progress operations using this service will fail [13130.782766] Lustre: Unmounted lustre-client [13153.715630] Key type lgssc unregistered [13154.044340] LNet: 267317:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13154.051456] LNetError: 267317:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13155.144603] LNet: Removed LNI 192.168.201.33@tcp [13156.095484] Key type .llcrypt unregistered [13156.100241] Key type ._llcrypt unregistered [13175.376655] Key type ._llcrypt registered [13175.378511] Key type .llcrypt registered [13176.778317] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 22:55:34 (1786762534) [13179.408951] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13179.561740] alg: No test for adler32 (adler32-zlib) [13180.785604] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [13181.212780] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [13182.920071] Key type lgssc registered [13184.309292] Lustre: Echo OBD driver; http://www.lustre.org/ [13243.669844] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13250.597286] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13275.884700] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13277.660325] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [13282.796780] Lustre: lustre-MDT0001-mdc-ffff8d545128e800: Connection to lustre-MDT0001 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [13286.344532] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13288.429845] Lustre: Unmounted lustre-client [13311.547303] Key type lgssc unregistered [13311.824822] LNet: 270904:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13311.831367] LNetError: 270904:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13311.845173] LNet: Removed LNI 192.168.201.33@tcp [13312.480093] Key type .llcrypt unregistered [13312.481984] Key type ._llcrypt unregistered [13332.672391] Key type ._llcrypt registered [13332.674773] Key type .llcrypt registered [13333.762180] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 22:58:12 (1786762692) [13355.395163] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13355.438984] alg: No test for adler32 (adler32-zlib) [13356.484674] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [13356.788076] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [13358.455202] Key type lgssc registered [13359.635907] Lustre: Echo OBD driver; http://www.lustre.org/ [13477.712832] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13480.313375] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [13526.510182] Lustre: lustre-MDT0001-mdc-ffff8d5450454000: Connection to lustre-MDT0001 (at 192.168.201.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [13536.561916] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13546.925873] Lustre: Unmounted lustre-client [13575.846737] Key type lgssc unregistered [13576.097204] LNet: 276705:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13576.101776] LNetError: 276705:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13577.135073] LNet: Removed LNI 192.168.201.33@tcp [13577.939193] Key type .llcrypt unregistered [13577.960359] Key type ._llcrypt unregistered [13597.489682] Key type ._llcrypt registered [13597.492879] Key type .llcrypt registered [13598.507158] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 23:02:36 (1786762956) [13600.244453] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13601.944799] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 23:02:40 (1786762960) [13603.783379] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13605.774142] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 23:02:43 (1786762963) [13607.445899] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13608.988297] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 23:02:47 (1786762967) [13610.720617] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13612.552258] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 23:02:50 (1786762970) [13613.904851] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13615.425299] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 23:02:53 (1786762973) [13625.371602] Key type .llcrypt unregistered [13625.373705] Key type ._llcrypt unregistered [13633.282467] Key type ._llcrypt registered [13633.331579] Key type .llcrypt registered [13633.855465] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13633.875344] alg: No test for adler32 (adler32-zlib) [13635.182403] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [13635.711824] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [13637.503460] Key type lgssc registered [13639.165346] Lustre: Echo OBD driver; http://www.lustre.org/ [13720.284425] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13726.305428] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13748.742945] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13750.924247] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [13754.122303] Lustre: Unmounted lustre-client [13796.977583] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 23:05:54 (1786763154) [13840.835725] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13847.096245] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13882.654684] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13883.298685] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [13886.214478] Lustre: Unmounted lustre-client [13929.527441] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 23:08:07 (1786763287) [13937.823571] LNet: 1 local NIs in recovery (showing 1): 192.168.201.33@tcp [14580.546453] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14588.024575] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14623.200941] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14736.649717] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 23:21:34 (1786764094) [14752.322765] Key type lgssc unregistered [14752.614320] LNet: 290243:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14752.622704] LNetError: 290243:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14752.650810] LNet: Removed LNI 192.168.201.33@tcp [14753.753789] Key type .llcrypt unregistered [14753.756796] Key type ._llcrypt unregistered [14875.200515] Key type ._llcrypt registered [14875.203397] Key type .llcrypt registered [14875.669806] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14875.694290] alg: No test for adler32 (adler32-zlib) [14876.789481] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [14877.183976] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [14879.023526] Key type lgssc registered [14880.558265] Lustre: Echo OBD driver; http://www.lustre.org/ [14971.424455] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14977.189682] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15004.958738] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15041.147965] Key type lgssc unregistered [15041.366901] LNet: 293940:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15041.375169] LNetError: 293940:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15041.421348] LNet: Removed LNI 192.168.201.33@tcp [15042.021903] Key type .llcrypt unregistered [15042.024243] Key type ._llcrypt unregistered [15081.068663] Key type ._llcrypt registered [15081.072766] Key type .llcrypt registered [15082.185976] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 23:27:20 (1786764440) [15101.880917] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15101.896886] alg: No test for adler32 (adler32-zlib) [15102.883527] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [15103.134354] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [15104.831981] Key type lgssc registered [15106.020454] Lustre: Echo OBD driver; http://www.lustre.org/ [15152.125871] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 23:28:30 (1786764510) [15163.922468] Key type lgssc unregistered [15164.195131] LNet: 297497:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15164.211253] LNetError: 297497:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15164.227074] LNet: Removed LNI 192.168.201.33@tcp [15164.784946] Key type .llcrypt unregistered [15164.787162] Key type ._llcrypt unregistered [15178.477953] Key type ._llcrypt registered [15178.480193] Key type .llcrypt registered [15179.146285] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15179.168288] alg: No test for adler32 (adler32-zlib) [15180.143545] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [15180.506575] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [15182.255569] Key type lgssc registered [15183.734539] Lustre: Echo OBD driver; http://www.lustre.org/ [15244.281923] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15250.891451] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15273.294063] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15572.430124] LNet: Added LNI 192.168.201.33@tcp50 [8/256/0/180] [15574.720548] LNet: Removed LNI 192.168.201.33@tcp [15576.817533] Lustre: 301894:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8d545087b000: config has no valid NIDs, force dynamic NIDs [15578.044370] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [15578.238482] Lustre: Unmounted lustre-client [15580.909223] Key type lgssc unregistered [15581.410748] LNet: 302157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15581.415660] LNetError: 302157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15581.429326] LNet: Removed LNI 192.168.201.33@tcp50 [15581.954627] Key type .llcrypt unregistered [15581.956477] Key type ._llcrypt unregistered [15603.188247] Key type ._llcrypt registered [15603.203091] Key type .llcrypt registered [15603.769269] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15603.846098] alg: No test for adler32 (adler32-zlib) [15605.034216] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [15605.340854] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [15607.007191] Key type lgssc registered [15609.302789] Lustre: Echo OBD driver; http://www.lustre.org/ [15672.245486] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15679.015819] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15687.996613] LNet: Added LNI 192.168.201.33@tcp50 [8/256/0/180] [15688.856043] LNet: Removed LNI 192.168.201.33@tcp [15690.137989] Lustre: 304847:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8d5451289000: config has no valid NIDs, force dynamic NIDs [15691.318901] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [15691.889791] Lustre: Unmounted lustre-client [15728.206387] Key type lgssc unregistered [15728.652851] LNet: 305719:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15728.658636] LNetError: 305719:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15728.673395] LNet: Removed LNI 192.168.201.33@tcp50 [15729.493930] Key type .llcrypt unregistered [15729.510647] Key type ._llcrypt unregistered [15742.333335] Key type ._llcrypt registered [15742.335467] Key type .llcrypt registered [15744.394278] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 23:38:21 (1786765101) [15763.794845] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15763.902750] alg: No test for adler32 (adler32-zlib) [15765.139169] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [15765.521202] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [15767.248705] Key type lgssc registered [15768.709876] Lustre: Echo OBD driver; http://www.lustre.org/ [15852.032518] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15858.683770] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15886.270864] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15919.988922] Key type lgssc unregistered [15920.191993] LNet: 310469:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15920.196806] LNetError: 310469:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15920.207369] LNet: Removed LNI 192.168.201.33@tcp [15920.822623] Key type .llcrypt unregistered [15920.825248] Key type ._llcrypt unregistered [15932.944780] Key type ._llcrypt registered [15932.948901] Key type .llcrypt registered [15934.153703] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 23:41:32 (1786765292) [15936.543757] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15936.563896] alg: No test for adler32 (adler32-zlib) [15937.682630] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [15937.919413] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [15939.623164] Key type lgssc registered [15940.808976] Lustre: Echo OBD driver; http://www.lustre.org/ [15993.714262] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16000.432358] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16021.515889] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16024.344749] Lustre: Mounted lustre-client - version 2.17.57_2_g67a826c [16087.923656] Lustre: Mounted fs15246-client - version 2.17.57_2_g67a826c [16105.107158] Lustre: Unmounted fs15246-client [16134.889265] Lustre: Unmounted lustre-client [16162.027462] Key type lgssc unregistered [16162.351644] LNet: 315331:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16162.360945] LNetError: 315331:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16162.388463] LNet: Removed LNI 192.168.201.33@tcp [16163.008179] Key type .llcrypt unregistered [16163.009931] Key type ._llcrypt unregistered [16173.202585] Key type ._llcrypt registered [16173.204284] Key type .llcrypt registered [16174.653491] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 23:45:32 (1786765532) [16176.518823] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16176.528778] alg: No test for adler32 (adler32-zlib) [16177.817691] Lustre: Lustre: Build Version: 2.17.57_2_g67a826c [16178.135810] LNet: Added LNI 192.168.201.33@tcp [8/256/0/180] [16179.824130] Key type lgssc registered [16181.152366] Lustre: Echo OBD driver; http://www.lustre.org/ [16328.367878] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16335.568601] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16360.504319] Lustre: DEBUG MARKER: oleg133-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16461.515345] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16144 sec ========= 23:50:19 (1786765819) [16463.126385] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 23:50:21 (1786765821) === [16466.524941] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 23:50:24 (1786765824) === [16502.934246] Key type lgssc unregistered [16503.231026] LNet: 324598:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16503.238992] LNetError: 324598:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16503.258716] LNet: Removed LNI 192.168.201.33@tcp [16504.442743] Key type .llcrypt unregistered [16504.444866] Key type ._llcrypt unregistered