[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-10.fc44 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 474711620 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003339] x2apic enabled [ 0.004014] Switched APIC routing to physical x2apic. [ 0.005016] kvm-guest: setup PV IPIs [ 0.007885] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008029] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009013] pid_max: default: 32768 minimum: 301 [ 0.010147] LSM: Security Framework initializing [ 0.011071] Yama: becoming mindful. [ 0.012041] SELinux: Initializing. [ 0.013072] *** VALIDATE selinux *** [ 0.023037] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028330] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029169] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030121] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031131] *** VALIDATE tmpfs *** [ 0.033365] *** VALIDATE proc *** [ 0.035409] *** VALIDATE cgroup *** [ 0.036012] *** VALIDATE cgroup2 *** [ 0.037299] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038252] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039047] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040035] Spectre V2 : User space: Vulnerable [ 0.041011] Speculative Store Bypass: Vulnerable [ 0.044377] debug: unmapping init [mem 0xffffffff9e859000-0xffffffff9e860fff] [ 0.047203] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048594] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049032] ... version: 2 [ 0.050015] ... bit width: 48 [ 0.051016] ... generic registers: 4 [ 0.052015] ... value mask: 0000ffffffffffff [ 0.053017] ... max period: 00007fffffffffff [ 0.054015] ... fixed-purpose events: 3 [ 0.055015] ... event mask: 000000070000000f [ 0.056340] rcu: Hierarchical SRCU implementation. [ 0.058362] smp: Bringing up secondary CPUs ... [ 0.059680] x86: Booting SMP configuration: [ 0.060036] .... node #0, CPUs: #1 #2 #3 [ 0.063570] smp: Brought up 1 node, 4 CPUs [ 0.065030] smpboot: Max logical packages: 1 [ 0.066021] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.153542] node 0 deferred pages initialised in 85ms [ 0.157282] devtmpfs: initialized [ 0.158203] x86/mm: Memory block size: 128MB [ 0.160630] gcov: version magic: 0x41383552 [ 0.163172] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.164081] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.165263] pinctrl core: initialized pinctrl subsystem [ 0.166200] [ 0.166638] ************************************************************* [ 0.167014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.168012] ** ** [ 0.169014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.170017] ** ** [ 0.171013] ** This means that this kernel is built to expose internal ** [ 0.172014] ** IOMMU data structures, which may compromise security on ** [ 0.173016] ** your system. ** [ 0.174017] ** ** [ 0.175010] ** If you see this message and you are not debugging the ** [ 0.176017] ** kernel, report this immediately to your vendor! ** [ 0.177017] ** ** [ 0.178014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.179028] ************************************************************* [ 0.180725] NET: Registered protocol family 16 [ 0.181435] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.182059] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.183056] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.185039] cpuidle: using governor menu [ 0.188220] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.190477] PCI: Using configuration type 1 for base access [ 0.193133] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.203218] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.205021] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.208218] cryptd: max_cpu_qlen set to 1000 [ 0.211023] ACPI: Added _OSI(Module Device) [ 0.212047] ACPI: Added _OSI(Processor Device) [ 0.213022] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.215021] ACPI: Added _OSI(Processor Aggregator Device) [ 0.222368] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.229237] ACPI: Interpreter enabled [ 0.230067] ACPI: PM: (supports S0 S3 S4 S5) [ 0.232019] ACPI: Using IOAPIC for interrupt routing [ 0.234127] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.238516] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.251053] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.254045] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.257023] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.261090] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.267000] acpiphp: Slot [2] registered [ 0.269172] acpiphp: Slot [5] registered [ 0.271187] acpiphp: Slot [6] registered [ 0.273273] acpiphp: Slot [3] registered [ 0.275124] acpiphp: Slot [4] registered [ 0.277125] acpiphp: Slot [7] registered [ 0.278185] acpiphp: Slot [8] registered [ 0.280165] acpiphp: Slot [9] registered [ 0.282123] acpiphp: Slot [10] registered [ 0.284117] acpiphp: Slot [11] registered [ 0.286168] acpiphp: Slot [12] registered [ 0.287179] acpiphp: Slot [13] registered [ 0.289157] acpiphp: Slot [14] registered [ 0.291115] acpiphp: Slot [15] registered [ 0.292125] acpiphp: Slot [16] registered [ 0.294109] acpiphp: Slot [17] registered [ 0.295104] acpiphp: Slot [18] registered [ 0.297113] acpiphp: Slot [19] registered [ 0.299213] acpiphp: Slot [20] registered [ 0.301133] acpiphp: Slot [21] registered [ 0.302112] acpiphp: Slot [22] registered [ 0.304157] acpiphp: Slot [23] registered [ 0.306109] acpiphp: Slot [24] registered [ 0.307106] acpiphp: Slot [25] registered [ 0.309104] acpiphp: Slot [26] registered [ 0.311154] acpiphp: Slot [27] registered [ 0.312113] acpiphp: Slot [28] registered [ 0.314170] acpiphp: Slot [29] registered [ 0.316110] acpiphp: Slot [30] registered [ 0.318143] acpiphp: Slot [31] registered [ 0.319103] PCI host bridge to bus 0000:00 [ 0.321020] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.324068] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.326021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.329031] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.333036] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.336049] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.339222] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.342071] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.346426] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.354017] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.359063] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.362024] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.364025] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.367022] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.370620] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.373822] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.377044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.379834] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.382000] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.392027] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.396014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.400876] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.407980] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.411876] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.434022] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.443681] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.449013] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.454016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.464000] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.472811] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.475490] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.478472] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.481450] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.484371] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.488299] iommu: Default domain type: Passthrough [ 0.490795] SCSI subsystem initialized [ 0.492216] ACPI: bus type USB registered [ 0.494139] usbcore: registered new interface driver usbfs [ 0.496124] usbcore: registered new interface driver hub [ 0.497098] usbcore: registered new device driver usb [ 0.498214] pps_core: LinuxPPS API ver. 1 registered [ 0.499013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.501110] PTP clock support registered [ 0.503061] EDAC MC: Ver: 3.0.0 [ 0.505156] PCI: Using ACPI for IRQ routing [ 0.507652] NetLabel: Initializing [ 0.508016] NetLabel: domain hash size = 128 [ 0.510019] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.513107] NetLabel: unlabeled traffic allowed by default [ 0.516148] vgaarb: loaded [ 0.517343] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.519019] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.526000] clocksource: Switched to clocksource kvm-clock [ 0.633837] VFS: Disk quotas dquot_6.6.0 [ 0.635140] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.638113] *** VALIDATE ramfs *** [ 0.639111] *** VALIDATE hugetlbfs *** [ 0.640384] pnp: PnP ACPI init [ 0.642877] pnp: PnP ACPI: found 6 devices [ 0.666079] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.669679] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.672150] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.674351] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.677035] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.679968] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.683284] NET: Registered protocol family 2 [ 0.686160] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.691099] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.694168] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.698770] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.701571] TCP: Hash tables configured (established 65536 bind 65536) [ 0.703784] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.707555] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.711178] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.714590] NET: Registered protocol family 1 [ 0.717350] RPC: Registered named UNIX socket transport module. [ 0.720266] RPC: Registered udp transport module. [ 0.721939] RPC: Registered tcp transport module. [ 0.723995] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.726647] NET: Registered protocol family 44 [ 0.728447] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.730781] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.732919] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.734926] PCI: CLS 0 bytes, default 64 [ 0.736925] Unpacking initramfs... [ 2.151469] debug: unmapping init [mem 0xffff908cfcc64000-0xffff908cfffcffff] [ 2.155254] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.157667] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.160457] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.670135] Initialise system trusted keyrings [ 2.672228] Key type blacklist registered [ 2.674264] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.686283] zbud: loaded [ 2.689462] *** VALIDATE nfs *** [ 2.690585] *** VALIDATE nfs4 *** [ 2.692878] pstore: using deflate compression [ 2.696364] Platform Keyring initialized [ 2.806735] NET: Registered protocol family 38 [ 2.809177] Key type asymmetric registered [ 2.811157] Asymmetric key parser 'x509' registered [ 2.813447] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.820064] io scheduler mq-deadline registered [ 2.823518] io scheduler kyber registered [ 2.826274] io scheduler bfq registered [ 2.828741] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.832918] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.836937] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.840295] ACPI: Power Button [PWRF] [ 2.845684] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.853326] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.866544] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.893701] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.921192] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.927358] Non-volatile memory driver v1.3 [ 2.928838] Linux agpgart interface v0.103 [ 2.965793] virtio_blk virtio1: [vda] 146960 512-byte logical blocks (75.2 MB/71.8 MiB) [ 2.970553] vda: detected capacity change from 0 to 75243520 [ 2.985128] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.988238] vdb: detected capacity change from 0 to 1073741824 [ 2.994834] libphy: Fixed MDIO Bus: probed [ 3.004276] usbcore: registered new interface driver usbserial_generic [ 3.006981] usbserial: USB Serial support registered for generic [ 3.009797] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.014168] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.016258] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.019292] mousedev: PS/2 mouse device common for all mice [ 3.022776] rtc_cmos 00:05: RTC can wake from S4 [ 3.024349] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.029235] rtc_cmos 00:05: registered as rtc0 [ 3.029305] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.029346] intel_pstate: CPU model not supported [ 3.033640] hid: raw HID events driver (C) Jiri Kosina [ 3.043149] usbcore: registered new interface driver usbhid [ 3.044147] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.046016] usbhid: USB HID core driver [ 3.051208] drop_monitor: Initializing network drop monitor service [ 3.053491] Initializing XFRM netlink socket [ 3.055831] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.056330] NET: Registered protocol family 10 [ 3.065725] Segment Routing with IPv6 [ 3.067253] NET: Registered protocol family 17 [ 3.069504] mpls_gso: MPLS GSO support [ 3.073901] RAS: Correctable Errors collector initialized. [ 3.076160] AVX version of gcm_enc/dec engaged. [ 3.077733] AES CTR mode by8 optimization enabled [ 3.156713] sched_clock: Marking stable (3156679488, 0)->(4093524911, -936845423) [ 3.160699] registered taskstats version 1 [ 3.163413] Loading compiled-in X.509 certificates [ 3.165625] zswap: loaded using pool lzo/zbud [ 3.192767] Key type big_key registered [ 3.205019] Key type encrypted registered [ 3.206661] ima: No TPM chip found, activating TPM-bypass! [ 3.208778] ima: Allocated hash algorithm: sha1 [ 3.210492] ima: No architecture policies found [ 3.212414] evm: Initialising EVM extended attributes: [ 3.214538] evm: security.selinux [ 3.215842] evm: security.ima [ 3.217192] evm: security.capability [ 3.218556] evm: HMAC attrs: 0x1 [ 3.221090] rtc_cmos 00:05: setting system clock to 2026-08-27 22:05:44 UTC (1787868344) [ 3.227968] debug: unmapping init [mem 0xffffffff9f803000-0xffffffff9f9fffff] [ 3.230939] debug: unmapping init [mem 0xffffffff9e582000-0xffffffff9e858fff] [ 3.241091] Write protecting the kernel read-only data: 28672k [ 3.244146] debug: unmapping init [mem 0xffffffff9cc03000-0xffffffff9cdfffff] [ 3.246704] debug: unmapping init [mem 0xffffffff9d514000-0xffffffff9d5fffff] [ 3.280830] 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.289538] systemd[1]: Detected virtualization kvm. [ 3.291720] systemd[1]: Detected architecture x86-64. [ 3.294685] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.324953] systemd[1]: No hostname configured. [ 3.326810] systemd[1]: Set hostname to . [ 3.329060] random: systemd: uninitialized urandom read (16 bytes read) [ 3.331828] systemd[1]: Initializing machine ID from random generator. [ 3.381263] random: ln: uninitialized urandom read (6 bytes read) [ 3.473167] random: systemd: uninitialized urandom read (16 bytes read) [ 3.476331] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.481489] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.489206] systemd[1]: Reached target Local Encrypted Volumes. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Sockets. [ OK ] Reached target Swap. Starting Setup Virtual Console... Starting Journal Service... [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... [ OK ] Reached target Timers. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.105706] device-mapper: uevent: version 1.0.3 [ 4.108173] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.864612] virtio_net virtio0 ens2: renamed from eth0 [ 4.867811] random: fast init done [ 4.895656] scsi host0: ata_piix [ 4.904375] scsi host1: ata_piix [ 4.906172] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.908584] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.573509] dracut-initqueue[582]: RTNETLINK answers: File exists [ 9.724209] random: crng init done [ 9.725438] 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.616438] 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 Initrd Default Target. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Timers. [ 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 Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.749429] printk: systemd: 26 output lines suppressed due to ratelimiting [ 12.000776] SELinux: Disabled at runtime. [ 12.058334] 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) [ 12.068202] systemd[1]: Detected virtualization kvm. [ 12.070263] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.550335] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.553331] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.557942] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.562685] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.565937] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.575287] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.586863] systemd[1]: proc-sys-fs-binfmt_misc.automount: Refusing to start, unit to trigger not loaded. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Mounting Kernel Debug File System... Activating swap /dev/disk/by-label/SWAP... Mounting POSIX Message Queue File System... Starting Apply Kernel Variables... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ 12.752703] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-getty.slice. [ OK ] Reached target RPC Port Mapper. Starting Remount Root and Kernel File Systems... Starting Create list of required st…ce nodes for the current kernel... Mounting Huge Pages File System... [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [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 ] Mounted Huge Pages File System. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 13.077535] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.349280] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.361108] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.511865] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.520698] EDAC sbridge: Ver: 1.1.2 [ 14.682737] Key type dns_resolver registered [ 14.993138] NFS: Registering the id_resolver key type [ 14.996979] Key type id_resolver registered [ 14.998736] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. Starting Login Service... Starting Network Manager... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started irqbalance daemon. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg417-client login: [ 82.323524] libcfs: loading out-of-tree module taints kernel. [ 82.562125] Key type ._llcrypt registered [ 82.575188] Key type .llcrypt registered [ 83.057169] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 83.082339] alg: No test for adler32 (adler32-zlib) [ 84.590636] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 85.347986] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 87.095181] Key type lgssc registered [ 89.007280] Lustre: Echo OBD driver; http://www.lustre.org/ [ 201.824248] hrtimer: interrupt took 2853559 ns [ 272.962885] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 278.156914] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 294.202111] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing check_logdir /tmp/testlogs/ [ 298.464514] Lustre: lustre-OST0000-osc-ffff908d46631800: disconnect after 23s idle [ 300.200284] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing yml_node [ 306.149532] Lustre: DEBUG MARKER: Client: 2.17.57.99 [ 309.469184] Lustre: DEBUG MARKER: MDS: 2.17.57.99 [ 312.467766] Lustre: DEBUG MARKER: OSS: 2.17.57.99 [ 314.382943] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Aug 27 18:10:53 EDT 2026 [ 334.183869] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 336.175919] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 339.852534] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 350.222700] Lustre: Unmounted lustre-client [ 472.342535] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 479.525756] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 504.755352] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 546.774351] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 18:14:46 (1787868886) [ 597.903853] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 604.218596] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 652.494778] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 708.873042] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 714.922909] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 761.946670] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 785.908485] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 18:18:45 (1787869125) [ 907.990844] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 915.180095] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 940.159341] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 941.142937] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 969.081604] Lustre: Unmounted lustre-client [ 998.366253] Key type lgssc unregistered [ 998.713976] LNet: 21884:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 998.740144] LNetError: 21884:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 998.761492] LNet: Removed LNI 192.168.204.17@tcp [ 999.744161] Key type .llcrypt unregistered [ 999.746899] Key type ._llcrypt unregistered [ 1017.155216] Key type ._llcrypt registered [ 1017.165457] Key type .llcrypt registered [ 1018.649925] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 18:22:38 (1787869358) [ 1021.415740] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1021.436091] alg: No test for adler32 (adler32-zlib) [ 1022.550480] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 1022.933726] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 1024.647598] Key type lgssc registered [ 1026.131610] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1083.344452] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1092.545147] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1118.169512] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1124.965960] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 1138.303326] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 18:24:37 (1787869477) [ 1149.613325] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 18:24:49 (1787869489) [ 1160.434902] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 18:24:59 (1787869499) [ 1174.408605] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 18:25:13 (1787869513) [ 1201.260275] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 18:25:41 (1787869541) [ 1223.788893] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 18:26:03 (1787869563) [ 1244.790793] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 18:26:24 (1787869584) [ 1257.497202] Lustre: Unmounted lustre-client [ 1258.111984] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 1260.545752] Lustre: Unmounted lustre-client [ 1300.259414] Key type lgssc unregistered [ 1300.506295] LNet: 30270:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1300.516919] LNetError: 30270:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1300.546848] LNet: Removed LNI 192.168.204.17@tcp [ 1301.510799] Key type .llcrypt unregistered [ 1301.512381] Key type ._llcrypt unregistered [ 1334.282705] Key type ._llcrypt registered [ 1334.284494] Key type .llcrypt registered [ 1334.963698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1334.988174] alg: No test for adler32 (adler32-zlib) [ 1336.317286] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 1336.682298] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 1338.431186] Key type lgssc registered [ 1340.468963] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1440.678665] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1447.627806] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1476.219686] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1526.090286] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 18:31:05 (1787869865) [ 1564.100340] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1572.847137] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1594.878518] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1607.182959] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 1754.370944] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 18:34:53 (1787870093) [ 1811.945690] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 18:35:51 (1787870151) [ 1825.497147] Lustre: Unmounted lustre-client [ 1925.785362] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1933.453060] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1960.656711] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1961.489439] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 1969.414653] Lustre: Unmounted lustre-client [ 2001.350124] Key type lgssc unregistered [ 2001.714030] LNet: 41610:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2001.726779] LNetError: 41610:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2001.747959] LNet: Removed LNI 192.168.204.17@tcp [ 2002.605115] Key type .llcrypt unregistered [ 2002.608980] Key type ._llcrypt unregistered [ 2021.595813] Key type ._llcrypt registered [ 2021.605720] Key type .llcrypt registered [ 2023.534756] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 18:39:22 (1787870362) [ 2027.068850] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2027.180530] alg: No test for adler32 (adler32-zlib) [ 2028.716177] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 2029.034279] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 2030.793983] Key type lgssc registered [ 2033.101346] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2096.428158] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2104.130961] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2129.055168] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2135.611186] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 2151.389228] Lustre: Unmounted lustre-client [ 2248.561775] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2255.079068] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2280.055916] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2280.964402] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 2288.700185] Lustre: Unmounted lustre-client [ 2318.483036] Key type lgssc unregistered [ 2318.766581] LNet: 47162:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2318.781046] LNetError: 47162:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2318.820236] LNet: Removed LNI 192.168.204.17@tcp [ 2319.596140] Key type .llcrypt unregistered [ 2319.600233] Key type ._llcrypt unregistered [ 2337.564396] Key type ._llcrypt registered [ 2337.571186] Key type .llcrypt registered [ 2338.897712] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 18:44:38 (1787870678) [ 2341.293209] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2341.383282] alg: No test for adler32 (adler32-zlib) [ 2342.495866] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 2342.731249] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 2344.439242] Key type lgssc registered [ 2345.859051] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2401.423089] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2408.932760] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2436.609515] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2438.576154] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 2560.512656] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 18:48:19 (1787870899) [ 2562.636320] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 2565.722516] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 18:48:24 (1787870904) [ 2567.534737] Lustre: Unmounted lustre-client [ 2607.780273] Key type lgssc unregistered [ 2608.033835] LNet: 52514:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2608.049589] LNetError: 52514:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2608.075977] LNet: Removed LNI 192.168.204.17@tcp [ 2609.151179] Key type .llcrypt unregistered [ 2609.158266] Key type ._llcrypt unregistered [ 2639.159397] Key type ._llcrypt registered [ 2639.163425] Key type .llcrypt registered [ 2639.611359] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2639.624811] alg: No test for adler32 (adler32-zlib) [ 2640.781517] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 2641.038667] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 2642.729682] Key type lgssc registered [ 2644.422514] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2681.644919] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 18:50:20 (1787871020) [ 2696.841856] Key type lgssc unregistered [ 2697.166854] LNet: 54934:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2697.175431] LNetError: 54934:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2697.199332] LNet: Removed LNI 192.168.204.17@tcp [ 2698.075583] Key type .llcrypt unregistered [ 2698.080844] Key type ._llcrypt unregistered [ 2714.516622] Key type ._llcrypt registered [ 2714.543846] Key type .llcrypt registered [ 2715.175672] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2715.194301] alg: No test for adler32 (adler32-zlib) [ 2716.603745] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 2716.866853] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 2718.608094] Key type lgssc registered [ 2720.743315] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2782.175353] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2789.404248] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2812.051301] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2823.727906] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 2877.191612] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 18:53:36 (1787871216) [ 2879.061211] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 2881.776575] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 18:53:41 (1787871221) [ 2884.622900] Lustre: Unmounted lustre-client [ 2956.781278] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2962.283348] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3033.863117] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 18:56:13 (1787871373) [ 3117.891585] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 3123.494682] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3138.536175] Lustre: lustre-MDT0001-mdc-ffff908d47e4f800: Connection to lustre-MDT0001 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3143.649260] Lustre: lustre-OST0000-osc-ffff908d47e4f800: disconnect after 23s idle [ 3155.304478] LustreError: 63639:0:(obd_config.c:2102:class_config_llog_handler()) MGC192.168.204.117@tcp: cfg command failed: rc = -17 [ 3155.309494] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 3155.309494] [ 3155.319334] LustreError: 62892:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 3171.204729] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID and inheritance flag ========================================================== 18:58:30 (1787871510) [ 3233.319848] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3324.315219] Lustre: Unmounted lustre-client [ 3503.717465] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 3509.821523] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3572.806687] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 19:05:12 (1787871912) [ 3574.578382] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3575.286920] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3575.301153] Lustre: Skipped 2 previous similar messages [ 3594.580405] Lustre: Unmounted lustre-client [ 3758.358425] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 19:08:17 (1787872097) [ 3760.304158] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 3762.616584] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 19:08:21 (1787872101) [ 3860.838083] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 3866.880931] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4634.594568] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 19:22:54 (1787872974) [ 4638.322393] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4648.693921] Lustre: Unmounted lustre-client [ 4800.969765] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4808.942919] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4841.748763] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4842.368242] LustreError: 55317:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 4842.435169] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 6953.620849] Lustre: DEBUG MARKER: conf-sanity test_135: @@@@@@ FAIL: creation thread is running. Is changelog reader stuck? [ 7017.742794] Lustre: Unmounted lustre-client [ 7057.197522] Key type lgssc unregistered [ 7057.589810] LNet: 103191:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7057.600034] LNetError: 103191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7057.618353] LNet: Removed LNI 192.168.204.17@tcp [ 7058.417235] Key type .llcrypt unregistered [ 7058.419322] Key type ._llcrypt unregistered [ 7070.267690] Key type ._llcrypt registered [ 7070.270918] Key type .llcrypt registered [ 7072.051718] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 20:03:31 (1787875411) [ 7091.016124] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7091.041514] alg: No test for adler32 (adler32-zlib) [ 7092.157779] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 7092.542284] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 7094.311195] Key type lgssc registered [ 7095.704496] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7187.481571] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7194.240674] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7221.459431] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7224.219899] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 7243.964387] Lustre: Unmounted lustre-client [ 7363.770679] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7369.378360] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7393.390897] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7427.515635] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 20:09:26 (1787875766) [ 7428.938944] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 7430.560369] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 20:09:30 (1787875770) [ 7463.812875] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7468.741286] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7484.085329] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7484.710705] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 7490.023679] Lustre: lustre-MDT0000-mdc-ffff908d4693a000: Connection to lustre-MDT0000 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7495.141231] Lustre: lustre-MDT0001-mdc-ffff908d4693a000: Connection to lustre-MDT0001 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7511.522111] Lustre: 103957:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787875836/real 1787875836] req@0000000077aaae66 x1874723270110080/t0(0) o400->MGC192.168.204.117@tcp@192.168.204.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1787875852 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7511.556369] LustreError: MGC192.168.204.117@tcp: Connection to MGS (at 192.168.204.117@tcp) was lost; in progress operations using this service will fail [ 7641.603375] LustreError: lustre-MDT0000-mdc-ffff908d4693a000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7641.665744] Lustre: lustre-MDT0000-mdc-ffff908d4693a000: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [ 7646.703638] LustreError: lustre-MDT0001-mdc-ffff908d4693a000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7646.759835] Lustre: lustre-MDT0001-mdc-ffff908d4693a000: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [ 7653.671483] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7655.595341] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7655.994752] Lustre: Evicted from MGS (at 192.168.204.117@tcp) after server handle changed from 0x596da11bc0d42a4c to 0x596da11bc0d4429b [ 7656.016785] Lustre: MGC192.168.204.117@tcp: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [ 7663.710613] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7666.613519] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7692.190862] Lustre: Unmounted lustre-client [ 7835.484544] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7841.412657] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7867.651043] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7912.976945] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 20:17:32 (1787876252) [ 7953.209885] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7959.224948] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7983.038901] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7983.709132] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 7985.984960] LustreError: 120692:0:(lproc_llite.c:618:ll_max_cached_mb_seq_write()) lustre: cannot set max_cached_mb=0 MB more than 3693 MB: rc = -34 [ 7993.170523] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 20:18:52 (1787876332) [ 7995.559210] Lustre: Unmounted lustre-client [ 8023.996288] Key type lgssc unregistered [ 8024.227138] LNet: 121700:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8024.241041] LNetError: 121700:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8024.272452] LNet: Removed LNI 192.168.204.17@tcp [ 8024.891692] Key type .llcrypt unregistered [ 8024.896290] Key type ._llcrypt unregistered [ 8040.310100] Key type ._llcrypt registered [ 8040.316565] Key type .llcrypt registered [ 8040.728215] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8040.742322] alg: No test for adler32 (adler32-zlib) [ 8041.867876] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 8042.135193] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 8043.863259] Key type lgssc registered [ 8045.133157] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8133.558844] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8140.823887] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8169.365692] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8312.549653] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8319.151478] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8348.558293] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8405.689671] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 20:25:44 (1787876744) [ 8418.800446] Key type lgssc unregistered [ 8419.119743] LNet: 128926:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8419.133039] LNetError: 128926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8419.156517] LNet: Removed LNI 192.168.204.17@tcp [ 8420.033862] Key type .llcrypt unregistered [ 8420.035649] Key type ._llcrypt unregistered [ 8432.827473] Key type ._llcrypt registered [ 8432.831840] Key type .llcrypt registered [ 8433.432679] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8433.456624] alg: No test for adler32 (adler32-zlib) [ 8434.525188] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 8434.819218] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 8436.495133] Key type lgssc registered [ 8437.646462] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8493.004674] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8498.514634] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8528.401624] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8674.686986] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8682.225864] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8707.717472] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8772.294557] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 20:31:50 (1787877110) [ 8879.308348] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 8884.329791] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8894.942708] Lustre: DEBUG MARKER: ADD OST3 [ 8905.183309] Lustre: lustre-OST0000-osc-ffff908d58483800: disconnect after 24s idle [ 8909.657413] Lustre: DEBUG MARKER: STOP OST3 [ 8923.127060] Lustre: lustre-OST0003-osc-ffff908d58483800: Connection to lustre-OST0003 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8930.860824] Lustre: DEBUG MARKER: START OST3 again [ 8940.526344] Lustre: lustre-OST0003-osc-ffff908d58483800: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [ 8973.152970] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8973.164413] LustreError: 139745:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff908d58483800: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 8983.539447] Lustre: Unmounted lustre-client [ 9118.207395] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9125.648648] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9154.261184] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9196.422882] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 20:38:56 (1787877536) [ 9299.697928] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9307.672781] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9333.399688] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9425.158226] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9435.414494] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9461.438703] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9464.148047] LNetError: 129338:0:(lib-move.c:2158:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 9464.525305] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 9469.842184] Lustre: Unmounted lustre-client [ 9501.054083] Key type lgssc unregistered [ 9517.279382] LNet: 1 local NIs in recovery (showing 1): 192.168.204.17@tcp [ 9522.977841] LNet: 148736:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9522.993066] LNetError: 148736:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9594.727599] LNet: Removed LNI 192.168.204.17@tcp [ 9596.177261] Key type .llcrypt unregistered [ 9596.180566] Key type ._llcrypt unregistered [ 9614.455464] Key type ._llcrypt registered [ 9614.463112] Key type .llcrypt registered [ 9615.944906] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 20:45:55 (1787877955) [ 9636.863027] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9636.893386] alg: No test for adler32 (adler32-zlib) [ 9638.236456] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [ 9638.725730] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [ 9640.521683] Key type lgssc registered [ 9642.306464] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9748.037831] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9755.076536] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9785.865547] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9949.881363] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 9955.446750] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9965.083318] Lustre: Unmounted lustre-client [ 9965.195627] LNetError: 149925:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::54c8:25ff:fecb:953f/1023: rc = -22 [ 9965.213360] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9965.520373] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 9965.768147] Lustre: Unmounted lustre-client [ 9966.405900] LNetError: 149926:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::54c8:25ff:fecb:953f/1023: rc = -22 [ 9966.423243] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9966.438957] LNet: 1 local NIs in recovery (showing 1): 192.168.204.17@tcp [ 9966.790202] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 9966.797923] Lustre: Skipped 1 previous similar message [ 9966.977133] Lustre: Unmounted lustre-client [ 9966.979580] Lustre: Skipped 1 previous similar message [ 9968.901743] LNetError: 149926:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::54c8:25ff:fecb:953f/1023: rc = -22 [ 9968.916676] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9969.188730] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [ 9969.194759] Lustre: Skipped 3 previous similar messages [ 9969.370679] Lustre: Unmounted lustre-client [ 9969.376912] Lustre: Skipped 3 previous similar messages [ 9970.037491] Lustre: 155868:0:(obd_mount.c:175:lustre_add_mgc_failnodes()) MGC6699:7654::1234:1234:d84@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 9970.664781] Lustre: 155896:0:(obd_mount.c:175:lustre_add_mgc_failnodes()) MGC193.168.0.240@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 9978.891543] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 20:51:58 (1787878318) [10028.901990] LNet: 1 local NIs in recovery (showing 1): 192.168.204.17@tcp [10115.868738] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10122.555681] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10151.986554] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10240.845825] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10248.875675] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10276.064685] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10281.633520] LustreError: 161499:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [10328.992635] LNet: 1 local NIs in recovery (showing 1): 192.168.204.17@tcp [10405.791446] LNet: 1 local NIs in recovery (showing 1): 192.168.204.17@tcp [10420.197139] LustreError: MGC192.168.252.112@tcp: Confguration from log lustre-client failed from MGS -110. Communication error between node & MGS, a bad configuration, or other errors. See syslog for more info [10420.219658] Lustre: Unmounted lustre-client [10420.232280] Lustre: Skipped 3 previous similar messages [10420.258123] LustreError: 161499:0:(super25.c:179:lustre_fill_super()) llite: Unable to mount : rc = -110 [10461.564638] Key type lgssc unregistered [10461.924900] LNet: 161963:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10461.948812] LNetError: 161963:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10536.744790] LNet: Removed LNI 192.168.204.17@tcp [10537.578215] Key type .llcrypt unregistered [10537.582131] Key type ._llcrypt unregistered [10553.577775] Key type ._llcrypt registered [10553.579488] Key type .llcrypt registered [10555.013320] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 21:01:34 (1787878894) [10579.219208] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10579.253809] alg: No test for adler32 (adler32-zlib) [10580.540347] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [10581.014271] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [10582.815204] Key type lgssc registered [10584.538223] Lustre: Echo OBD driver; http://www.lustre.org/ [10733.146306] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [10738.663838] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10756.370180] Lustre: Unmounted lustre-client [10938.731056] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [10946.981553] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10955.098103] Lustre: Unmounted lustre-client [11004.324938] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 21:09:04 (1787879344) [11124.214437] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11132.560853] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11157.456452] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11289.764793] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [11294.179437] Lustre: DEBUG MARKER: Using TIMEOUT=20 [11308.009844] Lustre: Unmounted lustre-client [11439.339094] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [11446.392561] Lustre: DEBUG MARKER: Using TIMEOUT=20 [11465.195957] Lustre: lustre-OST0001-osc-ffff908d47e84800: disconnect after 23s idle [11466.321283] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 21:16:46 (1787879806) [11468.325450] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11478.647265] Lustre: Unmounted lustre-client [11644.116526] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [11649.719880] Lustre: DEBUG MARKER: Using TIMEOUT=20 [11657.638538] Lustre: Unmounted lustre-client [11658.273518] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [11665.891672] Lustre: Unmounted lustre-client [11667.660320] Lustre: DEBUG MARKER: == conf-sanity test 157a: test allow_register for MDT registration and MGS restart ========================================================== 21:20:07 (1787880007) [11750.703481] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11756.899486] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11777.089986] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11788.326254] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [11880.437976] Lustre: lustre-MDT0000-mdc-ffff908d6814a800: Connection to lustre-MDT0000 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [11885.548432] LustreError: lustre-OST0001-osc-ffff908d6814a800: operation ost_connect to node 192.168.204.117@tcp failed: rc = -19 [11895.781829] LustreError: MGC192.168.204.117@tcp: Connection to MGS (at 192.168.204.117@tcp) was lost; in progress operations using this service will fail [11895.807513] LustreError: lustre-MDT0000-mdc-ffff908d6814a800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [11895.823796] Lustre: Evicted from MGS (at 192.168.204.117@tcp) after server handle changed from 0xae5b428689a6eacb to 0xae5b428689a6ee36 [11895.834534] Lustre: MGC192.168.204.117@tcp: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [11895.845175] Lustre: Skipped 1 previous similar message [11940.494425] Lustre: Unmounted lustre-client [11966.926515] Key type lgssc unregistered [11967.255240] LNet: 189503:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11967.264948] LNetError: 189503:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11967.285512] LNet: Removed LNI 192.168.204.17@tcp [11968.147288] Key type .llcrypt unregistered [11968.149466] Key type ._llcrypt unregistered [11979.856978] Key type ._llcrypt registered [11979.859258] Key type .llcrypt registered [11981.322782] Lustre: DEBUG MARKER: == conf-sanity test 157b: verify allow_register (block new OSTs, allow existing) ========================================================== 21:25:20 (1787880320) [11984.049522] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11984.115488] alg: No test for adler32 (adler32-zlib) [11985.259965] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [11985.519217] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [11987.247179] Key type lgssc registered [11988.786614] Lustre: Echo OBD driver; http://www.lustre.org/ [12046.222419] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12052.834743] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12072.343380] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12075.146232] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [12172.269103] LustreError: lustre-OST0001-osc-ffff908d4547a800: operation ost_connect to node 192.168.204.117@tcp failed: rc = -19 [12290.092221] Lustre: Unmounted lustre-client [12319.483899] Key type lgssc unregistered [12319.859220] LNet: 195535:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12319.875784] LNetError: 195535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12319.896157] LNet: Removed LNI 192.168.204.17@tcp [12320.815701] Key type .llcrypt unregistered [12320.818753] Key type ._llcrypt unregistered [12330.909745] Key type ._llcrypt registered [12330.914690] Key type .llcrypt registered [12332.654537] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 21:31:11 (1787880671) [12365.048098] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12365.102803] alg: No test for adler32 (adler32-zlib) [12366.308567] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [12366.579105] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [12368.328055] Key type lgssc registered [12369.489088] Lustre: Echo OBD driver; http://www.lustre.org/ [12459.414183] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12466.499438] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12493.686460] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12533.468918] Key type lgssc unregistered [12533.688831] LNet: 200521:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12533.695170] LNetError: 200521:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12533.720405] LNet: Removed LNI 192.168.204.17@tcp [12534.353639] Key type .llcrypt unregistered [12534.356313] Key type ._llcrypt unregistered [12650.318495] Key type ._llcrypt registered [12650.330749] Key type .llcrypt registered [12650.889850] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12650.918529] alg: No test for adler32 (adler32-zlib) [12652.088655] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [12652.463149] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [12654.239399] Key type lgssc registered [12655.752964] Lustre: Echo OBD driver; http://www.lustre.org/ [12708.955610] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 21:37:28 (1787881048) [12756.122447] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12763.822927] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12790.637566] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12793.469729] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [12796.580169] Lustre: Unmounted lustre-client [12797.477425] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [12797.968500] Lustre: Unmounted lustre-client [12798.953427] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [12811.797495] Lustre: Unmounted lustre-client [12842.810483] Key type lgssc unregistered [12843.338521] LNet: 205515:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12843.354480] LNetError: 205515:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12843.397860] LNet: Removed LNI 192.168.204.17@tcp [12844.270435] Key type .llcrypt unregistered [12844.273527] Key type ._llcrypt unregistered [12858.081254] Key type ._llcrypt registered [12858.084753] Key type .llcrypt registered [12860.408278] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 21:39:59 (1787881199) [12865.213357] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12865.241723] alg: No test for adler32 (adler32-zlib) [12866.425271] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [12866.675784] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [12868.463300] Key type lgssc registered [12870.285395] Lustre: Echo OBD driver; http://www.lustre.org/ [12921.907830] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12929.213079] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12955.709199] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12958.136663] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [12967.097507] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12968.857565] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12973.564958] Lustre: lustre-MDT0000-mdc-ffff908d48227000: Connection to lustre-MDT0000 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [12983.783251] Lustre: lustre-MDT0001-mdc-ffff908d48227000: Connection to lustre-MDT0001 (at 192.168.204.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [13000.162474] Lustre: 206193:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787881325/real 1787881325] req@000000004dc64377 x1874729324516992/t0(0) o400->MGC192.168.204.117@tcp@192.168.204.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1787881341 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [13000.207511] LustreError: MGC192.168.204.117@tcp: Connection to MGS (at 192.168.204.117@tcp) was lost; in progress operations using this service will fail [13033.972219] Lustre: Evicted from MGS (at 192.168.204.117@tcp) after server handle changed from 0xc898661497a1428a to 0xc898661497a14427 [13033.990978] Lustre: MGC192.168.204.117@tcp: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [13068.999624] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13070.735934] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [13075.961957] LustreError: lustre-MDT0000-mdc-ffff908d48227000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [13075.992523] Lustre: lustre-MDT0000-mdc-ffff908d48227000: Connection restored to 192.168.204.117@tcp (at 192.168.204.117@tcp) [13076.057526] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13077.583741] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [13080.017791] Lustre: Unmounted lustre-client [13107.646643] Key type lgssc unregistered [13107.933878] LNet: 211060:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13107.943467] LNetError: 211060:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13107.981905] LNet: Removed LNI 192.168.204.17@tcp [13108.665715] Key type .llcrypt unregistered [13108.668616] Key type ._llcrypt unregistered [13137.885118] Key type ._llcrypt registered [13137.891553] Key type .llcrypt registered [13138.445968] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13138.465380] alg: No test for adler32 (adler32-zlib) [13139.910689] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13140.285462] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13142.079625] Key type lgssc registered [13143.685847] Lustre: Echo OBD driver; http://www.lustre.org/ [13236.300846] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13243.371427] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13270.326742] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13314.900973] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 21:47:34 (1787881654) [13424.553731] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13431.623491] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13458.547955] Lustre: DEBUG MARKER: oleg417-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13461.715549] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [13468.428937] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [13470.097716] Lustre: Mounted lustre-client - version 2.17.57_99_gb2219ab [13470.109676] Lustre: Skipped 1 previous similar message [13475.145644] Lustre: Unmounted lustre-client [13477.714270] Lustre: Unmounted lustre-client [13479.937776] Lustre: Unmounted lustre-client [13482.702671] Lustre: Unmounted lustre-client [13498.401877] Lustre: Unmounted lustre-client [13498.405041] Lustre: Skipped 1 previous similar message [13537.001163] Key type lgssc unregistered [13537.298167] LNet: 220239:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13537.306381] LNetError: 220239:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13537.329269] LNet: Removed LNI 192.168.204.17@tcp [13538.259092] Key type .llcrypt unregistered [13538.261588] Key type ._llcrypt unregistered [13550.501610] Key type ._llcrypt registered [13550.503745] Key type .llcrypt registered [13552.143858] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 21:51:31 (1787881891) [13566.216719] Key type .llcrypt unregistered [13566.218395] Key type ._llcrypt unregistered [13567.617180] Key type ._llcrypt registered [13567.627636] Key type .llcrypt registered [13567.992789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [13568.009741] alg: No test for adler32 (adler32-zlib) [13569.144609] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13569.511213] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13571.241640] Key type lgssc registered [13572.568342] Lustre: Echo OBD driver; http://www.lustre.org/ [13600.577504] Key type lgssc unregistered [13600.903679] LNet: 222404:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13600.914611] LNetError: 222404:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13600.935833] LNet: Removed LNI 192.168.204.17@tcp [13601.662852] Key type .llcrypt unregistered [13601.665765] Key type ._llcrypt unregistered [13602.118139] Key type ._llcrypt registered [13602.120253] Key type .llcrypt registered [13603.756403] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 21:52:23 (1787881943) [13618.114525] Key type .llcrypt unregistered [13618.119980] Key type ._llcrypt unregistered [13619.521701] Key type ._llcrypt registered [13619.539800] Key type .llcrypt registered [13619.864213] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13619.885534] alg: No test for adler32 (adler32-zlib) [13621.132530] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13621.567029] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13623.399227] Key type lgssc registered [13625.133629] Lustre: Echo OBD driver; http://www.lustre.org/ [13643.976088] Key type lgssc unregistered [13644.329626] LNet: 223966:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13644.338269] LNetError: 223966:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13644.370647] LNet: Removed LNI 192.168.204.17@tcp [13645.036762] Key type .llcrypt unregistered [13645.038627] Key type ._llcrypt unregistered [13653.369532] Key type ._llcrypt registered [13653.386481] Key type .llcrypt registered [13653.761587] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13653.787804] alg: No test for adler32 (adler32-zlib) [13654.910956] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13655.221176] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13656.911188] Key type lgssc registered [13658.388239] Lustre: Echo OBD driver; http://www.lustre.org/ [13685.833711] Key type lgssc unregistered [13686.100435] LNet: 225734:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13686.107808] LNetError: 225734:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13686.129351] LNet: Removed LNI 192.168.204.17@tcp [13686.982686] Key type .llcrypt unregistered [13686.986444] Key type ._llcrypt unregistered [13687.421058] Key type ._llcrypt registered [13687.424763] Key type .llcrypt registered [13689.257181] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 21:53:48 (1787882028) [13702.767688] Key type .llcrypt unregistered [13702.775850] Key type ._llcrypt unregistered [13703.891390] Key type ._llcrypt registered [13703.894211] Key type .llcrypt registered [13704.606840] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13704.620766] alg: No test for adler32 (adler32-zlib) [13705.707824] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13705.905784] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13707.567489] Key type lgssc registered [13708.960620] Lustre: Echo OBD driver; http://www.lustre.org/ [13727.524269] Key type lgssc unregistered [13727.777604] LNet: 227288:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13727.787799] LNetError: 227288:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13727.811604] LNet: Removed LNI 192.168.204.17@tcp [13728.621687] Key type .llcrypt unregistered [13728.623476] Key type ._llcrypt unregistered [13737.393946] Key type ._llcrypt registered [13737.398532] Key type .llcrypt registered [13737.901942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13737.921277] alg: No test for adler32 (adler32-zlib) [13739.112835] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13739.452369] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13741.151171] Key type lgssc registered [13742.675652] Lustre: Echo OBD driver; http://www.lustre.org/ [13761.588139] Key type lgssc unregistered [13761.946180] LNet: 228599:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13761.956960] LNetError: 228599:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13761.977212] LNet: Removed LNI 192.168.204.17@tcp [13762.804532] Key type .llcrypt unregistered [13762.808929] Key type ._llcrypt unregistered [13770.290834] Key type ._llcrypt registered [13770.300904] Key type .llcrypt registered [13770.724205] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13770.738858] alg: No test for adler32 (adler32-zlib) [13771.883472] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13772.103564] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13773.770115] Key type lgssc registered [13775.174544] Lustre: Echo OBD driver; http://www.lustre.org/ [13792.238761] Key type lgssc unregistered [13792.548736] LNet: 229907:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13792.570755] LNetError: 229907:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13792.588798] LNet: Removed LNI 192.168.204.17@tcp [13793.204637] Key type .llcrypt unregistered [13793.206839] Key type ._llcrypt unregistered [13800.682153] Key type ._llcrypt registered [13800.684509] Key type .llcrypt registered [13801.067646] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13801.078590] alg: No test for adler32 (adler32-zlib) [13802.144566] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13802.344760] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13804.039438] Key type lgssc registered [13805.161640] Lustre: Echo OBD driver; http://www.lustre.org/ [13828.264505] Key type lgssc unregistered [13828.483678] LNet: 231679:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13828.500224] LNetError: 231679:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13828.527481] LNet: Removed LNI 192.168.204.17@tcp [13829.156960] Key type .llcrypt unregistered [13829.160234] Key type ._llcrypt unregistered [13829.620524] Key type ._llcrypt registered [13829.623225] Key type .llcrypt registered [13831.272090] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 21:56:10 (1787882170) [13844.356162] Key type .llcrypt unregistered [13844.359462] Key type ._llcrypt unregistered [13845.245265] Key type ._llcrypt registered [13845.248883] Key type .llcrypt registered [13845.744281] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13845.759691] alg: No test for adler32 (adler32-zlib) [13846.898379] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13847.181114] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13848.856027] Key type lgssc registered [13850.673761] Lustre: Echo OBD driver; http://www.lustre.org/ [13871.868103] Key type lgssc unregistered [13872.200809] LNet: 233239:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13872.206786] LNetError: 233239:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13872.221726] LNet: Removed LNI 192.168.204.17@tcp [13873.143517] Key type .llcrypt unregistered [13873.145733] Key type ._llcrypt unregistered [13880.749869] Key type ._llcrypt registered [13880.752978] Key type .llcrypt registered [13881.245156] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13881.258589] alg: No test for adler32 (adler32-zlib) [13882.377903] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13882.549091] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13884.247193] Key type lgssc registered [13885.277708] Lustre: Echo OBD driver; http://www.lustre.org/ [13901.632274] Key type lgssc unregistered [13901.999592] LNet: 234557:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13902.027816] LNetError: 234557:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13902.053135] LNet: Removed LNI 192.168.204.17@tcp [13902.916332] Key type .llcrypt unregistered [13902.920525] Key type ._llcrypt unregistered [13911.580537] Key type ._llcrypt registered [13911.583171] Key type .llcrypt registered [13912.005836] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13912.020369] alg: No test for adler32 (adler32-zlib) [13913.036387] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13913.298301] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13915.015162] Key type lgssc registered [13916.315164] Lustre: Echo OBD driver; http://www.lustre.org/ [13931.624640] Key type lgssc unregistered [13931.866279] LNet: 235867:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13931.876668] LNetError: 235867:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13931.890050] LNet: Removed LNI 192.168.204.17@tcp [13932.592415] Key type .llcrypt unregistered [13932.595499] Key type ._llcrypt unregistered [13939.943794] Key type ._llcrypt registered [13939.945454] Key type .llcrypt registered [13940.476637] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13940.501101] alg: No test for adler32 (adler32-zlib) [13941.633531] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13941.932044] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13943.615261] Key type lgssc registered [13944.996823] Lustre: Echo OBD driver; http://www.lustre.org/ [13963.317818] Key type lgssc unregistered [13963.657162] LNet: 237179:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13963.672315] LNetError: 237179:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13963.693532] LNet: Removed LNI 192.168.204.17@tcp [13964.589210] Key type .llcrypt unregistered [13964.592812] Key type ._llcrypt unregistered [13972.763625] Key type ._llcrypt registered [13972.765755] Key type .llcrypt registered [13973.138194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13973.159119] alg: No test for adler32 (adler32-zlib) [13974.194552] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [13974.449039] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [13976.159356] Key type lgssc registered [13977.777605] Lustre: Echo OBD driver; http://www.lustre.org/ [13995.214120] Key type lgssc unregistered [13995.537517] LNet: 238492:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13995.547828] LNetError: 238492:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13995.566413] LNet: Removed LNI 192.168.204.17@tcp [13996.328789] Key type .llcrypt unregistered [13996.332437] Key type ._llcrypt unregistered [14004.929154] Key type ._llcrypt registered [14004.931454] Key type .llcrypt registered [14005.205289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14005.218566] alg: No test for adler32 (adler32-zlib) [14006.296984] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [14006.519527] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [14008.183409] Key type lgssc registered [14009.623904] Lustre: Echo OBD driver; http://www.lustre.org/ [14027.720370] Key type lgssc unregistered [14027.949755] LNet: 239800:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14027.961563] LNetError: 239800:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14027.978284] LNet: Removed LNI 192.168.204.17@tcp [14028.731647] Key type .llcrypt unregistered [14028.735659] Key type ._llcrypt unregistered [14057.136510] Key type ._llcrypt registered [14057.140015] Key type .llcrypt registered [14058.302563] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 21:59:58 (1787882398) [14072.660292] Key type .llcrypt unregistered [14072.662524] Key type ._llcrypt unregistered [14073.501023] Key type ._llcrypt registered [14073.508701] Key type .llcrypt registered [14073.918098] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14073.939346] alg: No test for adler32 (adler32-zlib) [14075.102512] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [14075.403302] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [14077.087211] Key type lgssc registered [14078.385771] Lustre: Echo OBD driver; http://www.lustre.org/ [14094.945311] Key type lgssc unregistered [14095.194578] LNet: 242131:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14095.204780] LNetError: 242131:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14095.242802] LNet: Removed LNI 192.168.204.17@tcp [14095.863713] Key type .llcrypt unregistered [14095.865609] Key type ._llcrypt unregistered [14103.413821] Key type ._llcrypt registered [14103.418035] Key type .llcrypt registered [14103.961947] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14103.980054] alg: No test for adler32 (adler32-zlib) [14105.078519] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [14105.390944] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [14107.079206] Key type lgssc registered [14108.387712] Lustre: Echo OBD driver; http://www.lustre.org/ [14126.102294] Key type lgssc unregistered [14126.400510] LNet: 243463:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14126.418049] LNetError: 243463:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14126.449681] LNet: Removed LNI 192.168.204.17@tcp [14127.355611] Key type .llcrypt unregistered [14127.358716] Key type ._llcrypt unregistered [14136.278916] Key type ._llcrypt registered [14136.294439] Key type .llcrypt registered [14136.737418] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14136.762733] alg: No test for adler32 (adler32-zlib) [14138.091929] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [14138.381041] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [14140.071393] Key type lgssc registered [14141.549970] Lustre: Echo OBD driver; http://www.lustre.org/ [14161.583786] Key type lgssc unregistered [14161.947837] LNet: 244774:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14161.959742] LNetError: 244774:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14161.977748] LNet: Removed LNI 192.168.204.17@tcp [14162.736885] Key type .llcrypt unregistered [14162.742198] Key type ._llcrypt unregistered [14171.615748] Key type ._llcrypt registered [14171.618754] Key type .llcrypt registered [14171.866953] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14171.879410] alg: No test for adler32 (adler32-zlib) [14173.209012] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [14173.436076] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [14175.111333] Key type lgssc registered [14176.678539] Lustre: Echo OBD driver; http://www.lustre.org/ [14201.892711] Key type lgssc unregistered [14202.116580] LNet: 246571:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14202.129477] LNetError: 246571:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14202.156025] LNet: Removed LNI 192.168.204.17@tcp [14202.790320] Key type .llcrypt unregistered [14202.795079] Key type ._llcrypt unregistered [14203.259391] Key type ._llcrypt registered [14203.261521] Key type .llcrypt registered [14204.714244] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 22:02:24 (1787882544) [14220.738814] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14220.767421] alg: No test for adler32 (adler32-zlib) [14221.783827] Lustre: Lustre: Build Version: 2.17.57_99_gb2219ab [14222.029659] LNet: Added LNI 192.168.204.17@tcp [8/256/0/180] [14223.720155] Key type lgssc registered [14224.808577] Lustre: Echo OBD driver; http://www.lustre.org/ [14467.674754] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 22:06:47 (1787882807) [14470.028568] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [14537.902666] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14221 sec ========= 22:07:56 (1787882876) [14540.533745] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 22:07:59 (1787882879) === [14544.940846] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 22:08:04 (1787882884) === [14588.531157] Key type lgssc unregistered [14588.857859] LNet: 255634:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14588.870529] LNetError: 255634:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14588.896971] LNet: Removed LNI 192.168.204.17@tcp [14589.654501] Key type .llcrypt unregistered [14589.662121] Key type ._llcrypt unregistered