[ 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-8.fc42 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 476654226 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 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 0x00000000BFFE2421 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE22BD 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 00227D (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2331 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE23C1 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE23F9 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe22bd-0xbffe2330] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22bc] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2331-0xbffe23c0] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe23c1-0xbffe23f8] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe23f9-0xbffe2420] [ 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.001016] APIC: Switch to symmetric I/O mode setup [ 0.003255] x2apic enabled [ 0.004012] Switched APIC routing to physical x2apic. [ 0.005017] kvm-guest: setup PV IPIs [ 0.007759] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.008029] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.009018] pid_max: default: 32768 minimum: 301 [ 0.011135] LSM: Security Framework initializing [ 0.012064] Yama: becoming mindful. [ 0.013049] SELinux: Initializing. [ 0.014083] *** VALIDATE selinux *** [ 0.022629] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027291] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028164] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029128] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030135] *** VALIDATE tmpfs *** [ 0.031507] *** VALIDATE proc *** [ 0.032277] *** VALIDATE cgroup *** [ 0.033013] *** VALIDATE cgroup2 *** [ 0.034307] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035181] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036015] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037041] Spectre V2 : User space: Vulnerable [ 0.038010] Speculative Store Bypass: Vulnerable [ 0.041791] debug: unmapping init [mem 0xffffffff9e059000-0xffffffff9e060fff] [ 0.044158] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045675] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046031] ... version: 2 [ 0.047016] ... bit width: 48 [ 0.048015] ... generic registers: 4 [ 0.049023] ... value mask: 0000ffffffffffff [ 0.050012] ... max period: 00007fffffffffff [ 0.051012] ... fixed-purpose events: 3 [ 0.051831] ... event mask: 000000070000000f [ 0.052350] rcu: Hierarchical SRCU implementation. [ 0.054507] smp: Bringing up secondary CPUs ... [ 0.055547] x86: Booting SMP configuration: [ 0.056035] .... node #0, CPUs: #1 #2 #3 [ 0.062411] smp: Brought up 1 node, 4 CPUs [ 0.063920] smpboot: Max logical packages: 1 [ 0.064021] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.239894] node 0 deferred pages initialised in 173ms [ 0.242012] devtmpfs: initialized [ 0.243289] x86/mm: Memory block size: 128MB [ 0.245873] gcov: version magic: 0x41383552 [ 0.247309] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.248098] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.249279] pinctrl core: initialized pinctrl subsystem [ 0.250224] [ 0.250630] ************************************************************* [ 0.251020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.252018] ** ** [ 0.253019] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.254019] ** ** [ 0.255031] ** This means that this kernel is built to expose internal ** [ 0.256021] ** IOMMU data structures, which may compromise security on ** [ 0.257020] ** your system. ** [ 0.258018] ** ** [ 0.259021] ** If you see this message and you are not debugging the ** [ 0.260019] ** kernel, report this immediately to your vendor! ** [ 0.261021] ** ** [ 0.262023] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.263021] ************************************************************* [ 0.264845] NET: Registered protocol family 16 [ 0.265511] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.266096] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.267074] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.268450] cpuidle: using governor menu [ 0.272405] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.275589] PCI: Using configuration type 1 for base access [ 0.278168] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.288062] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.289034] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.291057] cryptd: max_cpu_qlen set to 1000 [ 0.293170] ACPI: Added _OSI(Module Device) [ 0.294018] ACPI: Added _OSI(Processor Device) [ 0.295019] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.296021] ACPI: Added _OSI(Processor Aggregator Device) [ 0.300681] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.303584] ACPI: Interpreter enabled [ 0.304075] ACPI: PM: (supports S0 S3 S4 S5) [ 0.305017] ACPI: Using IOAPIC for interrupt routing [ 0.306122] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.307461] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.316662] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.317051] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.318029] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.319085] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.321352] acpiphp: Slot [2] registered [ 0.322179] acpiphp: Slot [5] registered [ 0.323144] acpiphp: Slot [6] registered [ 0.324170] acpiphp: Slot [3] registered [ 0.325102] acpiphp: Slot [4] registered [ 0.326082] acpiphp: Slot [7] registered [ 0.327088] acpiphp: Slot [8] registered [ 0.328143] acpiphp: Slot [9] registered [ 0.329103] acpiphp: Slot [10] registered [ 0.330085] acpiphp: Slot [11] registered [ 0.331087] acpiphp: Slot [12] registered [ 0.332102] acpiphp: Slot [13] registered [ 0.333103] acpiphp: Slot [14] registered [ 0.334103] acpiphp: Slot [15] registered [ 0.335131] acpiphp: Slot [16] registered [ 0.336101] acpiphp: Slot [17] registered [ 0.337103] acpiphp: Slot [18] registered [ 0.338257] acpiphp: Slot [19] registered [ 0.339124] acpiphp: Slot [20] registered [ 0.340109] acpiphp: Slot [21] registered [ 0.341152] acpiphp: Slot [22] registered [ 0.342146] acpiphp: Slot [23] registered [ 0.344158] acpiphp: Slot [24] registered [ 0.346161] acpiphp: Slot [25] registered [ 0.347149] acpiphp: Slot [26] registered [ 0.349230] acpiphp: Slot [27] registered [ 0.351117] acpiphp: Slot [28] registered [ 0.352113] acpiphp: Slot [29] registered [ 0.353134] acpiphp: Slot [30] registered [ 0.355162] acpiphp: Slot [31] registered [ 0.357088] PCI host bridge to bus 0000:00 [ 0.358022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.360029] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.362029] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.365031] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.367024] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.369030] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.371235] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.374325] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.377330] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.385020] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.389058] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.391022] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.393022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.395020] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.398547] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.401870] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.404057] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.408108] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.412020] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.423021] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.428039] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.434018] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.442020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.445987] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.460023] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.471283] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.476019] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.481022] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.492022] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.500989] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.503502] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.505476] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.508396] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.509341] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.514185] iommu: Default domain type: Passthrough [ 0.515545] SCSI subsystem initialized [ 0.517200] ACPI: bus type USB registered [ 0.519165] usbcore: registered new interface driver usbfs [ 0.521102] usbcore: registered new interface driver hub [ 0.523163] usbcore: registered new device driver usb [ 0.525205] pps_core: LinuxPPS API ver. 1 registered [ 0.527017] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.530123] PTP clock support registered [ 0.532193] EDAC MC: Ver: 3.0.0 [ 0.534529] PCI: Using ACPI for IRQ routing [ 0.536806] NetLabel: Initializing [ 0.538014] NetLabel: domain hash size = 128 [ 0.539009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.540171] NetLabel: unlabeled traffic allowed by default [ 0.542164] vgaarb: loaded [ 0.543390] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.545017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.552390] clocksource: Switched to clocksource kvm-clock [ 0.660855] VFS: Disk quotas dquot_6.6.0 [ 0.663360] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.666160] *** VALIDATE ramfs *** [ 0.667634] *** VALIDATE hugetlbfs *** [ 0.669147] pnp: PnP ACPI init [ 0.671163] pnp: PnP ACPI: found 6 devices [ 0.687091] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.690451] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.692472] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.694412] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.696593] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.698735] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.701383] NET: Registered protocol family 2 [ 0.703761] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.708538] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.711782] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.716653] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.719937] TCP: Hash tables configured (established 65536 bind 65536) [ 0.722703] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.725487] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.727899] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.730711] NET: Registered protocol family 1 [ 0.733113] RPC: Registered named UNIX socket transport module. [ 0.735439] RPC: Registered udp transport module. [ 0.737252] RPC: Registered tcp transport module. [ 0.739056] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.741759] NET: Registered protocol family 44 [ 0.743585] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.745870] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.748096] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.750522] PCI: CLS 0 bytes, default 64 [ 0.752272] Unpacking initramfs... [ 2.182509] debug: unmapping init [mem 0xffff99f0bcc64000-0xffff99f0bffcffff] [ 2.187388] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.189429] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.191992] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 2.690786] Initialise system trusted keyrings [ 2.692527] Key type blacklist registered [ 2.694359] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.703504] zbud: loaded [ 2.706629] *** VALIDATE nfs *** [ 2.707875] *** VALIDATE nfs4 *** [ 2.709423] pstore: using deflate compression [ 2.712876] Platform Keyring initialized [ 2.830300] NET: Registered protocol family 38 [ 2.831931] Key type asymmetric registered [ 2.833715] Asymmetric key parser 'x509' registered [ 2.835883] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.839346] io scheduler mq-deadline registered [ 2.843630] io scheduler kyber registered [ 2.845532] io scheduler bfq registered [ 2.848371] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.851482] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.853903] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.856418] ACPI: Power Button [PWRF] [ 2.861749] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.869766] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.879717] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.909153] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.939055] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.945085] Non-volatile memory driver v1.3 [ 2.947279] Linux agpgart interface v0.103 [ 2.982829] virtio_blk virtio1: [vda] 134608 512-byte logical blocks (68.9 MB/65.7 MiB) [ 2.988643] vda: detected capacity change from 0 to 68919296 [ 3.034490] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.037952] vdb: detected capacity change from 0 to 1073741824 [ 3.045511] libphy: Fixed MDIO Bus: probed [ 3.054741] usbcore: registered new interface driver usbserial_generic [ 3.057949] usbserial: USB Serial support registered for generic [ 3.060729] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.065219] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.066752] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.069362] mousedev: PS/2 mouse device common for all mice [ 3.073764] rtc_cmos 00:05: RTC can wake from S4 [ 3.078904] rtc_cmos 00:05: registered as rtc0 [ 3.079641] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.081643] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.088059] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.088985] intel_pstate: CPU model not supported [ 3.094201] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.100404] hid: raw HID events driver (C) Jiri Kosina [ 3.102880] usbcore: registered new interface driver usbhid [ 3.104970] usbhid: USB HID core driver [ 3.106563] drop_monitor: Initializing network drop monitor service [ 3.109474] Initializing XFRM netlink socket [ 3.112136] NET: Registered protocol family 10 [ 3.116309] Segment Routing with IPv6 [ 3.118553] NET: Registered protocol family 17 [ 3.121686] mpls_gso: MPLS GSO support [ 3.128331] RAS: Correctable Errors collector initialized. [ 3.130593] AVX version of gcm_enc/dec engaged. [ 3.132487] AES CTR mode by8 optimization enabled [ 3.242355] sched_clock: Marking stable (3242322831, 0)->(4279485774, -1037162943) [ 3.245354] registered taskstats version 1 [ 3.247624] Loading compiled-in X.509 certificates [ 3.249299] zswap: loaded using pool lzo/zbud [ 3.276484] Key type big_key registered [ 3.290297] Key type encrypted registered [ 3.292450] ima: No TPM chip found, activating TPM-bypass! [ 3.295650] ima: Allocated hash algorithm: sha1 [ 3.297766] ima: No architecture policies found [ 3.301893] evm: Initialising EVM extended attributes: [ 3.304113] evm: security.selinux [ 3.305815] evm: security.ima [ 3.307086] evm: security.capability [ 3.308544] evm: HMAC attrs: 0x1 [ 3.311337] rtc_cmos 00:05: setting system clock to 2026-04-29 21:05:37 UTC (1777496737) [ 3.318229] debug: unmapping init [mem 0xffffffff9f003000-0xffffffff9f1fffff] [ 3.321758] debug: unmapping init [mem 0xffffffff9dd82000-0xffffffff9e058fff] [ 3.330121] Write protecting the kernel read-only data: 28672k [ 3.333883] debug: unmapping init [mem 0xffffffff9c403000-0xffffffff9c5fffff] [ 3.336968] debug: unmapping init [mem 0xffffffff9cd14000-0xffffffff9cdfffff] [ 3.375286] 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.382493] systemd[1]: Detected virtualization kvm. [ 3.384285] systemd[1]: Detected architecture x86-64. [ 3.386609] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.415694] systemd[1]: No hostname configured. [ 3.418930] systemd[1]: Set hostname to . [ 3.421249] random: systemd: uninitialized urandom read (16 bytes read) [ 3.423871] systemd[1]: Initializing machine ID from random generator. [ 3.465557] random: ln: uninitialized urandom read (6 bytes read) [ 3.559515] random: systemd: uninitialized urandom read (16 bytes read) [ 3.562176] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.567105] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.572954] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Swap. [ 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 ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Reached target Sockets. Starting Journal Service... Starting Apply Kernel Variables... [ 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 Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.240439] device-mapper: uevent: version 1.0.3 [ 4.242902] 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. [ 5.020660] virtio_net virtio0 ens2: renamed from eth0 [ 5.076518] scsi host0: ata_piix [ 5.103362] scsi host1: ata_piix [ 5.104669] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.106171] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.841578] dracut-initqueue[588]: RTNETLINK answers: File exists [ 9.816131] random: crng init done [ 9.817977] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.272559] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. Stopping Hardware RNG Entropy Gatherer Daemon... [ 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 System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. [ 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 ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.479985] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.749478] SELinux: Disabled at runtime. [ 11.809642] 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.820240] systemd[1]: Detected virtualization kvm. [ 11.821733] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.306840] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.310521] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.315848] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.321669] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.325271] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.332463] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.337306] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ OK ] Created slice system-getty.slice. Mounting Huge Pages File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Control Socket. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Dispatch Password Requests to Console Directory Watch. Activating swap /dev/disk/by-label/SWAP... Mounting Kernel Debug File System... Starting Apply Kernel Variables... [ 12.455905] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target Local Encrypted Volumes. Mounting POSIX Message Queue File System... [ OK ] Reached target Paths. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.826566] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.166450] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.176770] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.257614] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.269656] EDAC sbridge: Ver: 1.1.2 [ 14.450167] Key type dns_resolver registered [ 14.754982] NFS: Registering the id_resolver key type [ 14.756503] Key type id_resolver registered [ 14.757843] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. Starting Network Manager... Starting Login Service... [ OK ] Reached target sshd-keygen.target. Starting Restore /run/initramfs on shutdown... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. 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 oleg406-client login: [ 46.708466] libcfs: loading out-of-tree module taints kernel. [ 46.775433] Key type ._llcrypt registered [ 46.777104] Key type .llcrypt registered [ 47.098970] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 47.106688] alg: No test for adler32 (adler32-zlib) [ 48.159472] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 48.543941] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 50.192234] Key type lgssc registered [ 52.606263] Lustre: Echo OBD driver; http://www.lustre.org/ [ 222.229493] hrtimer: interrupt took 6988797 ns [ 235.280093] Lustre: Mounted lustre-client [ 240.616857] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 254.268348] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing check_logdir /tmp/testlogs/ [ 259.237696] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing yml_node [ 261.088830] Lustre: lustre-OST0000-osc-ffff99f11919c800: disconnect after 24s idle [ 263.322434] Lustre: DEBUG MARKER: Client: 2.17.52.93 [ 266.047970] Lustre: DEBUG MARKER: MDS: 2.17.52.93 [ 268.603493] Lustre: DEBUG MARKER: OSS: 2.17.52.93 [ 270.268315] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Apr 29 17:10:03 EDT 2026 [ 288.157071] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 290.469468] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 293.757673] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 304.084414] Lustre: Unmounted lustre-client [ 414.662292] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 418.014609] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 437.882953] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 472.935711] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 17:13:25 (1777497205) [ 475.236676] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 476.806494] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 17:13:29 (1777497209) [ 503.943226] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 507.826163] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 526.564464] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 532.526847] Lustre: Mounted lustre-client [ 536.392257] LustreError: 14424:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1117df000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 536.472716] Lustre: Unmounted lustre-client [ 562.741277] Key type lgssc unregistered [ 563.113792] LNet: 14832:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 563.128345] LNetError: 14832:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 563.165164] LNet: Removed LNI 192.168.204.6@tcp [ 564.034160] Key type .llcrypt unregistered [ 564.039661] Key type ._llcrypt unregistered [ 578.163519] Key type ._llcrypt registered [ 578.166322] Key type .llcrypt registered [ 579.609502] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 17:15:12 (1777497312) [ 581.151118] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 581.208937] alg: No test for adler32 (adler32-zlib) [ 582.532454] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 582.747548] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 584.400243] Key type lgssc registered [ 585.609137] Lustre: Echo OBD driver; http://www.lustre.org/ [ 663.957631] Lustre: Mounted lustre-client [ 750.056845] LustreError: 18140:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f107e00800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 750.094662] Lustre: Unmounted lustre-client [ 782.441817] Key type lgssc unregistered [ 782.748780] LNet: 18605:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 782.762829] LNetError: 18605:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 782.796516] LNet: Removed LNI 192.168.204.6@tcp [ 783.580462] Key type .llcrypt unregistered [ 783.583991] Key type ._llcrypt unregistered [ 795.258247] Key type ._llcrypt registered [ 795.262344] Key type .llcrypt registered [ 796.292205] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 17:18:49 (1777497529) [ 798.239150] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 798.273094] alg: No test for adler32 (adler32-zlib) [ 799.275640] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 799.467287] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 801.136552] Key type lgssc registered [ 802.143544] Lustre: Echo OBD driver; http://www.lustre.org/ [ 853.051733] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 857.173499] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 875.581449] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 878.299956] Lustre: Mounted lustre-client [ 889.091129] LustreError: 21711:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10523a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 889.182800] Lustre: Unmounted lustre-client [ 914.021362] Key type lgssc unregistered [ 914.318464] LNet: 22118:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 914.330653] LNetError: 22118:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 914.355992] LNet: Removed LNI 192.168.204.6@tcp [ 915.098638] Key type .llcrypt unregistered [ 915.104981] Key type ._llcrypt unregistered [ 925.622397] Key type ._llcrypt registered [ 925.624245] Key type .llcrypt registered [ 927.108851] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 17:20:59 (1777497659) [ 929.736881] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 929.781266] alg: No test for adler32 (adler32-zlib) [ 930.880700] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 931.136347] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 932.824446] Key type lgssc registered [ 933.977377] Lustre: Echo OBD driver; http://www.lustre.org/ [ 980.052828] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 983.866920] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1003.694897] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1006.339200] Lustre: Mounted lustre-client [ 1012.531030] LustreError: 24817:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106fbb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1012.616774] Lustre: Unmounted lustre-client [ 1040.635702] Key type lgssc unregistered [ 1040.983451] LNet: 25222:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1040.992673] LNetError: 25222:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1041.012528] LNet: Removed LNI 192.168.204.6@tcp [ 1041.739890] Key type .llcrypt unregistered [ 1041.745759] Key type ._llcrypt unregistered [ 1058.595720] Key type ._llcrypt registered [ 1058.599127] Key type .llcrypt registered [ 1059.946939] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 17:23:12 (1777497792) [ 1062.304869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1062.354433] alg: No test for adler32 (adler32-zlib) [ 1063.425340] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 1063.643581] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 1065.336166] Key type lgssc registered [ 1066.578315] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1115.573751] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1119.013567] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1137.343114] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1140.199142] Lustre: Mounted lustre-client [ 1145.337962] Lustre: lustre-MDT0000-mdc-ffff99f106579000: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1155.577415] Lustre: lustre-MDT0001-mdc-ffff99f106579000: Connection to lustre-MDT0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1171.744933] Lustre: 26180:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777497889/real 1777497889] req@00000000428c30db x1863841529993216/t0(0) o400->MGC192.168.204.106@tcp@192.168.204.106@tcp:26/25 lens 224/224 e 0 to 1 dl 1777497905 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1171.791645] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 1171.860562] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1182.212588] Lustre: Unmounted lustre-client [ 1195.411493] Key type lgssc unregistered [ 1195.669820] LNet: 28786:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1195.677531] LNetError: 28786:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1195.699545] LNet: Removed LNI 192.168.204.6@tcp [ 1196.292605] Key type .llcrypt unregistered [ 1196.297362] Key type ._llcrypt unregistered [ 1211.521449] Key type ._llcrypt registered [ 1211.524295] Key type .llcrypt registered [ 1212.908217] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 17:25:45 (1777497945) [ 1215.005873] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1215.019706] alg: No test for adler32 (adler32-zlib) [ 1216.056438] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 1216.265412] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 1217.937295] Key type lgssc registered [ 1219.211888] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1265.020499] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1268.562980] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1287.980880] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1290.731801] Lustre: Mounted lustre-client [ 1295.866921] Lustre: lustre-OST0000-osc-ffff99f106581000: Connection to lustre-OST0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1302.705757] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1313.055062] Lustre: Unmounted lustre-client [ 1347.199979] Key type lgssc unregistered [ 1347.450523] LNet: 32306:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1347.467953] LNetError: 32306:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1347.511591] LNet: Removed LNI 192.168.204.6@tcp [ 1348.185606] Key type .llcrypt unregistered [ 1348.187979] Key type ._llcrypt unregistered [ 1363.270776] Key type ._llcrypt registered [ 1363.273351] Key type .llcrypt registered [ 1364.516100] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 17:28:17 (1777498097) [ 1366.491143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1366.517012] alg: No test for adler32 (adler32-zlib) [ 1367.551454] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 1367.889599] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 1369.560296] Key type lgssc registered [ 1370.711694] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1409.523893] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1413.276299] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1428.919823] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1440.822743] Lustre: Mounted lustre-client [ 1444.242331] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1447.890128] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1459.201443] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-04-2917h29m52s [ 1461.375192] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1466.343878] Lustre: lustre-MDT0000-mdc-ffff99f10391f800: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1470.711377] LustreError: 36005:0:(lmv_obd.c:1449:lmv_statfs()) lustre-MDT0000-mdc-ffff99f10391f800: can't stat MDS #0: rc = -19 [ 1471.808739] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1477.606619] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 1477.627880] Lustre: Evicted from MGS (at 192.168.204.106@tcp) after server handle changed from 0x5aa37fb699465e32 to 0x5aa37fb6994661b9 [ 1477.641636] Lustre: MGC192.168.204.106@tcp: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 1478.701710] LustreError: lustre-MDT0000-mdc-ffff99f10391f800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1478.721068] Lustre: lustre-MDT0000-mdc-ffff99f10391f800: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 1483.711726] Lustre: DEBUG MARKER: Wait for df (36005) ... [ 1485.044525] Lustre: DEBUG MARKER: done [ 1486.957472] LustreError: 36617:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10391f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1487.021513] Lustre: Unmounted lustre-client [ 1511.145719] Key type lgssc unregistered [ 1511.346815] LNet: 37021:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1511.355652] LNetError: 37021:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1511.369373] LNet: Removed LNI 192.168.204.6@tcp [ 1511.915703] Key type .llcrypt unregistered [ 1511.920276] Key type ._llcrypt unregistered [ 1536.028919] Key type ._llcrypt registered [ 1536.031886] Key type .llcrypt registered [ 1537.225674] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 17:31:10 (1777498270) [ 1539.385340] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1539.398842] alg: No test for adler32 (adler32-zlib) [ 1540.374509] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 1540.603112] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 1542.248447] Key type lgssc registered [ 1543.238512] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1581.524630] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1584.265184] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1599.774818] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1601.339619] Lustre: Mounted lustre-client [ 1605.098869] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-04-2917h32m18s [ 1606.262517] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1611.550756] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1613.401650] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1633.760168] Lustre: 41067:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777498347/real 1777498347] req@000000003092a6fa x1863842030163200/t0(0) o101->lustre-MDT0000-mdc-ffff99f106587800@192.168.204.106@tcp:12/10 lens 576/1152 e 0 to 1 dl 1777498367 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1633.785276] Lustre: lustre-MDT0000-mdc-ffff99f106587800: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1633.811683] Lustre: lustre-MDT0000-mdc-ffff99f106587800: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 1654.763293] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1657.114851] Lustre: DEBUG MARKER: done [ 1659.876872] LustreError: 41547:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106587800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1659.939403] Lustre: Unmounted lustre-client [ 1682.064805] Key type lgssc unregistered [ 1682.280134] LNet: 41950:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1682.292424] LNetError: 41950:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1682.318819] LNet: Removed LNI 192.168.204.6@tcp [ 1682.844379] Key type .llcrypt unregistered [ 1682.846909] Key type ._llcrypt unregistered [ 1703.257793] Key type ._llcrypt registered [ 1703.259412] Key type .llcrypt registered [ 1704.210598] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 17:33:57 (1777498437) [ 1705.253666] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1706.400821] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 17:33:59 (1777498439) [ 1708.895324] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1708.906043] alg: No test for adler32 (adler32-zlib) [ 1709.889642] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 1710.054200] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 1711.672656] Key type lgssc registered [ 1712.500728] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1733.180644] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 17:34:26 (1777498466) [ 1753.919209] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1756.335543] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1768.541032] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1769.950434] Lustre: Mounted lustre-client [ 1772.683568] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1775.005971] LustreError: 46297:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10391f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1775.088862] Lustre: Unmounted lustre-client [ 1783.956076] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1820.023535] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1822.204940] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1822.568437] Lustre: Mounted lustre-client [ 1824.791263] LustreError: 47547:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f105238800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1824.854162] Lustre: Unmounted lustre-client [ 1870.980583] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1873.322630] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1873.703537] Lustre: Mounted lustre-client [ 1876.018841] LustreError: 48658:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106fb8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1876.074892] Lustre: Unmounted lustre-client [ 1892.801234] Lustre: DEBUG MARKER: files compared the same [ 1909.798723] Key type lgssc unregistered [ 1909.962588] LNet: 49365:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1909.969408] LNetError: 49365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1909.987827] LNet: Removed LNI 192.168.204.6@tcp [ 1910.416687] Key type .llcrypt unregistered [ 1910.418927] Key type ._llcrypt unregistered [ 1919.523628] Key type ._llcrypt registered [ 1919.527591] Key type .llcrypt registered [ 1920.530849] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 17:37:33 (1777498653) [ 1922.160572] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1922.169939] alg: No test for adler32 (adler32-zlib) [ 1923.144829] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 1923.312506] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 1924.968265] Key type lgssc registered [ 1925.848262] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1957.944536] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1960.197295] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1971.675973] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1974.185527] Lustre: Mounted lustre-client [ 1980.516678] LustreError: 52451:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1078cd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1980.594890] Lustre: Unmounted lustre-client [ 2000.148290] Key type lgssc unregistered [ 2000.333962] LNet: 52855:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2000.339361] LNetError: 52855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2000.349669] LNet: Removed LNI 192.168.204.6@tcp [ 2000.689810] Key type .llcrypt unregistered [ 2000.692472] Key type ._llcrypt unregistered [ 2008.760959] Key type ._llcrypt registered [ 2008.762583] Key type .llcrypt registered [ 2009.530157] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 17:39:02 (1777498742) [ 2010.952918] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2010.964446] alg: No test for adler32 (adler32-zlib) [ 2011.949619] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 2012.116505] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 2013.744171] Key type lgssc registered [ 2014.637868] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2082.095699] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2097.239220] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2099.022355] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2125.335319] Key type lgssc unregistered [ 2125.522635] LNet: 56249:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2125.526577] LNetError: 56249:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2125.540603] LNet: Removed LNI 192.168.204.6@tcp [ 2126.139484] Key type .llcrypt unregistered [ 2126.142443] Key type ._llcrypt unregistered [ 2144.068890] Key type ._llcrypt registered [ 2144.074946] Key type .llcrypt registered [ 2145.398856] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 17:41:18 (1777498878) [ 2150.578967] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2150.614045] alg: No test for adler32 (adler32-zlib) [ 2151.616048] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 2151.823729] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 2153.544445] Key type lgssc registered [ 2155.102245] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2250.517436] Lustre: Mounted lustre-client [ 2257.711205] LustreError: 58745:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f103769800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2257.792772] Lustre: Unmounted lustre-client [ 2294.195774] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 17:43:47 (1777499027) [ 2409.837161] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2426.676801] Lustre: Mounted lustre-client [ 2433.768275] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2433.772995] LustreError: 62703:0:(file.c:252:ll_close_inode_openhandle()) lustre-clilmv-ffff99f1118fa800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2433.794638] Lustre: 57236:0:(llite_lib.c:4154:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.106@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2444.153843] Lustre: Unmounted lustre-client [ 2489.533899] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 17:47:02 (1777499222) [ 2501.432817] Key type lgssc unregistered [ 2501.698925] LNet: 63917:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2501.706068] LNetError: 63917:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2501.726781] LNet: Removed LNI 192.168.204.6@tcp [ 2502.521726] Key type .llcrypt unregistered [ 2502.531857] Key type ._llcrypt unregistered [ 2515.917230] Key type ._llcrypt registered [ 2515.921866] Key type .llcrypt registered [ 2516.290865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2516.303960] alg: No test for adler32 (adler32-zlib) [ 2517.368137] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 2517.652148] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 2519.307426] Key type lgssc registered [ 2520.617394] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2572.306167] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2576.099675] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2595.912743] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2597.499420] Lustre: Mounted lustre-client [ 2601.833818] LustreError: 66440:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10391c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2601.978921] Lustre: Unmounted lustre-client [ 2629.905719] Key type lgssc unregistered [ 2630.217834] LNet: 66844:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2630.223805] LNetError: 66844:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2630.251586] LNet: Removed LNI 192.168.204.6@tcp [ 2630.861330] Key type .llcrypt unregistered [ 2630.873054] Key type ._llcrypt unregistered [ 2642.757897] Key type ._llcrypt registered [ 2642.775321] Key type .llcrypt registered [ 2643.264341] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2643.294185] alg: No test for adler32 (adler32-zlib) [ 2644.457174] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 2644.757619] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 2646.472196] Key type lgssc registered [ 2647.764459] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2748.218934] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2751.304171] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2768.399981] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2774.079834] Lustre: Mounted lustre-client [ 2776.607222] LustreError: 69789:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f108002800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2776.754312] Lustre: Unmounted lustre-client [ 2802.592813] Key type lgssc unregistered [ 2802.817665] LNet: 70190:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2802.827273] LNetError: 70190:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2802.845869] LNet: Removed LNI 192.168.204.6@tcp [ 2803.439514] Key type .llcrypt unregistered [ 2803.445924] Key type ._llcrypt unregistered [ 2817.211549] Key type ._llcrypt registered [ 2817.213680] Key type .llcrypt registered [ 2818.397690] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 17:52:31 (1777499551) [ 2820.292635] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2820.333657] alg: No test for adler32 (adler32-zlib) [ 2821.348041] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 2821.591332] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 2823.272191] Key type lgssc registered [ 2824.292250] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2865.996116] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2869.418962] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2885.104866] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2891.816174] Lustre: Mounted lustre-client [ 2895.803401] LustreError: 73310:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f108002000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2895.867175] Lustre: Unmounted lustre-client [ 2896.170702] Lustre: Mounted lustre-client [ 2898.194558] LustreError: 73382:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f104a11800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2898.267585] Lustre: Unmounted lustre-client [ 2923.177579] Key type lgssc unregistered [ 2923.452622] LNet: 73786:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2923.462823] LNetError: 73786:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2923.484563] LNet: Removed LNI 192.168.204.6@tcp [ 2924.021123] Key type .llcrypt unregistered [ 2924.023072] Key type ._llcrypt unregistered [ 2934.680421] Key type ._llcrypt registered [ 2934.682910] Key type .llcrypt registered [ 2935.136664] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2935.150876] alg: No test for adler32 (adler32-zlib) [ 2936.238931] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 2936.468703] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 2938.169179] Key type lgssc registered [ 2939.384521] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2982.740267] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2986.088234] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3002.724661] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3008.556927] Lustre: Mounted lustre-client [ 3012.581449] LustreError: 76326:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f113159000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3012.669757] Lustre: Unmounted lustre-client [ 3037.229285] Key type lgssc unregistered [ 3037.451755] LNet: 76729:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3037.457552] LNetError: 76729:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3037.471359] LNet: Removed LNI 192.168.204.6@tcp [ 3037.962302] Key type .llcrypt unregistered [ 3037.965771] Key type ._llcrypt unregistered [ 3048.940732] Key type ._llcrypt registered [ 3048.944253] Key type .llcrypt registered [ 3049.899996] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 17:56:23 (1777499783) [ 3051.736233] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3051.757878] alg: No test for adler32 (adler32-zlib) [ 3052.803187] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 3052.991203] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 3054.624242] Key type lgssc registered [ 3055.516296] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3091.993808] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3094.666973] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3109.695460] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3120.692661] Lustre: Mounted lustre-client [ 3131.433934] Lustre: lustre: nosquash_nids is cleared [ 3131.464627] Lustre: lustre: root_squash is set to 500:500 [ 3140.642300] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.6@tcp 192.168.0.[2,10]@tcp [ 3150.177799] Lustre: lustre: nosquash_nids set to 192.168.204.6/24@tcp [ 3154.262552] LustreError: 80182:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106591000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3154.311722] Lustre: Unmounted lustre-client [ 3186.278658] Key type lgssc unregistered [ 3186.494177] LNet: 80586:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3186.505227] LNetError: 80586:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3186.517725] LNet: Removed LNI 192.168.204.6@tcp [ 3186.976939] Key type .llcrypt unregistered [ 3186.979331] Key type ._llcrypt unregistered [ 3198.208859] Key type ._llcrypt registered [ 3198.211977] Key type .llcrypt registered [ 3199.204497] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 17:58:52 (1777499932) [ 3200.887803] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3202.021389] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 17:58:55 (1777499935) [ 3203.744068] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3203.752726] alg: No test for adler32 (adler32-zlib) [ 3204.692578] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 3204.851290] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 3206.480158] Key type lgssc registered [ 3207.289425] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3243.127320] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3245.953066] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3259.734224] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3261.273698] Lustre: lustre: root_squash is set to 500:500 [ 3261.293397] Lustre: lustre: nosquash_nids set to 192.168.204.6/24@tcp [ 3271.718275] Lustre: Mounted lustre-client [ 3275.998045] LustreError: 84053:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1118ff800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3276.053975] Lustre: Unmounted lustre-client [ 3298.773450] Key type lgssc unregistered [ 3299.012308] LNet: 84455:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3299.019665] LNetError: 84455:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3299.037123] LNet: Removed LNI 192.168.204.6@tcp [ 3299.473633] Key type .llcrypt unregistered [ 3299.474958] Key type ._llcrypt unregistered [ 3310.413192] Key type ._llcrypt registered [ 3310.415151] Key type .llcrypt registered [ 3311.322152] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3312.482391] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 18:00:45 (1777500045) [ 3325.243376] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3325.253241] alg: No test for adler32 (adler32-zlib) [ 3326.205495] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 3326.366864] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 3328.016167] Key type lgssc registered [ 3329.006500] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3381.554895] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3383.845194] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3397.577747] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3439.721419] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3442.022632] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3453.192432] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3461.365382] Lustre: Mounted lustre-client [ 3480.818741] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99f105155800.ost_server_uuid 50 [ 3481.688629] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99f105155800.ost_server_uuid in FULL state after 0 sec [ 3481.982292] Lustre: Mounted lustre-client [ 3483.981664] LustreError: 91349:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f107e04000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3484.037921] Lustre: Unmounted lustre-client [ 3485.090768] LustreError: 91368:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f105155800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3485.097172] LustreError: 91368:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 3485.144823] Lustre: Unmounted lustre-client [ 3519.559194] Key type lgssc unregistered [ 3519.711886] LNet: 91921:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3519.718110] LNetError: 91921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3519.727904] LNet: Removed LNI 192.168.204.6@tcp [ 3520.110934] Key type .llcrypt unregistered [ 3520.115156] Key type ._llcrypt unregistered [ 3536.307983] Key type ._llcrypt registered [ 3536.310199] Key type .llcrypt registered [ 3537.165622] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 18:04:30 (1777500270) [ 3546.883080] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3546.929086] alg: No test for adler32 (adler32-zlib) [ 3547.840650] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 3547.991955] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 3549.616420] Key type lgssc registered [ 3550.317422] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3597.025827] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3599.055281] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3610.766912] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3613.152825] Lustre: Mounted lustre-client [ 3633.638933] Lustre: lustre-OST0000-osc-ffff99f103768800: Connection to lustre-OST0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3634.251213] Lustre: lustre-OST0000-osc-ffff99f103768800: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 3634.656088] Lustre: 93282:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777500352/real 1777500352] req@000000002bfb694a x1863844135703808/t0(0) o400->lustre-OST0000-osc-ffff99f103768800@192.168.204.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1777500368 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3638.761215] Lustre: lustre-MDT0000-mdc-ffff99f103768800: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3639.776299] Lustre: 93282:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777500357/real 1777500357] req@00000000b67a1256 x1863844135704320/t0(0) o400->lustre-OST0000-osc-ffff99f103768800@192.168.204.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1777500373 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3643.872202] Lustre: 93281:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777500362/real 1777500362] req@00000000aa3b03b2 x1863844135704832/t0(0) o400->lustre-OST0000-osc-ffff99f103768800@192.168.204.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1777500378 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3654.112666] Lustre: 96362:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777500372/real 1777500372] req@000000002bfb694a x1863844135706624/t0(0) o101->MGC192.168.204.106@tcp@192.168.204.106@tcp:26/25 lens 328/344 e 0 to 1 dl 1777500388 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3654.113182] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 3654.132231] Lustre: 96362:0:(client.c:2479:ptlrpc_expire_one_request()) Skipped 1 previous similar message [ 3654.146445] Lustre: 96362:0:(mgc_request.c:1897:mgc_process_log()) MGC192.168.204.106@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 3654.154557] Lustre: Evicted from MGS (at 192.168.204.106@tcp) after server handle changed from 0x41623dd20e01498f to 0x41623dd20e014c4b [ 3654.161071] Lustre: MGC192.168.204.106@tcp: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 3655.499206] LustreError: 97079:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f103768800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3655.541729] Lustre: Unmounted lustre-client [ 3675.659934] Key type lgssc unregistered [ 3675.803730] LNet: 97481:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3675.808139] LNetError: 97481:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3675.819663] LNet: Removed LNI 192.168.204.6@tcp [ 3676.197735] Key type .llcrypt unregistered [ 3676.200222] Key type ._llcrypt unregistered [ 3684.980824] Key type ._llcrypt registered [ 3684.982166] Key type .llcrypt registered [ 3685.660909] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 18:06:59 (1777500419) [ 3698.174634] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3698.200203] alg: No test for adler32 (adler32-zlib) [ 3699.133895] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 3699.282276] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 3700.912267] Key type lgssc registered [ 3701.564720] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3722.955823] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3771.138158] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3772.883906] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3784.353469] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3786.685153] Lustre: Mounted lustre-client [ 3787.803705] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 3788.835425] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 18:08:42 (1777500522) [ 3915.017133] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3925.318655] Lustre: Unmounted lustre-client [ 3999.416510] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4001.385301] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4012.151624] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4037.799239] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 18:12:51 (1777500771) [ 4081.893278] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4083.891755] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4094.062391] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4099.589944] Lustre: Mounted lustre-client [ 4101.514562] LustreError: 115621:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f110b5e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4101.591327] Lustre: Unmounted lustre-client [ 4122.290947] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 18:14:15 (1777500855) [ 4162.648981] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4164.266366] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4173.777637] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4179.450202] Lustre: Mounted lustre-client [ 4180.865937] LustreError: 119655:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f110b62000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4180.904879] Lustre: Unmounted lustre-client [ 4199.805069] Key type lgssc unregistered [ 4199.967205] LNet: 120059:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4199.971535] LNetError: 120059:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4199.985233] LNet: Removed LNI 192.168.204.6@tcp [ 4200.321348] Key type .llcrypt unregistered [ 4200.323074] Key type ._llcrypt unregistered [ 4207.412291] Key type ._llcrypt registered [ 4207.414043] Key type .llcrypt registered [ 4208.073911] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 18:15:41 (1777500941) [ 4209.147186] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4209.166505] alg: No test for adler32 (adler32-zlib) [ 4210.068892] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 4210.170849] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 4211.784173] Key type lgssc registered [ 4212.336342] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4235.837962] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4237.677063] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4246.635045] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4254.194178] Lustre: Mounted lustre-client [ 4269.132774] LustreError: 123152:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106930800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4269.169943] Lustre: Unmounted lustre-client [ 4289.030513] Key type lgssc unregistered [ 4289.176804] LNet: 123555:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4289.183456] LNetError: 123555:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4289.195299] LNet: Removed LNI 192.168.204.6@tcp [ 4289.515371] Key type .llcrypt unregistered [ 4289.519101] Key type ._llcrypt unregistered [ 4296.331155] Key type ._llcrypt registered [ 4296.333342] Key type .llcrypt registered [ 4296.998218] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 18:17:10 (1777501030) [ 4297.938746] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4297.974707] alg: No test for adler32 (adler32-zlib) [ 4298.914143] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 4299.068500] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 4300.696167] Key type lgssc registered [ 4301.326791] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4326.915650] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4328.944512] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4339.286359] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4345.830934] Lustre: Mounted lustre-client [ 4356.070079] Lustre: lustre-OST0000-osc-ffff99f110a09800: Connection to lustre-OST0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4361.515969] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff99f110a09800.ost_server_uuid 50 [ 4362.473944] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 4372.397237] LustreError: 127089:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f110a09800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4372.446317] Lustre: Unmounted lustre-client [ 4385.250975] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 18:18:38 (1777501118) [ 4398.896552] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4400.952155] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4410.359201] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4422.263990] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4422.589946] Lustre: Mounted lustre-client [ 4427.751396] Lustre: lustre-OST0000-osc-ffff99f107e02800: Connection to lustre-OST0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4443.982960] LustreError: 129731:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f107e02800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4444.021453] Lustre: Unmounted lustre-client [ 4479.044466] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 18:20:12 (1777501212) [ 4492.949071] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4494.771894] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4502.689572] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4510.434687] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4510.665844] Lustre: Mounted lustre-client [ 4515.814146] Lustre: lustre-OST0000-osc-ffff99f110b63800: Connection to lustre-OST0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4528.234530] LustreError: 132475:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f110b63800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4528.241409] LustreError: 132475:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 4528.275877] Lustre: Unmounted lustre-client [ 4562.555083] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 18:21:36 (1777501296) [ 4601.125192] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4602.855066] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4612.274745] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4642.574051] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4643.991451] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4651.863412] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4672.247431] Lustre: Mounted lustre-client [ 4701.757589] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4702.537709] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4703.050697] LustreError: 139058:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106933800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4703.056620] LustreError: 139058:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 4703.101663] Lustre: Unmounted lustre-client [ 4717.317390] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 18:24:10 (1777501450) [ 4729.078817] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4730.539720] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4737.841530] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4755.767433] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4770.127845] Lustre: Mounted lustre-client [ 4798.309730] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4799.001610] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4800.998808] Lustre: lustre-OST0001-osc-ffff99f110b62800: Connection to lustre-OST0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4807.118027] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4817.404402] Lustre: Unmounted lustre-client [ 4848.401825] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 18:26:22 (1777501582) [ 4859.873048] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4861.248162] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4868.393202] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4878.843655] Lustre: Mounted lustre-client [ 4887.405087] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4890.109294] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 2 sec [ 4894.597440] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99f106591000.ost_server_uuid 50 [ 4895.203942] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99f106591000.ost_server_uuid in FULL state after 0 sec [ 4895.953416] LustreError: 146048:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106591000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4895.991172] Lustre: Unmounted lustre-client [ 4896.104730] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 4896.107383] Lustre: Skipped 3 previous similar messages [ 4896.139068] Lustre: Mounted lustre-client [ 4896.570875] LustreError: 146102:0:(sec.c:413:import_sec_validate_get()) import 000000008582c113 (NEW) with no sec [ 4945.553487] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 18:27:59 (1777501679) [ 4957.777877] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4959.240297] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4966.388574] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4972.967159] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4973.127084] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 4973.173461] Lustre: Mounted lustre-client [ 4984.230962] LustreError: 148951:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1124e1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4984.237136] LustreError: 148951:0:(lov_obd.c:792:lov_cleanup()) Skipped 2 previous similar messages [ 4984.280743] Lustre: Unmounted lustre-client [ 4984.282285] Lustre: Skipped 1 previous similar message [ 5011.891334] Key type lgssc unregistered [ 5012.021455] LNet: 149398:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5012.026184] LNetError: 149398:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5012.036497] LNet: Removed LNI 192.168.204.6@tcp [ 5012.320437] Key type .llcrypt unregistered [ 5012.321883] Key type ._llcrypt unregistered [ 5018.139887] Key type ._llcrypt registered [ 5018.140951] Key type .llcrypt registered [ 5018.711092] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 18:29:12 (1777501752) [ 5019.162270] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5019.176655] alg: No test for adler32 (adler32-zlib) [ 5020.055187] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5020.145203] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5021.744156] Key type lgssc registered [ 5022.226438] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5043.736833] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5045.106225] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5052.504232] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5060.279486] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5060.469884] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5061.531641] Lustre: Mounted lustre-client [ 5068.273907] LustreError: lustre-MDT0001-mdc-ffff99f1044f1000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5068.286134] Lustre: lustre-MDT0001-mdc-ffff99f1044f1000: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 5069.765284] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5070.489453] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5082.097692] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5089.030443] LustreError: 153624:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1044f1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5089.061309] Lustre: Unmounted lustre-client [ 5099.630843] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 18:30:33 (1777501833) [ 5136.311650] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5137.710686] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5145.761869] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5145.992236] Lustre: Mounted lustre-client [ 5157.130103] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5157.720466] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5168.613793] Lustre: lustre-OST0001-osc-ffff99f121bf7000: Connection to lustre-OST0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5174.929823] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5185.210150] Lustre: Unmounted lustre-client [ 5217.818581] Key type lgssc unregistered [ 5217.945549] LNet: 158745:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5217.949893] LNetError: 158745:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5217.960643] LNet: Removed LNI 192.168.204.6@tcp [ 5218.264970] Key type .llcrypt unregistered [ 5218.267992] Key type ._llcrypt unregistered [ 5230.319583] Key type ._llcrypt registered [ 5230.321436] Key type .llcrypt registered [ 5230.845197] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 18:32:44 (1777501964) [ 5231.647074] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5231.683749] alg: No test for adler32 (adler32-zlib) [ 5232.572236] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5232.664150] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5234.256156] Key type lgssc registered [ 5234.673955] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5252.808116] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5254.089620] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5260.261195] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5266.906308] Lustre: Mounted lustre-client [ 5303.626391] LustreError: 162004:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10741f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5303.660148] Lustre: Unmounted lustre-client [ 5319.491910] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5319.634654] Lustre: Mounted lustre-client [ 5351.745467] LustreError: 162649:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f111823800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5351.779176] Lustre: Unmounted lustre-client [ 5368.861713] Key type lgssc unregistered [ 5368.984397] LNet: 163055:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5368.987371] LNetError: 163055:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5368.995700] LNet: Removed LNI 192.168.204.6@tcp [ 5369.236921] Key type .llcrypt unregistered [ 5369.238083] Key type ._llcrypt unregistered [ 5374.215296] Key type ._llcrypt registered [ 5374.216258] Key type .llcrypt registered [ 5374.683582] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 18:35:08 (1777502108) [ 5375.398181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5375.439143] alg: No test for adler32 (adler32-zlib) [ 5376.287648] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5376.373367] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5377.952156] Key type lgssc registered [ 5378.333581] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5396.229687] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5397.378714] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5403.508677] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5418.991483] Lustre: Mounted lustre-client [ 5425.599822] LustreError: 166301:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f104a12000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5425.626375] Lustre: Unmounted lustre-client [ 5442.748247] Key type lgssc unregistered [ 5442.871866] LNet: 166704:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5442.877570] LNetError: 166704:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5442.888626] LNet: Removed LNI 192.168.204.6@tcp [ 5443.132332] Key type .llcrypt unregistered [ 5443.133855] Key type ._llcrypt unregistered [ 5447.312200] Key type ._llcrypt registered [ 5447.313389] Key type .llcrypt registered [ 5447.537760] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5447.544186] alg: No test for adler32 (adler32-zlib) [ 5448.419393] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5448.507685] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5450.096132] Key type lgssc registered [ 5450.482334] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5467.607237] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5468.795233] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5474.737196] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5485.038828] Lustre: Mounted lustre-client [ 5487.800123] LustreError: 169264:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f107e05000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5487.829674] Lustre: Unmounted lustre-client [ 5496.938043] Key type lgssc unregistered [ 5497.060653] LNet: 169665:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5497.063677] LNetError: 169665:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5497.070748] LNet: Removed LNI 192.168.204.6@tcp [ 5497.326158] Key type .llcrypt unregistered [ 5497.327559] Key type ._llcrypt unregistered [ 5502.654541] Key type ._llcrypt registered [ 5502.656411] Key type .llcrypt registered [ 5503.162850] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 18:37:16 (1777502236) [ 5503.895090] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5503.913500] alg: No test for adler32 (adler32-zlib) [ 5504.776322] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5504.859165] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5506.440127] Key type lgssc registered [ 5506.833605] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5523.644324] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5524.851649] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5530.880100] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5537.243799] Lustre: Mounted lustre-client [ 5543.794135] LustreError: 172912:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f11330c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5543.825847] Lustre: Unmounted lustre-client [ 5561.032366] Key type lgssc unregistered [ 5561.155582] LNet: 173315:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5561.158621] LNetError: 173315:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5561.170571] LNet: Removed LNI 192.168.204.6@tcp [ 5561.396408] Key type .llcrypt unregistered [ 5561.397634] Key type ._llcrypt unregistered [ 5565.430335] Key type ._llcrypt registered [ 5565.431840] Key type .llcrypt registered [ 5565.643749] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5565.649646] alg: No test for adler32 (adler32-zlib) [ 5566.511420] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5566.605840] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5568.200231] Key type lgssc registered [ 5568.625818] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5585.806026] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5586.913720] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5592.981452] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5608.435384] Lustre: Mounted lustre-client [ 5611.457980] LustreError: 175877:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f105155000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5611.491389] Lustre: Unmounted lustre-client [ 5628.909537] Key type lgssc unregistered [ 5629.040630] LNet: 176280:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5629.044164] LNetError: 176280:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5629.051667] LNet: Removed LNI 192.168.204.6@tcp [ 5629.316024] Key type .llcrypt unregistered [ 5629.317636] Key type ._llcrypt unregistered [ 5635.120252] Key type ._llcrypt registered [ 5635.121387] Key type .llcrypt registered [ 5635.633632] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 18:39:29 (1777502369) [ 5643.272283] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5643.280755] alg: No test for adler32 (adler32-zlib) [ 5644.155489] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5644.242425] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5645.832116] Key type lgssc registered [ 5646.207198] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5674.559778] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5675.832971] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5683.632429] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5705.592370] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 18:40:39 (1777502439) [ 5715.650272] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5716.874462] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5723.221205] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5733.874985] Lustre: Mounted lustre-client [ 5735.858114] LustreError: 182771:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f105155000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5735.892184] Lustre: Unmounted lustre-client [ 5761.628647] Key type lgssc unregistered [ 5761.748500] LNet: 183175:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5761.750930] LNetError: 183175:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5761.759842] LNet: Removed LNI 192.168.204.6@tcp [ 5762.008199] Key type .llcrypt unregistered [ 5762.009860] Key type ._llcrypt unregistered [ 5767.043385] Key type ._llcrypt registered [ 5767.044463] Key type .llcrypt registered [ 5767.561361] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 5768.134929] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 18:41:41 (1777502501) [ 5773.941871] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5773.969684] alg: No test for adler32 (adler32-zlib) [ 5774.813720] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 5774.899983] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 5776.472148] Key type lgssc registered [ 5776.832623] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5809.991283] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5811.215713] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5818.931757] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 5825.105399] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 5826.282177] Lustre: Mounted lustre-client [ 5832.159063] LustreError: 188692:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1043b0800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 5832.189541] Lustre: Unmounted lustre-client [ 5894.049329] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5895.202435] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5902.122929] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5924.880969] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 18:44:18 (1777502658) [ 5925.362858] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 5925.874760] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 18:44:19 (1777502659) [ 5942.322695] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5943.481633] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5969.842318] Key type lgssc unregistered [ 5969.956412] LNet: 194854:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5969.958519] LNetError: 194854:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5969.970753] LNet: Removed LNI 192.168.204.6@tcp [ 5970.175452] Key type .llcrypt unregistered [ 5970.176391] Key type ._llcrypt unregistered [ 5975.175918] Key type ._llcrypt registered [ 5975.177038] Key type .llcrypt registered [ 5975.600971] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 18:45:09 (1777502709) [ 6009.319648] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6009.377190] alg: No test for adler32 (adler32-zlib) [ 6010.243795] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6010.328733] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6011.920138] Key type lgssc registered [ 6012.307315] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6026.676513] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6027.956562] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6047.021866] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6058.183217] Key type lgssc unregistered [ 6058.304276] LNet: 198483:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6058.306960] LNetError: 198483:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6058.317298] LNet: Removed LNI 192.168.204.6@tcp [ 6058.529272] Key type .llcrypt unregistered [ 6058.530275] Key type ._llcrypt unregistered [ 6063.663980] Key type ._llcrypt registered [ 6063.665248] Key type .llcrypt registered [ 6064.163936] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 18:46:37 (1777502797) [ 6065.079793] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6065.118551] alg: No test for adler32 (adler32-zlib) [ 6065.990916] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6066.067884] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6067.648143] Key type lgssc registered [ 6068.001715] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6084.633422] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6085.888988] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6094.174709] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6104.561592] Lustre: Mounted lustre-client [ 6109.666978] Lustre: lustre-MDT0000-mdc-ffff99f1083ba800: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6114.786623] Lustre: lustre-MDT0001-mdc-ffff99f1083ba800: Connection to lustre-MDT0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6130.144166] Lustre: 199472:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777502848/real 1777502848] req@00000000da676dff x1863846776094848/t0(0) o400->MGC192.168.204.106@tcp@192.168.204.106@tcp:26/25 lens 224/224 e 0 to 1 dl 1777502864 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6130.146224] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 6130.158056] Lustre: Evicted from MGS (at 192.168.204.106@tcp) after server handle changed from 0x4ebde86ac9742258 to 0x4ebde86ac9743b9c [ 6130.161738] Lustre: MGC192.168.204.106@tcp: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 6139.363993] Lustre: 201497:0:(mgc_request.c:1897:mgc_process_log()) MGC192.168.204.106@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 6147.092451] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6150.627270] LustreError: lustre-MDT0000-mdc-ffff99f1083ba800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6150.643529] Lustre: lustre-MDT0000-mdc-ffff99f1083ba800: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 6151.724380] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 4 sec [ 6152.945117] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6153.479521] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6154.064562] LustreError: 202905:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1083ba800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6154.091704] Lustre: Unmounted lustre-client [ 6171.402260] Key type lgssc unregistered [ 6171.526541] LNet: 203309:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6171.531632] LNetError: 203309:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6171.542773] LNet: Removed LNI 192.168.204.6@tcp [ 6171.796596] Key type .llcrypt unregistered [ 6171.797961] Key type ._llcrypt unregistered [ 6176.815549] Key type ._llcrypt registered [ 6176.816668] Key type .llcrypt registered [ 6177.279516] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 18:48:30 (1777502910) [ 6178.059517] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6178.067382] alg: No test for adler32 (adler32-zlib) [ 6178.929859] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6179.016188] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6180.600129] Key type lgssc registered [ 6180.974705] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6198.117099] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6199.325171] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6220.013455] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6221.232747] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6234.561536] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6240.975344] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6261.936836] Key type lgssc unregistered [ 6262.045322] LNet: 208404:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6262.047338] LNetError: 208404:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6262.054279] LNet: Removed LNI 192.168.204.6@tcp [ 6262.278369] Key type .llcrypt unregistered [ 6262.279502] Key type ._llcrypt unregistered [ 6283.345367] Key type ._llcrypt registered [ 6283.346865] Key type .llcrypt registered [ 6283.813403] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 18:50:17 (1777503017) [ 6296.386794] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6296.424589] alg: No test for adler32 (adler32-zlib) [ 6297.299093] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6297.382909] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6298.968211] Key type lgssc registered [ 6299.358893] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6329.257411] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6330.426027] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6337.574751] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6362.435865] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 18:51:36 (1777503096) [ 6364.911109] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 18:51:38 (1777503098) [ 6375.488237] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6376.644627] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6382.715589] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6393.327484] Lustre: Mounted lustre-client [ 6396.428855] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 6397.181031] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 6397.707238] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 6398.315682] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 6403.555525] Lustre: lustre-MDT0000-mdc-ffff99f110b41800: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6413.794386] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 6413.800922] Lustre: Evicted from MGS (at 192.168.204.106@tcp) after server handle changed from 0x455cd0de4c5eb5c9 to 0x455cd0de4c5eb83f [ 6413.805872] Lustre: MGC192.168.204.106@tcp: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 6417.476324] Lustre: lustre-MDT0000-mdc-ffff99f110b41800: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 6418.605628] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6419.135719] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6420.958190] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 6424.035098] Lustre: lustre-MDT0000-mdc-ffff99f110b41800: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6437.856129] Lustre: 216084:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777503156/real 1777503156] req@0000000062d5580a x1863847018248192/t0(0) o101->MGC192.168.204.106@tcp@192.168.204.106@tcp:26/25 lens 328/344 e 0 to 1 dl 1777503172 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6437.863325] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 6437.868575] Lustre: 216084:0:(mgc_request.c:1897:mgc_process_log()) MGC192.168.204.106@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 6437.874383] Lustre: Evicted from MGS (at 192.168.204.106@tcp) after server handle changed from 0x455cd0de4c5eb83f to 0x455cd0de4c5ebb33 [ 6437.877095] Lustre: MGC192.168.204.106@tcp: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 6440.002364] Lustre: lustre-MDT0000-mdc-ffff99f110b41800: Connection restored to 192.168.204.106@tcp (at 192.168.204.106@tcp) [ 6441.180477] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6441.716114] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6443.331915] LustreError: 218517:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f110b41800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6443.358152] Lustre: Unmounted lustre-client [ 6474.823491] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6475.911569] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6481.669192] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6497.269481] Lustre: Mounted lustre-client [ 6497.656299] LustreError: 220122:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f111950800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6497.687116] Lustre: Unmounted lustre-client [ 6515.117161] Key type lgssc unregistered [ 6515.229461] LNet: 220525:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6515.231855] LNetError: 220525:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6515.241962] LNet: Removed LNI 192.168.204.6@tcp [ 6515.490608] Key type .llcrypt unregistered [ 6515.492343] Key type ._llcrypt unregistered [ 6520.768320] Key type ._llcrypt registered [ 6520.770180] Key type .llcrypt registered [ 6521.229524] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 18:54:14 (1777503254) [ 6522.667936] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6522.678890] alg: No test for adler32 (adler32-zlib) [ 6523.556187] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6523.644722] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6525.232145] Key type lgssc registered [ 6525.623855] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6542.802044] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6544.157271] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6550.304510] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6565.873410] Lustre: Mounted lustre-client [ 6568.929110] LustreError: 223687:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106f01800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6568.959203] Lustre: Unmounted lustre-client [ 6599.724874] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6600.862321] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6606.622331] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6606.776489] Lustre: Mounted lustre-client [ 6612.606199] LustreError: 225274:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1075c3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6612.635996] Lustre: Unmounted lustre-client [ 6644.718658] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6645.897375] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6651.952647] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6662.647656] Lustre: Mounted lustre-client [ 6662.996783] LustreError: 226879:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1044f6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6663.029200] Lustre: Unmounted lustre-client [ 6680.427263] Key type lgssc unregistered [ 6680.540652] LNet: 227282:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6680.543371] LNetError: 227282:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6680.551446] LNet: Removed LNI 192.168.204.6@tcp [ 6680.802970] Key type .llcrypt unregistered [ 6680.804663] Key type ._llcrypt unregistered [ 6686.025947] Key type ._llcrypt registered [ 6686.027106] Key type .llcrypt registered [ 6686.481611] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 18:57:00 (1777503420) [ 6687.649629] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6687.685058] alg: No test for adler32 (adler32-zlib) [ 6688.542584] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6688.628201] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6690.216200] Key type lgssc registered [ 6690.659505] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6706.180778] Key type lgssc unregistered [ 6706.303453] LNet: 229595:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6706.305819] LNetError: 229595:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6706.317481] LNet: Removed LNI 192.168.204.6@tcp [ 6706.594667] Key type .llcrypt unregistered [ 6706.595818] Key type ._llcrypt unregistered [ 6715.393069] Key type ._llcrypt registered [ 6715.394915] Key type .llcrypt registered [ 6715.568432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6715.576954] alg: No test for adler32 (adler32-zlib) [ 6716.440508] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6716.525979] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6718.104191] Key type lgssc registered [ 6718.445649] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6745.834907] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6747.127892] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6754.553210] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6775.918995] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 6776.505309] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 18:58:30 (1777503510) [ 6786.375151] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6787.520202] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6793.543615] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6801.058901] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6806.512280] Lustre: Mounted lustre-client [ 6809.894322] LustreError: lustre-OST0001-osc-ffff99f104413800: operation ost_statfs to node 192.168.204.106@tcp failed: rc = -107 [ 6809.897888] Lustre: lustre-OST0001-osc-ffff99f104413800: Connection to lustre-OST0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6810.193529] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6820.475075] Lustre: Unmounted lustre-client [ 6843.968713] Key type lgssc unregistered [ 6844.083646] LNet: 236470:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6844.086570] LNetError: 236470:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6844.095127] LNet: Removed LNI 192.168.204.6@tcp [ 6844.336732] Key type .llcrypt unregistered [ 6844.338508] Key type ._llcrypt unregistered [ 6854.983050] Key type ._llcrypt registered [ 6854.984052] Key type .llcrypt registered [ 6855.519685] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 18:59:49 (1777503589) [ 6860.011255] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6860.041663] alg: No test for adler32 (adler32-zlib) [ 6860.904087] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 6860.984892] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 6862.568291] Key type lgssc registered [ 6863.067815] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6880.816260] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6881.986286] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6893.235342] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 19:00:26 (1777503626) [ 6902.779077] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6903.968720] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6909.660890] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6916.058694] Lustre: Mounted lustre-client [ 6924.777454] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6927.366324] Lustre: Unmounted lustre-client [ 6981.006115] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6982.190407] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7014.594784] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7023.040478] Lustre: Mounted lustre-client [ 7023.547434] LustreError: 243565:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f105157000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7023.575163] Lustre: Unmounted lustre-client [ 7041.065892] Key type lgssc unregistered [ 7041.184599] LNet: 243967:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7041.188609] LNetError: 243967:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7041.199672] LNet: Removed LNI 192.168.204.6@tcp [ 7041.472197] Key type .llcrypt unregistered [ 7041.473291] Key type ._llcrypt unregistered [ 7050.640194] Key type ._llcrypt registered [ 7050.641218] Key type .llcrypt registered [ 7050.915960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7050.921605] alg: No test for adler32 (adler32-zlib) [ 7051.784413] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7051.876464] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7053.464162] Key type lgssc registered [ 7053.866955] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7084.126176] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7085.348271] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7092.752839] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7114.151174] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 7114.743379] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 19:04:08 (1777503848) [ 7125.532737] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7126.794462] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7132.523531] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7143.948340] Lustre: Mounted lustre-client [ 7145.723277] LustreError: 249997:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f111956800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7145.763786] Lustre: Unmounted lustre-client [ 7165.531433] Key type lgssc unregistered [ 7165.713354] LNet: 250400:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7165.718748] LNetError: 250400:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7165.732555] LNet: Removed LNI 192.168.204.6@tcp [ 7166.157134] Key type .llcrypt unregistered [ 7166.158968] Key type ._llcrypt unregistered [ 7180.483043] Key type ._llcrypt registered [ 7180.484420] Key type .llcrypt registered [ 7182.129165] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 7183.613523] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 19:05:16 (1777503916) [ 7189.719434] Key type .llcrypt unregistered [ 7189.723636] Key type ._llcrypt unregistered [ 7193.953503] Key type ._llcrypt registered [ 7193.955180] Key type .llcrypt registered [ 7194.201036] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7194.219237] alg: No test for adler32 (adler32-zlib) [ 7195.128659] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7195.249388] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7196.864488] Key type lgssc registered [ 7197.408760] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7219.068018] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7229.946427] Lustre: Mounted lustre-client [ 7230.590109] LustreError: 253428:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1083be000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7230.621210] Lustre: Unmounted lustre-client [ 7249.103335] Key type lgssc unregistered [ 7249.236702] LNet: 253833:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7249.240352] LNetError: 253833:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7249.248522] LNet: Removed LNI 192.168.204.6@tcp [ 7249.524469] Key type .llcrypt unregistered [ 7249.525790] Key type ._llcrypt unregistered [ 7255.051874] Key type ._llcrypt registered [ 7255.053138] Key type .llcrypt registered [ 7255.602547] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 19:06:29 (1777503989) [ 7256.519967] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7256.531777] alg: No test for adler32 (adler32-zlib) [ 7257.401430] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7257.501269] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7259.080198] Key type lgssc registered [ 7259.492622] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7321.763107] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7337.424669] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7339.496637] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7341.837262] Lustre: Mounted lustre-client [ 7342.956400] LustreError: 256870:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f1084f4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7343.009631] Lustre: Unmounted lustre-client [ 7359.060882] Key type lgssc unregistered [ 7359.202172] LNet: 257272:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7359.209873] LNetError: 257272:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7359.226487] LNet: Removed LNI 192.168.204.6@tcp [ 7359.535616] Key type .llcrypt unregistered [ 7359.537486] Key type ._llcrypt unregistered [ 7367.942140] Key type ._llcrypt registered [ 7367.944501] Key type .llcrypt registered [ 7368.646805] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 19:08:22 (1777504102) [ 7369.884498] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7369.893325] alg: No test for adler32 (adler32-zlib) [ 7370.798083] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7370.939656] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7372.552187] Key type lgssc registered [ 7373.382148] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7400.085458] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7401.924920] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7412.748612] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7415.174554] Lustre: Mounted lustre-client [ 7420.391098] Lustre: lustre-MDT0000-mdc-ffff99f106597000: Connection to lustre-MDT0000 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7423.934191] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7423.950927] LustreError: 260334:0:(file.c:6098:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 7424.167191] LustreError: 260353:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f106597000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7424.184730] LustreError: MGC192.168.204.106@tcp: Connection to MGS (at 192.168.204.106@tcp) was lost; in progress operations using this service will fail [ 7424.217249] Lustre: Unmounted lustre-client [ 7435.623081] Key type lgssc unregistered [ 7435.767844] LNet: 260746:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7435.773120] LNetError: 260746:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7435.796055] LNet: Removed LNI 192.168.204.6@tcp [ 7436.136462] Key type .llcrypt unregistered [ 7436.140458] Key type ._llcrypt unregistered [ 7446.053395] Key type ._llcrypt registered [ 7446.055542] Key type .llcrypt registered [ 7446.940536] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 19:09:40 (1777504180) [ 7448.555533] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7448.565948] alg: No test for adler32 (adler32-zlib) [ 7449.544802] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7449.719365] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7451.328256] Key type lgssc registered [ 7452.092329] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7478.515424] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7480.558128] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7490.369466] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7496.710142] Lustre: Mounted lustre-client [ 7501.801260] Lustre: lustre-MDT0001-mdc-ffff99f104a13000: Connection to lustre-MDT0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7505.168189] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7506.203425] LustreError: 263850:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f104a13000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7506.247076] Lustre: Unmounted lustre-client [ 7519.857636] Key type lgssc unregistered [ 7520.032692] LNet: 264243:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7520.037228] LNetError: 264243:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7520.047910] LNet: Removed LNI 192.168.204.6@tcp [ 7520.384258] Key type .llcrypt unregistered [ 7520.385861] Key type ._llcrypt unregistered [ 7528.538767] Key type ._llcrypt registered [ 7528.540600] Key type .llcrypt registered [ 7529.245816] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 19:11:02 (1777504262) [ 7539.404334] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7539.417932] alg: No test for adler32 (adler32-zlib) [ 7540.373146] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7540.524896] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7542.144299] Key type lgssc registered [ 7542.834379] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7601.502281] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7603.836340] Lustre: Mounted lustre-client [ 7624.679489] Lustre: lustre-MDT0001-mdc-ffff99f107c53000: Connection to lustre-MDT0001 (at 192.168.204.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7627.439926] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7637.751630] Lustre: Unmounted lustre-client [ 7665.309126] Key type lgssc unregistered [ 7665.437111] LNet: 269984:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7665.442438] LNetError: 269984:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7665.451947] LNet: Removed LNI 192.168.204.6@tcp [ 7665.766046] Key type .llcrypt unregistered [ 7665.768166] Key type ._llcrypt unregistered [ 7672.881878] Key type ._llcrypt registered [ 7672.883613] Key type .llcrypt registered [ 7673.494107] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 19:13:27 (1777504407) [ 7674.231449] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 7674.997328] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 19:13:28 (1777504408) [ 7675.705934] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 7676.563705] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 19:13:30 (1777504410) [ 7677.337277] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 7678.229619] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 19:13:31 (1777504411) [ 7679.048812] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 7679.922363] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 19:13:33 (1777504413) [ 7680.748108] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 7681.479381] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 19:13:35 (1777504415) [ 7686.306486] Key type .llcrypt unregistered [ 7686.310308] Key type ._llcrypt unregistered [ 7689.567197] Key type ._llcrypt registered [ 7689.568989] Key type .llcrypt registered [ 7689.838249] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7689.870541] alg: No test for adler32 (adler32-zlib) [ 7690.774937] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 7690.913624] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 7692.512108] Key type lgssc registered [ 7693.202782] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7728.291148] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7730.102442] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7740.749659] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7742.081505] Lustre: Mounted lustre-client [ 7743.138252] LustreError: 275566:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f11315b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7743.196957] Lustre: Unmounted lustre-client [ 7768.915656] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 19:15:02 (1777504502) [ 7783.535829] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7785.263927] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7807.557803] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7823.364766] Lustre: Mounted lustre-client [ 7823.802778] LustreError: 277673:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10472b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7823.842200] Lustre: Unmounted lustre-client [ 7856.153091] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 19:16:29 (1777504589) [ 7864.992842] LNet: 1 local NIs in recovery (showing 1): 192.168.204.6@tcp [ 8444.515122] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8445.605235] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8464.326578] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8506.514969] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 19:27:20 (1777505240) [ 8510.105192] Key type lgssc unregistered [ 8510.213467] LNet: 283206:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8510.216336] LNetError: 283206:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8510.223672] LNet: Removed LNI 192.168.204.6@tcp [ 8510.443376] Key type .llcrypt unregistered [ 8510.444495] Key type ._llcrypt unregistered [ 8591.810697] Key type ._llcrypt registered [ 8591.812689] Key type .llcrypt registered [ 8592.113118] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8592.118628] alg: No test for adler32 (adler32-zlib) [ 8592.995648] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 8593.087454] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 8594.680138] Key type lgssc registered [ 8595.094459] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8626.323602] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8627.579777] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8634.912149] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8653.516734] Key type lgssc unregistered [ 8653.635524] LNet: 286794:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8653.638418] LNetError: 286794:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8653.650587] LNet: Removed LNI 192.168.204.6@tcp [ 8653.864333] Key type .llcrypt unregistered [ 8653.865443] Key type ._llcrypt unregistered [ 8658.550517] Key type ._llcrypt registered [ 8658.551534] Key type .llcrypt registered [ 8659.036349] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 19:29:52 (1777505392) [ 8666.000848] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8666.013492] alg: No test for adler32 (adler32-zlib) [ 8666.893387] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 8666.990525] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 8668.576151] Key type lgssc registered [ 8668.981189] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8686.216342] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 19:30:19 (1777505419) [ 8690.357142] Key type lgssc unregistered [ 8690.469451] LNet: 290334:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8690.471919] LNetError: 290334:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8690.482619] LNet: Removed LNI 192.168.204.6@tcp [ 8690.725469] Key type .llcrypt unregistered [ 8690.726621] Key type ._llcrypt unregistered [ 8694.421864] Key type ._llcrypt registered [ 8694.427852] Key type .llcrypt registered [ 8694.617195] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8694.625416] alg: No test for adler32 (adler32-zlib) [ 8695.480822] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 8695.562869] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 8697.144155] Key type lgssc registered [ 8697.511778] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8717.944508] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8719.136968] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8726.553695] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8813.438730] LNet: Added LNI 192.168.204.6@tcp50 [8/256/0/180] [ 8814.120305] LNet: Removed LNI 192.168.204.6@tcp [ 8815.466228] Lustre: 294604:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff99f121bf3000: config has no valid NIDs, force dynamic NIDs [ 8816.501517] Lustre: Mounted lustre-client [ 8816.526068] LustreError: 294613:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f121bf3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8816.553075] Lustre: Unmounted lustre-client [ 8817.459036] Key type lgssc unregistered [ 8817.592522] LNet: 294863:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8817.594827] LNetError: 294863:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8817.606269] LNet: Removed LNI 192.168.204.6@tcp50 [ 8817.797034] Key type .llcrypt unregistered [ 8817.798698] Key type ._llcrypt unregistered [ 8827.786483] Key type ._llcrypt registered [ 8827.787473] Key type .llcrypt registered [ 8827.963146] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8827.971952] alg: No test for adler32 (adler32-zlib) [ 8828.817098] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 8828.895594] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 8830.480120] Key type lgssc registered [ 8830.862624] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8858.828101] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8859.992110] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8862.651019] LNet: Added LNI 192.168.204.6@tcp50 [8/256/0/180] [ 8862.920415] LNet: Removed LNI 192.168.204.6@tcp [ 8863.981740] Lustre: 297487:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff99f104a11000: config has no valid NIDs, force dynamic NIDs [ 8865.024845] Lustre: Mounted lustre-client [ 8865.162172] LustreError: 297516:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f104a11000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8865.192214] Lustre: Unmounted lustre-client [ 8884.176380] Key type lgssc unregistered [ 8884.326744] LNet: 298356:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8884.330494] LNetError: 298356:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8884.344600] LNet: Removed LNI 192.168.204.6@tcp50 [ 8884.550395] Key type .llcrypt unregistered [ 8884.551574] Key type ._llcrypt unregistered [ 8888.271852] Key type ._llcrypt registered [ 8888.273326] Key type .llcrypt registered [ 8888.789406] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 19:33:42 (1777505622) [ 8894.781098] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8894.825110] alg: No test for adler32 (adler32-zlib) [ 8895.698639] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 8895.786077] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 8897.376173] Key type lgssc registered [ 8897.831073] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8927.346162] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8928.603670] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8936.525643] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8955.742588] Key type lgssc unregistered [ 8955.882683] LNet: 302998:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8955.885201] LNetError: 302998:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8955.893781] LNet: Removed LNI 192.168.204.6@tcp [ 8956.145559] Key type .llcrypt unregistered [ 8956.147406] Key type ._llcrypt unregistered [ 8959.771890] Key type ._llcrypt registered [ 8959.773172] Key type .llcrypt registered [ 8960.252171] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 19:34:53 (1777505693) [ 8960.922960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8960.929413] alg: No test for adler32 (adler32-zlib) [ 8961.780276] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 8961.861894] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 8963.448136] Key type lgssc registered [ 8963.860338] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8981.722739] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8982.931459] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8988.918852] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8999.407822] Lustre: Mounted lustre-client [ 9020.212102] Lustre: Mounted fs15246-client [ 9025.142761] LustreError: 307121:0:(lov_obd.c:792:lov_cleanup()) fs15246-clilov-ffff99f10758d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9025.161295] Lustre: Unmounted fs15246-client [ 9037.727855] LustreError: 307338:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff99f10472e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9037.755178] Lustre: Unmounted lustre-client [ 9055.073852] Key type lgssc unregistered [ 9055.189629] LNet: 307741:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9055.193105] LNetError: 307741:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9055.202845] LNet: Removed LNI 192.168.204.6@tcp [ 9055.431441] Key type .llcrypt unregistered [ 9055.432607] Key type ._llcrypt unregistered [ 9059.152080] Key type ._llcrypt registered [ 9059.153283] Key type .llcrypt registered [ 9059.615508] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 19:36:33 (1777505793) [ 9060.209590] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9060.215800] alg: No test for adler32 (adler32-zlib) [ 9061.057804] Lustre: Lustre: Build Version: 2.17.52_93_g6cdb58a [ 9061.133940] LNet: Added LNI 192.168.204.6@tcp [8/256/0/180] [ 9062.712114] Key type lgssc registered [ 9063.085628] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9108.713047] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9109.918565] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9117.257808] Lustre: DEBUG MARKER: oleg406-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9165.689679] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 8895 sec ========== 19:38:19 (1777505899) [ 9166.249392] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 19:38:19 (1777505899) === [ 9167.435766] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 19:38:21 (1777505901) === [ 9178.893846] Key type lgssc unregistered [ 9179.015611] LNet: 316879:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9179.018048] LNetError: 316879:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9179.026834] LNet: Removed LNI 192.168.204.6@tcp [ 9179.273830] Key type .llcrypt unregistered [ 9179.275901] Key type ._llcrypt unregistered