[ 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 474204766 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003210] x2apic enabled [ 0.004010] Switched APIC routing to physical x2apic. [ 0.005015] kvm-guest: setup PV IPIs [ 0.008389] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009025] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010013] pid_max: default: 32768 minimum: 301 [ 0.011131] LSM: Security Framework initializing [ 0.012056] Yama: becoming mindful. [ 0.013042] SELinux: Initializing. [ 0.014062] *** VALIDATE selinux *** [ 0.022820] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027804] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029135] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031113] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032112] *** VALIDATE tmpfs *** [ 0.034195] *** VALIDATE proc *** [ 0.035342] *** VALIDATE cgroup *** [ 0.036009] *** VALIDATE cgroup2 *** [ 0.037262] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038163] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040027] Spectre V2 : User space: Vulnerable [ 0.042005] Speculative Store Bypass: Vulnerable [ 0.045205] debug: unmapping init [mem 0xffffffff96859000-0xffffffff96860fff] [ 0.047847] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048669] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049022] ... version: 2 [ 0.050012] ... bit width: 48 [ 0.051023] ... generic registers: 4 [ 0.052012] ... value mask: 0000ffffffffffff [ 0.053013] ... max period: 00007fffffffffff [ 0.054011] ... fixed-purpose events: 3 [ 0.055011] ... event mask: 000000070000000f [ 0.056284] rcu: Hierarchical SRCU implementation. [ 0.058404] smp: Bringing up secondary CPUs ... [ 0.059547] x86: Booting SMP configuration: [ 0.060022] .... node #0, CPUs: #1 #2 #3 [ 0.064166] smp: Brought up 1 node, 4 CPUs [ 0.066018] smpboot: Max logical packages: 1 [ 0.067023] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.243327] node 0 deferred pages initialised in 173ms [ 0.245159] devtmpfs: initialized [ 0.247568] x86/mm: Memory block size: 128MB [ 0.252811] gcov: version magic: 0x41383552 [ 0.256288] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.257169] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.258444] pinctrl core: initialized pinctrl subsystem [ 0.261367] [ 0.262015] ************************************************************* [ 0.265018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.266016] ** ** [ 0.268017] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.271016] ** ** [ 0.273013] ** This means that this kernel is built to expose internal ** [ 0.275015] ** IOMMU data structures, which may compromise security on ** [ 0.278016] ** your system. ** [ 0.280012] ** ** [ 0.282015] ** If you see this message and you are not debugging the ** [ 0.285016] ** kernel, report this immediately to your vendor! ** [ 0.287018] ** ** [ 0.289014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.292015] ************************************************************* [ 0.294615] NET: Registered protocol family 16 [ 0.296514] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.299089] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.302090] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.307045] cpuidle: using governor menu [ 0.308925] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.312718] PCI: Using configuration type 1 for base access [ 0.314118] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.321180] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.323121] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.326093] cryptd: max_cpu_qlen set to 1000 [ 0.329253] ACPI: Added _OSI(Module Device) [ 0.330012] ACPI: Added _OSI(Processor Device) [ 0.331009] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.332012] ACPI: Added _OSI(Processor Aggregator Device) [ 0.335272] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.342270] ACPI: Interpreter enabled [ 0.343060] ACPI: PM: (supports S0 S3 S4 S5) [ 0.344013] ACPI: Using IOAPIC for interrupt routing [ 0.346137] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.349477] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.358898] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.361074] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.364031] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.368132] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.373478] acpiphp: Slot [2] registered [ 0.375448] acpiphp: Slot [5] registered [ 0.377182] acpiphp: Slot [6] registered [ 0.378131] acpiphp: Slot [3] registered [ 0.379116] acpiphp: Slot [4] registered [ 0.381117] acpiphp: Slot [7] registered [ 0.384174] acpiphp: Slot [8] registered [ 0.386142] acpiphp: Slot [9] registered [ 0.387143] acpiphp: Slot [10] registered [ 0.389119] acpiphp: Slot [11] registered [ 0.390145] acpiphp: Slot [12] registered [ 0.392137] acpiphp: Slot [13] registered [ 0.393191] acpiphp: Slot [14] registered [ 0.395168] acpiphp: Slot [15] registered [ 0.397133] acpiphp: Slot [16] registered [ 0.399131] acpiphp: Slot [17] registered [ 0.400114] acpiphp: Slot [18] registered [ 0.402149] acpiphp: Slot [19] registered [ 0.404133] acpiphp: Slot [20] registered [ 0.406225] acpiphp: Slot [21] registered [ 0.407143] acpiphp: Slot [22] registered [ 0.409156] acpiphp: Slot [23] registered [ 0.411137] acpiphp: Slot [24] registered [ 0.413123] acpiphp: Slot [25] registered [ 0.414000] acpiphp: Slot [26] registered [ 0.414000] acpiphp: Slot [27] registered [ 0.415132] acpiphp: Slot [28] registered [ 0.417074] acpiphp: Slot [29] registered [ 0.418135] acpiphp: Slot [30] registered [ 0.420113] acpiphp: Slot [31] registered [ 0.421115] PCI host bridge to bus 0000:00 [ 0.422041] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.425030] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.428034] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.431034] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.434035] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.437034] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.440198] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.443252] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.447552] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.455580] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.460768] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.464028] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.466023] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.471033] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.473725] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.475803] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.478056] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.482056] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.488026] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.501757] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.506021] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.512084] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.519020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.525020] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.546021] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.555893] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.561921] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.577025] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.606019] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.619611] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.622598] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.625532] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.628474] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.631272] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.638037] iommu: Default domain type: Passthrough [ 0.639526] SCSI subsystem initialized [ 0.640188] ACPI: bus type USB registered [ 0.642261] usbcore: registered new interface driver usbfs [ 0.646131] usbcore: registered new interface driver hub [ 0.648170] usbcore: registered new device driver usb [ 0.651218] pps_core: LinuxPPS API ver. 1 registered [ 0.653016] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.657068] PTP clock support registered [ 0.660050] EDAC MC: Ver: 3.0.0 [ 0.661594] PCI: Using ACPI for IRQ routing [ 0.664875] NetLabel: Initializing [ 0.666018] NetLabel: domain hash size = 128 [ 0.668018] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.670095] NetLabel: unlabeled traffic allowed by default [ 0.673179] vgaarb: loaded [ 0.675346] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.677017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.683543] clocksource: Switched to clocksource kvm-clock [ 0.801812] VFS: Disk quotas dquot_6.6.0 [ 0.802908] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.805402] *** VALIDATE ramfs *** [ 0.806831] *** VALIDATE hugetlbfs *** [ 0.808643] pnp: PnP ACPI init [ 0.811916] pnp: PnP ACPI: found 6 devices [ 0.833179] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.836847] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.840438] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.842461] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.845571] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.848106] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.851266] NET: Registered protocol family 2 [ 0.853886] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.859218] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.863690] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.870051] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.874445] TCP: Hash tables configured (established 65536 bind 65536) [ 0.877234] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.879977] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.883287] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.886691] NET: Registered protocol family 1 [ 0.890268] RPC: Registered named UNIX socket transport module. [ 0.892316] RPC: Registered udp transport module. [ 0.893995] RPC: Registered tcp transport module. [ 0.895652] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.898078] NET: Registered protocol family 44 [ 0.900068] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.902830] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.904925] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.907250] PCI: CLS 0 bytes, default 64 [ 0.908976] Unpacking initramfs... [ 2.458658] debug: unmapping init [mem 0xffff907dbcc64000-0xffff907dbffcffff] [ 2.468659] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.471585] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.475415] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.969618] Initialise system trusted keyrings [ 2.971707] Key type blacklist registered [ 2.973482] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.981743] zbud: loaded [ 2.985301] *** VALIDATE nfs *** [ 2.986287] *** VALIDATE nfs4 *** [ 2.987626] pstore: using deflate compression [ 2.992499] Platform Keyring initialized [ 3.106793] NET: Registered protocol family 38 [ 3.111916] Key type asymmetric registered [ 3.113153] Asymmetric key parser 'x509' registered [ 3.114830] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.118910] io scheduler mq-deadline registered [ 3.120654] io scheduler kyber registered [ 3.121883] io scheduler bfq registered [ 3.124263] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.128924] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.132476] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.135765] ACPI: Power Button [PWRF] [ 3.141352] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.147933] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.186876] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.216594] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.248919] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.254654] Non-volatile memory driver v1.3 [ 3.256229] Linux agpgart interface v0.103 [ 3.307448] virtio_blk virtio1: [vda] 145808 512-byte logical blocks (74.7 MB/71.2 MiB) [ 3.311523] vda: detected capacity change from 0 to 74653696 [ 3.322826] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.325248] vdb: detected capacity change from 0 to 1073741824 [ 3.333546] libphy: Fixed MDIO Bus: probed [ 3.338042] usbcore: registered new interface driver usbserial_generic [ 3.340493] usbserial: USB Serial support registered for generic [ 3.342227] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.345565] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.347138] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.349642] mousedev: PS/2 mouse device common for all mice [ 3.351813] rtc_cmos 00:05: RTC can wake from S4 [ 3.354911] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.355242] rtc_cmos 00:05: registered as rtc0 [ 3.359373] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.363220] intel_pstate: CPU model not supported [ 3.364223] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.368805] hid: raw HID events driver (C) Jiri Kosina [ 3.371152] usbcore: registered new interface driver usbhid [ 3.373583] usbhid: USB HID core driver [ 3.375301] drop_monitor: Initializing network drop monitor service [ 3.375330] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.376929] Initializing XFRM netlink socket [ 3.383937] NET: Registered protocol family 10 [ 3.387450] Segment Routing with IPv6 [ 3.388981] NET: Registered protocol family 17 [ 3.392174] mpls_gso: MPLS GSO support [ 3.401676] RAS: Correctable Errors collector initialized. [ 3.403898] AVX version of gcm_enc/dec engaged. [ 3.405444] AES CTR mode by8 optimization enabled [ 3.482151] sched_clock: Marking stable (3482119445, 0)->(4449907682, -967788237) [ 3.485319] registered taskstats version 1 [ 3.487227] Loading compiled-in X.509 certificates [ 3.489137] zswap: loaded using pool lzo/zbud [ 3.516055] Key type big_key registered [ 3.528401] Key type encrypted registered [ 3.529967] ima: No TPM chip found, activating TPM-bypass! [ 3.532242] ima: Allocated hash algorithm: sha1 [ 3.533822] ima: No architecture policies found [ 3.535619] evm: Initialising EVM extended attributes: [ 3.536922] evm: security.selinux [ 3.537829] evm: security.ima [ 3.538840] evm: security.capability [ 3.540082] evm: HMAC attrs: 0x1 [ 3.542206] rtc_cmos 00:05: setting system clock to 2026-07-13 12:44:05 UTC (1783946645) [ 3.548196] debug: unmapping init [mem 0xffffffff97803000-0xffffffff979fffff] [ 3.550831] debug: unmapping init [mem 0xffffffff96582000-0xffffffff96858fff] [ 3.558363] Write protecting the kernel read-only data: 28672k [ 3.561478] debug: unmapping init [mem 0xffffffff94c03000-0xffffffff94dfffff] [ 3.563974] debug: unmapping init [mem 0xffffffff95514000-0xffffffff955fffff] [ 3.593863] 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.604151] systemd[1]: Detected virtualization kvm. [ 3.606491] systemd[1]: Detected architecture x86-64. [ 3.608567] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.636233] systemd[1]: No hostname configured. [ 3.638103] systemd[1]: Set hostname to . [ 3.639944] random: systemd: uninitialized urandom read (16 bytes read) [ 3.643113] systemd[1]: Initializing machine ID from random generator. [ 3.688884] random: ln: uninitialized urandom read (6 bytes read) [ 3.782367] random: systemd: uninitialized urandom read (16 bytes read) [ 3.786020] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.792378] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.797835] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Swap. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Listening on Journal Socket. Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Journal Service. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.490409] device-mapper: uevent: version 1.0.3 [ 4.492397] 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... [ 5.382340] virtio_net virtio0 ens2: renamed from eth0 [ 5.395534] scsi host0: ata_piix [ 5.426673] scsi host1: ata_piix [ 5.428289] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.430261] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.799275] dracut-initqueue[581]: RTNETLINK answers: File exists [ 10.061334] random: crng init done [ 10.063773] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 12.656492] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 15.249436] printk: systemd: 20 output lines suppressed due to ratelimiting [ 15.726295] SELinux: Disabled at runtime. [ 15.827569] 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) [ 15.845996] systemd[1]: Detected virtualization kvm. [ 15.849934] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 17.168269] systemd[1]: initrd-switch-root.service: Succeeded. [ 17.172050] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 17.177560] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 17.186691] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 17.192814] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 17.207771] systemd[1]: Starting Journal Service... Starting Journal Service... [ 17.224341] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting POSIX Message Queue File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-getty.slice. Mounting Huge Pages File System... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Mounting Kernel Debug File System... [ OK ] Stopped target Initrd Root File System. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Reached target Paths. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. Starting Apply Kernel Variables... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Starting Remount Root and Kernel File S[ 17.716928] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS ystems... [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... 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. [ 18.500395] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 19.532996] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 19.583568] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 20.125578] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 20.298238] EDAC sbridge: Ver: 1.1.2 [ 23.672947] Key type dns_resolver registered [* ] A start job is running for Configur…-only root support (7s / no limit)[ 24.392720] NFS: Registering the id_resolver key type [ 24.416937] Key type id_resolver registered [ 24.434292] Key type id_legacy registered [** ] A start job is running for Configur…-only root support (7s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Login Service. [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ 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 System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg438-client login: [ 89.322965] libcfs: loading out-of-tree module taints kernel. [ 89.593650] Key type ._llcrypt registered [ 89.597366] Key type .llcrypt registered [ 90.104425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 90.133855] alg: No test for adler32 (adler32-zlib) [ 91.654116] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 92.707555] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 94.567259] Key type lgssc registered [ 97.008315] Lustre: Echo OBD driver; http://www.lustre.org/ [ 102.661092] hrtimer: interrupt took 3863453 ns [ 238.966080] Lustre: Mounted lustre-client [ 243.791524] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 259.871457] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing check_logdir /tmp/testlogs/ [ 264.674499] Lustre: lustre-OST0000-osc-ffff907e1a8fa800: disconnect after 24s idle [ 266.513379] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing yml_node [ 273.899981] Lustre: DEBUG MARKER: Client: 2.17.54.162 [ 277.929582] Lustre: DEBUG MARKER: MDS: 2.17.54.162 [ 281.841444] Lustre: DEBUG MARKER: OSS: 2.17.54.162 [ 284.034690] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Jul 13 08:48:44 EDT 2026 [ 302.183695] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 304.278060] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 307.950661] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 318.299905] Lustre: Unmounted lustre-client [ 401.542883] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 429.699608] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 457.725259] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 08:51:37 (1783947097) [ 499.270994] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 538.144590] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 564.668300] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 604.301552] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 619.817584] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 08:54:19 (1783947259) [ 621.597130] Lustre: DEBUG MARKER: SKIP: conf-sanity test_122a needs >= 2 MDTs [ 623.647406] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 08:54:23 (1783947263) [ 643.657923] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 663.927608] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 664.743853] Lustre: Mounted lustre-client [ 676.179777] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 08:55:16 (1783947316) [ 688.037645] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 08:55:28 (1783947328) [ 696.498062] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 08:55:37 (1783947337) [ 708.798438] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 08:55:49 (1783947349) [ 732.429276] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 08:56:12 (1783947372) [ 746.934850] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 08:56:27 (1783947387) [ 762.054830] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 08:56:42 (1783947402) [ 771.166838] Lustre: Unmounted lustre-client [ 771.606806] Lustre: Mounted lustre-client [ 774.158585] Lustre: Unmounted lustre-client [ 792.060203] Key type lgssc unregistered [ 792.325328] LNet: 20799:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 792.336909] LNetError: 20799:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 792.354174] LNet: Removed LNI 192.168.204.38@tcp [ 793.251246] Key type .llcrypt unregistered [ 793.253494] Key type ._llcrypt unregistered [ 819.325173] Key type ._llcrypt registered [ 819.329540] Key type .llcrypt registered [ 819.812069] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 819.837381] alg: No test for adler32 (adler32-zlib) [ 820.923894] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 821.267787] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 823.023775] Key type lgssc registered [ 824.328308] Lustre: Echo OBD driver; http://www.lustre.org/ [ 890.094309] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 914.609144] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 941.191638] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 08:59:41 (1783947581) [ 960.741214] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 982.948760] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 984.509622] Lustre: Mounted lustre-client [ 1114.955572] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 09:02:35 (1783947755) [ 1159.674473] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 09:03:19 (1783947799) [ 1169.474651] Lustre: Unmounted lustre-client [ 1225.443822] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1245.837384] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1246.396058] Lustre: Mounted lustre-client [ 1252.875545] Lustre: Unmounted lustre-client [ 1271.114918] Key type lgssc unregistered [ 1271.347105] LNet: 30069:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1271.363743] LNetError: 30069:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1271.373590] LNet: Removed LNI 192.168.204.38@tcp [ 1272.022060] Key type .llcrypt unregistered [ 1272.026987] Key type ._llcrypt unregistered [ 1288.287383] Key type ._llcrypt registered [ 1288.293453] Key type .llcrypt registered [ 1290.034522] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 09:05:30 (1783947930) [ 1292.992371] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1293.081939] alg: No test for adler32 (adler32-zlib) [ 1294.176824] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1294.445203] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 1296.191261] Key type lgssc registered [ 1297.627328] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1337.595062] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1359.949619] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1362.818251] Lustre: Mounted lustre-client [ 1373.227408] Lustre: Unmounted lustre-client [ 1425.878215] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1445.979425] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1446.741534] Lustre: Mounted lustre-client [ 1452.874067] Lustre: Unmounted lustre-client [ 1470.301911] Key type lgssc unregistered [ 1470.589134] LNet: 34440:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1470.600401] LNetError: 34440:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1470.622984] LNet: Removed LNI 192.168.204.38@tcp [ 1471.290956] Key type .llcrypt unregistered [ 1471.293591] Key type ._llcrypt unregistered [ 1487.009296] Key type ._llcrypt registered [ 1487.012990] Key type .llcrypt registered [ 1488.342410] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 09:08:48 (1783948128) [ 1490.587055] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1490.616337] alg: No test for adler32 (adler32-zlib) [ 1491.562174] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1491.744565] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 1493.487253] Key type lgssc registered [ 1494.785941] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1532.581100] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1551.639498] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1553.306930] Lustre: Mounted lustre-client [ 1657.207397] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 09:11:37 (1783948297) [ 1658.876763] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs >= 2 MDTs [ 1660.670651] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 09:11:41 (1783948301) [ 1663.197674] Lustre: Unmounted lustre-client [ 1679.328314] Key type lgssc unregistered [ 1679.549917] LNet: 39168:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1679.568557] LNetError: 39168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1679.592504] LNet: Removed LNI 192.168.204.38@tcp [ 1680.281590] Key type .llcrypt unregistered [ 1680.284461] Key type ._llcrypt unregistered [ 1707.520556] Key type ._llcrypt registered [ 1707.537636] Key type .llcrypt registered [ 1707.852572] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1707.869717] alg: No test for adler32 (adler32-zlib) [ 1709.086705] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1709.466755] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 1711.135272] Key type lgssc registered [ 1712.417649] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1745.173604] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 09:13:05 (1783948385) [ 1753.912946] Key type lgssc unregistered [ 1754.207703] LNet: 41452:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1754.214733] LNetError: 41452:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1754.230941] LNet: Removed LNI 192.168.204.38@tcp [ 1754.964977] Key type .llcrypt unregistered [ 1754.967982] Key type ._llcrypt unregistered [ 1767.759859] Key type ._llcrypt registered [ 1767.768420] Key type .llcrypt registered [ 1768.123477] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1768.138516] alg: No test for adler32 (adler32-zlib) [ 1769.233540] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1769.473430] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 1771.175196] Key type lgssc registered [ 1772.122644] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1803.145775] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1822.951302] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1824.720577] Lustre: Mounted lustre-client [ 1869.556305] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 09:15:09 (1783948509) [ 1871.330406] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 1873.292491] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 09:15:13 (1783948513) [ 1874.799318] Lustre: Unmounted lustre-client [ 1913.450356] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1976.542277] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 09:16:56 (1783948616) [ 1978.413681] Lustre: DEBUG MARKER: SKIP: conf-sanity test_130 needs >= 2 MDTs [ 1980.725220] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID and inheritance flag ========================================================== 09:17:00 (1783948620) [ 2046.340554] Lustre: Mounted lustre-client [ 2051.022874] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2072.032686] Lustre: lustre-OST0000-osc-ffff907e03446000: disconnect after 23s idle [ 2159.264365] Lustre: Unmounted lustre-client [ 2270.960969] Lustre: Mounted lustre-client [ 2277.449382] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2341.422382] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 09:23:01 (1783948981) [ 2344.340869] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2345.016264] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 2364.594592] Lustre: Unmounted lustre-client [ 2506.557144] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 09:25:46 (1783949146) [ 2508.715552] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 2511.573344] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 09:25:51 (1783949151) [ 2590.974894] Lustre: Mounted lustre-client [ 2596.635386] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3166.856480] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 09:36:47 (1783949807) [ 3173.592812] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3173.598374] Lustre: Skipped 1 previous similar message [ 3183.964616] Lustre: Unmounted lustre-client [ 3283.064745] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3307.248646] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3308.066501] Lustre: Mounted lustre-client [ 5759.025565] Lustre: 75524:0:(llog_cat.c:310:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff907e02c48000: catlog [0xa:0x5:0x0] crosses index zero [ 5782.715647] Lustre: Unmounted lustre-client [ 5800.571239] Key type lgssc unregistered [ 5800.861813] LNet: 83726:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5800.868715] LNetError: 83726:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5800.889240] LNet: Removed LNI 192.168.204.38@tcp [ 5801.721159] Key type .llcrypt unregistered [ 5801.723267] Key type ._llcrypt unregistered [ 5811.529257] Key type ._llcrypt registered [ 5811.533796] Key type .llcrypt registered [ 5813.433190] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 10:20:53 (1783952453) [ 5815.191756] Lustre: DEBUG MARKER: SKIP: conf-sanity test_136 needs >= 2 MDTs [ 5817.169824] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 10:20:57 (1783952457) [ 5819.649761] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 5822.041561] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 10:21:02 (1783952462) [ 5823.714894] Lustre: DEBUG MARKER: SKIP: conf-sanity test_140 needs >= 2 MDTs [ 5825.739124] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 10:21:06 (1783952466) [ 5828.609193] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5828.638967] alg: No test for adler32 (adler32-zlib) [ 5829.816638] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 5830.109256] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 5831.840316] Key type lgssc registered [ 5833.251578] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5871.910365] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5895.884466] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5897.732571] Lustre: Mounted lustre-client [ 5900.124305] LustreError: 86819: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 [ 5907.067963] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 10:22:27 (1783952547) [ 5909.337732] Lustre: Unmounted lustre-client [ 5927.139885] Key type lgssc unregistered [ 5927.388564] LNet: 87766:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5927.395672] LNetError: 87766:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5928.426465] LNet: Removed LNI 192.168.204.38@tcp [ 5929.193427] Key type .llcrypt unregistered [ 5929.195790] Key type ._llcrypt unregistered [ 5943.262224] Key type ._llcrypt registered [ 5943.269405] Key type .llcrypt registered [ 5943.797552] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5943.821074] alg: No test for adler32 (adler32-zlib) [ 5944.981815] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 5945.246161] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 5947.015280] Key type lgssc registered [ 5948.252728] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6026.218151] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6051.683742] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6141.346702] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6165.820877] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6194.148773] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 10:27:14 (1783952834) [ 6203.772658] Key type lgssc unregistered [ 6204.076825] LNet: 93441:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6204.083153] LNetError: 93441:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6204.102138] LNet: Removed LNI 192.168.204.38@tcp [ 6205.129604] Key type .llcrypt unregistered [ 6205.132833] Key type ._llcrypt unregistered [ 6220.180800] Key type ._llcrypt registered [ 6220.183948] Key type .llcrypt registered [ 6220.574791] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6220.598042] alg: No test for adler32 (adler32-zlib) [ 6221.673482] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 6221.923467] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 6223.647214] Key type lgssc registered [ 6225.500545] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6265.785828] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6288.013602] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6375.102293] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6400.817406] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6433.764141] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 10:31:13 (1783953073) [ 6435.603405] Lustre: DEBUG MARKER: SKIP: conf-sanity test_152 needs >= 2 MDTs [ 6437.909659] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 10:31:18 (1783953078) [ 6522.095434] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6548.147975] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6596.185461] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6621.255711] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6623.881051] LNetError: 93849:0:(lib-move.c:2120:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 6626.335205] Lustre: Mounted lustre-client [ 6629.719926] Lustre: Unmounted lustre-client [ 6652.996267] Key type lgssc unregistered [ 6677.599543] LNet: 1 local NIs in recovery (showing 1): 192.168.204.38@tcp [ 6681.952507] LNet: 102892:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6681.962510] LNetError: 102892:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6755.690349] LNet: Removed LNI 192.168.204.38@tcp [ 6756.583915] Key type .llcrypt unregistered [ 6756.590872] Key type ._llcrypt unregistered [ 6774.988886] Key type ._llcrypt registered [ 6774.992606] Key type .llcrypt registered [ 6776.610718] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 10:36:56 (1783953416) [ 6795.445852] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6795.483103] alg: No test for adler32 (adler32-zlib) [ 6796.573840] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 6796.899444] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 6798.591802] Key type lgssc registered [ 6800.092361] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6863.770412] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6897.270671] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7013.259978] Lustre: Mounted lustre-client [ 7018.874374] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 7026.370621] Lustre: Unmounted lustre-client [ 7026.478388] LNetError: 104032:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5425:32ff:fec1:139a/1023: rc = -22 [ 7026.485242] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 7026.726824] Lustre: Mounted lustre-client [ 7026.929990] Lustre: Unmounted lustre-client [ 7027.787648] LNetError: 104030:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5425:32ff:fec1:139a/1023: rc = -22 [ 7027.803492] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 7028.079865] Lustre: Mounted lustre-client [ 7028.082518] Lustre: Skipped 1 previous similar message [ 7028.251462] Lustre: Unmounted lustre-client [ 7028.254016] Lustre: Skipped 1 previous similar message [ 7030.307905] LNetError: 104030:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5425:32ff:fec1:139a/1023: rc = -22 [ 7030.323046] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 7030.610915] Lustre: Mounted lustre-client [ 7030.615496] Lustre: Skipped 3 previous similar messages [ 7030.770415] Lustre: Unmounted lustre-client [ 7030.773692] Lustre: Skipped 3 previous similar messages [ 7031.423270] Lustre: 108718: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 [ 7031.987726] Lustre: 108744: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 [ 7040.419992] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 10:41:20 (1783953680) [ 7084.703410] LNet: 1 local NIs in recovery (showing 1): 192.168.204.38@tcp [ 7135.569911] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7162.448443] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7213.665123] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7240.621179] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7246.241201] LustreError: 112910:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 7294.623372] LNet: 1 local NIs in recovery (showing 1): 192.168.204.38@tcp [ 7370.403630] LNet: 1 local NIs in recovery (showing 1): 192.168.204.38@tcp [ 7385.055960] 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 [ 7385.074766] Lustre: Unmounted lustre-client [ 7385.081713] Lustre: Skipped 3 previous similar messages [ 7385.098763] LustreError: 112910:0:(super25.c:178:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 7405.795374] Key type lgssc unregistered [ 7427.681473] LNet: 113318:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7427.711716] LNetError: 113318:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7501.487496] LNet: Removed LNI 192.168.204.38@tcp [ 7502.488158] Key type .llcrypt unregistered [ 7502.493654] Key type ._llcrypt unregistered [ 7521.578421] Key type ._llcrypt registered [ 7521.583993] Key type .llcrypt registered [ 7523.187808] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 10:49:23 (1783954163) [ 7540.127288] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7540.150137] alg: No test for adler32 (adler32-zlib) [ 7541.339858] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 7541.630246] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 7543.359212] Key type lgssc registered [ 7544.802941] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7677.145219] Lustre: Mounted lustre-client [ 7682.721552] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 7701.921791] Lustre: Unmounted lustre-client [ 7839.516180] Lustre: Mounted lustre-client [ 7846.176409] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 7853.676988] Lustre: Unmounted lustre-client [ 7890.304775] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 10:55:30 (1783954530) [ 7964.000644] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7990.796088] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8089.112438] Lustre: Mounted lustre-client [ 8094.821411] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8109.741906] Lustre: Unmounted lustre-client [ 8213.523286] Lustre: Mounted lustre-client [ 8219.612734] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8239.080502] Lustre: lustre-OST0001-osc-ffff907e10a26800: disconnect after 23s idle [ 8241.557543] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 11:01:21 (1783954881) [ 8243.292561] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8253.623225] Lustre: Unmounted lustre-client [ 8395.251838] Lustre: Mounted lustre-client [ 8400.949604] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8410.455540] Lustre: Unmounted lustre-client [ 8411.115944] Lustre: Mounted lustre-client [ 8421.228659] Lustre: Unmounted lustre-client [ 8423.559804] Lustre: DEBUG MARKER: == conf-sanity test 157a: test allow_register for MDT registration and MGS restart ========================================================== 11:04:23 (1783955063) [ 8471.863126] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8493.910775] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8494.726500] Lustre: Mounted lustre-client [ 8591.866474] LustreError: lustre-OST0001-osc-ffff907e10a67800: operation ost_connect to node 192.168.204.138@tcp failed: rc = -19 [ 8596.982997] Lustre: lustre-MDT0000-mdc-ffff907e10a67800: Connection to lustre-MDT0000 (at 192.168.204.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8627.685520] LustreError: MGC192.168.204.138@tcp: Connection to MGS (at 192.168.204.138@tcp) was lost; in progress operations using this service will fail [ 8627.705258] Lustre: Evicted from MGS (at 192.168.204.138@tcp) after server handle changed from 0xb288a22342bfd213 to 0xb288a22342bfd500 [ 8627.720898] Lustre: MGC192.168.204.138@tcp: Connection restored to 192.168.204.138@tcp (at 192.168.204.138@tcp) [ 8637.951230] LustreError: lustre-MDT0000-mdc-ffff907e10a67800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8637.968890] Lustre: lustre-MDT0000-mdc-ffff907e10a67800: Connection restored to 192.168.204.138@tcp (at 192.168.204.138@tcp) [ 8680.069725] Lustre: Unmounted lustre-client [ 8700.684539] Key type lgssc unregistered [ 8701.123773] LNet: 136644:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8701.139119] LNetError: 136644:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8701.162609] LNet: Removed LNI 192.168.204.38@tcp [ 8702.316532] Key type .llcrypt unregistered [ 8702.319382] Key type ._llcrypt unregistered [ 8715.869571] Key type ._llcrypt registered [ 8715.872566] Key type .llcrypt registered [ 8717.241719] Lustre: DEBUG MARKER: == conf-sanity test 157b: verify allow_register (block new OSTs, allow existing) ========================================================== 11:09:17 (1783955357) [ 8719.875759] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8719.961152] alg: No test for adler32 (adler32-zlib) [ 8721.167215] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 8721.467942] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 8723.175267] Key type lgssc registered [ 8724.676944] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8767.626811] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8796.460982] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8799.566223] Lustre: Mounted lustre-client [ 8897.039809] LustreError: lustre-OST0001-osc-ffff907e10a64000: operation ost_connect to node 192.168.204.138@tcp failed: rc = -19 [ 9026.125643] Lustre: Unmounted lustre-client [ 9044.980484] Key type lgssc unregistered [ 9045.268131] LNet: 142065:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9045.289588] LNetError: 142065:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9045.340140] LNet: Removed LNI 192.168.204.38@tcp [ 9046.274301] Key type .llcrypt unregistered [ 9046.278426] Key type ._llcrypt unregistered [ 9058.587582] Key type ._llcrypt registered [ 9058.589158] Key type .llcrypt registered [ 9060.191722] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 11:15:00 (1783955700) [ 9086.132739] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9086.178155] alg: No test for adler32 (adler32-zlib) [ 9087.365973] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 9087.725356] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 9089.439207] Key type lgssc registered [ 9090.798361] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9157.111206] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9182.511059] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9221.208040] Key type lgssc unregistered [ 9221.494725] LNet: 146109:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9221.507807] LNetError: 146109:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9221.546523] LNet: Removed LNI 192.168.204.38@tcp [ 9222.216751] Key type .llcrypt unregistered [ 9222.219578] Key type ._llcrypt unregistered [ 9334.987624] Key type ._llcrypt registered [ 9334.990306] Key type .llcrypt registered [ 9335.307261] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9335.321585] alg: No test for adler32 (adler32-zlib) [ 9336.385255] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 9336.679576] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 9338.439274] Key type lgssc registered [ 9340.039714] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9386.958903] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 11:20:27 (1783956027) [ 9412.270857] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9435.702536] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9437.424064] Lustre: Mounted lustre-client [ 9439.552740] Lustre: Unmounted lustre-client [ 9439.969541] Lustre: Mounted lustre-client [ 9440.157744] Lustre: Unmounted lustre-client [ 9449.073432] Lustre: Unmounted lustre-client [ 9468.028583] Key type lgssc unregistered [ 9468.344417] LNet: 150170:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9468.351516] LNetError: 150170:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9468.370938] LNet: Removed LNI 192.168.204.38@tcp [ 9469.082423] Key type .llcrypt unregistered [ 9469.087210] Key type ._llcrypt unregistered [ 9481.875614] Key type ._llcrypt registered [ 9481.880236] Key type .llcrypt registered [ 9483.380910] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 11:22:03 (1783956123) [ 9487.456435] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9487.478139] alg: No test for adler32 (adler32-zlib) [ 9488.690336] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 9489.040511] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 9490.752361] Key type lgssc registered [ 9492.385932] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9529.347881] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9550.285502] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9553.062832] Lustre: Mounted lustre-client [ 9563.939681] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9566.244442] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9573.868712] Lustre: lustre-MDT0000-mdc-ffff907e041b0000: Connection to lustre-MDT0000 (at 192.168.204.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9594.274116] Lustre: 150838:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783956220/real 1783956220] req@0000000028ec47fb x1870613582975872/t0(0) o400->MGC192.168.204.138@tcp@192.168.204.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1783956236 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9594.318149] LustreError: MGC192.168.204.138@tcp: Connection to MGS (at 192.168.204.138@tcp) was lost; in progress operations using this service will fail [ 9625.076699] Lustre: Evicted from MGS (at 192.168.204.138@tcp) after server handle changed from 0xea49fe72562162d3 to 0xea49fe7256216454 [ 9625.112903] Lustre: MGC192.168.204.138@tcp: Connection restored to 192.168.204.138@tcp (at 192.168.204.138@tcp) [ 9648.638884] LustreError: lustre-MDT0000-mdc-ffff907e041b0000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9648.664657] Lustre: lustre-MDT0000-mdc-ffff907e041b0000: Connection restored to 192.168.204.138@tcp (at 192.168.204.138@tcp) [ 9657.200508] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9659.690526] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [ 9666.280053] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9667.724168] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9671.230579] Lustre: Unmounted lustre-client [ 9690.671697] Key type lgssc unregistered [ 9690.987976] LNet: 154864:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9690.999388] LNetError: 154864:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9691.027245] LNet: Removed LNI 192.168.204.38@tcp [ 9691.926859] Key type .llcrypt unregistered [ 9691.937366] Key type ._llcrypt unregistered [ 9722.760397] Key type ._llcrypt registered [ 9722.789916] Key type .llcrypt registered [ 9723.255905] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9723.283909] alg: No test for adler32 (adler32-zlib) [ 9724.556722] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 9724.947932] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [ 9726.759291] Key type lgssc registered [ 9727.927637] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9791.825126] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9816.674569] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9855.810202] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 11:28:16 (1783956496) [ 9930.023456] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9955.593879] Lustre: DEBUG MARKER: oleg438-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9957.652200] Lustre: Mounted lustre-client [ 9962.521161] Lustre: Mounted lustre-client [ 9963.803679] Lustre: Mounted lustre-client [ 9963.806532] Lustre: Skipped 1 previous similar message [ 9968.801555] Lustre: Unmounted lustre-client [ 9970.832215] Lustre: Unmounted lustre-client [ 9972.555645] Lustre: Unmounted lustre-client [ 9975.877745] Lustre: Unmounted lustre-client [ 9975.886246] Lustre: Skipped 1 previous similar message [ 9985.337497] Lustre: Unmounted lustre-client [10004.118650] Key type lgssc unregistered [10004.456885] LNet: 162161:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10004.469638] LNetError: 162161:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10004.491404] LNet: Removed LNI 192.168.204.38@tcp [10005.382844] Key type .llcrypt unregistered [10005.386117] Key type ._llcrypt unregistered [10016.939309] Key type ._llcrypt registered [10016.940971] Key type .llcrypt registered [10018.530795] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 11:30:58 (1783956658) [10030.325337] Key type .llcrypt unregistered [10030.327430] Key type ._llcrypt unregistered [10031.285286] Key type ._llcrypt registered [10031.288534] Key type .llcrypt registered [10031.751789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [10031.775528] alg: No test for adler32 (adler32-zlib) [10032.872247] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10033.207108] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10034.927209] Key type lgssc registered [10036.505367] Lustre: Echo OBD driver; http://www.lustre.org/ [10061.744612] Key type lgssc unregistered [10062.031338] LNet: 164186:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10062.038599] LNetError: 164186:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10062.054610] LNet: Removed LNI 192.168.204.38@tcp [10063.035823] Key type .llcrypt unregistered [10063.038171] Key type ._llcrypt unregistered [10063.615563] Key type ._llcrypt registered [10063.617596] Key type .llcrypt registered [10065.274168] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 11:31:45 (1783956705) [10077.161641] Key type .llcrypt unregistered [10077.163535] Key type ._llcrypt unregistered [10078.834666] Key type ._llcrypt registered [10078.837932] Key type .llcrypt registered [10079.652313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10079.671565] alg: No test for adler32 (adler32-zlib) [10080.777415] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10081.017913] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10082.679197] Key type lgssc registered [10084.181452] Lustre: Echo OBD driver; http://www.lustre.org/ [10096.287905] Key type lgssc unregistered [10096.566289] LNet: 165608:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10096.582941] LNetError: 165608:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10096.603451] LNet: Removed LNI 192.168.204.38@tcp [10097.053713] Key type .llcrypt unregistered [10097.056166] Key type ._llcrypt unregistered [10104.771102] Key type ._llcrypt registered [10104.772731] Key type .llcrypt registered [10105.191476] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10105.236845] alg: No test for adler32 (adler32-zlib) [10106.734123] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10106.987551] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10108.639287] Key type lgssc registered [10110.079700] Lustre: Echo OBD driver; http://www.lustre.org/ [10136.980346] Key type lgssc unregistered [10137.277873] LNet: 167278:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10137.290273] LNetError: 167278:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10137.326796] LNet: Removed LNI 192.168.204.38@tcp [10138.122326] Key type .llcrypt unregistered [10138.124750] Key type ._llcrypt unregistered [10138.533552] Key type ._llcrypt registered [10138.535266] Key type .llcrypt registered [10140.266232] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 11:33:00 (1783956780) [10150.182319] Key type .llcrypt unregistered [10150.190113] Key type ._llcrypt unregistered [10151.466248] Key type ._llcrypt registered [10151.474155] Key type .llcrypt registered [10151.909458] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10151.938525] alg: No test for adler32 (adler32-zlib) [10153.104509] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10153.477041] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10155.265160] Key type lgssc registered [10156.897564] Lustre: Echo OBD driver; http://www.lustre.org/ [10170.690248] Key type lgssc unregistered [10170.932159] LNet: 168694:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10170.937924] LNetError: 168694:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10170.950241] LNet: Removed LNI 192.168.204.38@tcp [10171.694122] Key type .llcrypt unregistered [10171.697359] Key type ._llcrypt unregistered [10179.139783] Key type ._llcrypt registered [10179.146725] Key type .llcrypt registered [10179.622179] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10179.639955] alg: No test for adler32 (adler32-zlib) [10180.745601] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10181.034220] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10182.719969] Key type lgssc registered [10184.145535] Lustre: Echo OBD driver; http://www.lustre.org/ [10196.897663] Key type lgssc unregistered [10197.134463] LNet: 169905:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10197.140352] LNetError: 169905:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10197.153704] LNet: Removed LNI 192.168.204.38@tcp [10198.039970] Key type .llcrypt unregistered [10198.044061] Key type ._llcrypt unregistered [10207.377923] Key type ._llcrypt registered [10207.385038] Key type .llcrypt registered [10207.904278] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10207.914892] alg: No test for adler32 (adler32-zlib) [10209.144978] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10209.464613] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10211.303195] Key type lgssc registered [10212.603058] Lustre: Echo OBD driver; http://www.lustre.org/ [10227.530982] Key type lgssc unregistered [10227.808677] LNet: 171114:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10227.821254] LNetError: 171114:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10227.854268] LNet: Removed LNI 192.168.204.38@tcp [10228.448779] Key type .llcrypt unregistered [10228.453935] Key type ._llcrypt unregistered [10235.276907] Key type ._llcrypt registered [10235.280848] Key type .llcrypt registered [10235.724305] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10235.734768] alg: No test for adler32 (adler32-zlib) [10236.789273] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10237.062195] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10238.751305] Key type lgssc registered [10239.966450] Lustre: Echo OBD driver; http://www.lustre.org/ [10258.856974] Key type lgssc unregistered [10259.136670] LNet: 172788:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10259.154517] LNetError: 172788:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10259.193110] LNet: Removed LNI 192.168.204.38@tcp [10259.873071] Key type .llcrypt unregistered [10259.876964] Key type ._llcrypt unregistered [10260.250213] Key type ._llcrypt registered [10260.252826] Key type .llcrypt registered [10261.764625] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 11:35:02 (1783956902) [10271.017836] Key type .llcrypt unregistered [10271.024610] Key type ._llcrypt unregistered [10272.125569] Key type ._llcrypt registered [10272.131601] Key type .llcrypt registered [10272.718606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10272.741867] alg: No test for adler32 (adler32-zlib) [10273.818267] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10274.053668] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10275.791205] Key type lgssc registered [10276.952673] Lustre: Echo OBD driver; http://www.lustre.org/ [10291.068099] Key type lgssc unregistered [10291.311663] LNet: 174207:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10291.319481] LNetError: 174207:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10291.361878] LNet: Removed LNI 192.168.204.38@tcp [10292.109551] Key type .llcrypt unregistered [10292.111154] Key type ._llcrypt unregistered [10299.639282] Key type ._llcrypt registered [10299.653863] Key type .llcrypt registered [10300.074417] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10300.101879] alg: No test for adler32 (adler32-zlib) [10301.278954] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10301.623443] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10303.335193] Key type lgssc registered [10304.756305] Lustre: Echo OBD driver; http://www.lustre.org/ [10320.469590] Key type lgssc unregistered [10320.670984] LNet: 175426:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10320.676772] LNetError: 175426:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10320.699710] LNet: Removed LNI 192.168.204.38@tcp [10321.280928] Key type .llcrypt unregistered [10321.282903] Key type ._llcrypt unregistered [10328.850211] Key type ._llcrypt registered [10328.955959] Key type .llcrypt registered [10329.256675] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10329.271464] alg: No test for adler32 (adler32-zlib) [10330.391238] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10330.670818] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10332.351253] Key type lgssc registered [10333.906687] Lustre: Echo OBD driver; http://www.lustre.org/ [10348.289255] Key type lgssc unregistered [10348.590177] LNet: 176638:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10348.602648] LNetError: 176638:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10348.637382] LNet: Removed LNI 192.168.204.38@tcp [10349.528348] Key type .llcrypt unregistered [10349.530774] Key type ._llcrypt unregistered [10357.312577] Key type ._llcrypt registered [10357.320515] Key type .llcrypt registered [10357.942305] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10357.969394] alg: No test for adler32 (adler32-zlib) [10359.171552] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10359.486754] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10361.199311] Key type lgssc registered [10362.802456] Lustre: Echo OBD driver; http://www.lustre.org/ [10377.110702] Key type lgssc unregistered [10377.415412] LNet: 177850:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10377.429632] LNetError: 177850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10377.443621] LNet: Removed LNI 192.168.204.38@tcp [10378.085598] Key type .llcrypt unregistered [10378.091124] Key type ._llcrypt unregistered [10385.467638] Key type ._llcrypt registered [10385.471860] Key type .llcrypt registered [10386.091986] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10386.109647] alg: No test for adler32 (adler32-zlib) [10387.229745] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10387.579971] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10389.263914] Key type lgssc registered [10390.744777] Lustre: Echo OBD driver; http://www.lustre.org/ [10406.354437] Key type lgssc unregistered [10406.812634] LNet: 179068:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10406.821521] LNetError: 179068:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10406.839970] LNet: Removed LNI 192.168.204.38@tcp [10407.713450] Key type .llcrypt unregistered [10407.719206] Key type ._llcrypt unregistered [10415.975233] Key type ._llcrypt registered [10415.983119] Key type .llcrypt registered [10416.579455] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10416.602139] alg: No test for adler32 (adler32-zlib) [10417.805420] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10418.161105] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10419.919438] Key type lgssc registered [10421.978905] Lustre: Echo OBD driver; http://www.lustre.org/ [10439.258361] Key type lgssc unregistered [10439.531387] LNet: 180281:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10439.538299] LNetError: 180281:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10439.560339] LNet: Removed LNI 192.168.204.38@tcp [10440.534703] Key type .llcrypt unregistered [10440.537631] Key type ._llcrypt unregistered [10463.089526] Key type ._llcrypt registered [10463.092635] Key type .llcrypt registered [10465.005147] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 11:38:24 (1783957104) [10474.907558] Key type .llcrypt unregistered [10474.910082] Key type ._llcrypt unregistered [10476.051507] Key type ._llcrypt registered [10476.055831] Key type .llcrypt registered [10476.907647] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10476.924788] alg: No test for adler32 (adler32-zlib) [10478.016428] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10478.214236] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10479.895287] Key type lgssc registered [10481.243838] Lustre: Echo OBD driver; http://www.lustre.org/ [10495.868744] Key type lgssc unregistered [10496.131567] LNet: 182428:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10496.142060] LNetError: 182428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10496.162687] LNet: Removed LNI 192.168.204.38@tcp [10496.798217] Key type .llcrypt unregistered [10496.803559] Key type ._llcrypt unregistered [10504.472338] Key type ._llcrypt registered [10504.530457] Key type .llcrypt registered [10504.942357] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10504.976290] alg: No test for adler32 (adler32-zlib) [10506.145530] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10506.441340] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10508.119199] Key type lgssc registered [10509.439504] Lustre: Echo OBD driver; http://www.lustre.org/ [10524.084423] Key type lgssc unregistered [10524.350617] LNet: 183652:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10524.366551] LNetError: 183652:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10524.388095] LNet: Removed LNI 192.168.204.38@tcp [10525.299186] Key type .llcrypt unregistered [10525.302056] Key type ._llcrypt unregistered [10534.002671] Key type ._llcrypt registered [10534.076059] Key type .llcrypt registered [10534.684797] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10534.717207] alg: No test for adler32 (adler32-zlib) [10535.983104] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10536.430633] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10538.231300] Key type lgssc registered [10540.349490] Lustre: Echo OBD driver; http://www.lustre.org/ [10555.293913] Key type lgssc unregistered [10555.608449] LNet: 184866:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10555.625804] LNetError: 184866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10555.637917] LNet: Removed LNI 192.168.204.38@tcp [10556.435341] Key type .llcrypt unregistered [10556.442338] Key type ._llcrypt unregistered [10565.044527] Key type ._llcrypt registered [10565.046477] Key type .llcrypt registered [10565.433554] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10565.463681] alg: No test for adler32 (adler32-zlib) [10566.695156] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10567.026987] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10568.799252] Key type lgssc registered [10570.336398] Lustre: Echo OBD driver; http://www.lustre.org/ [10592.916787] Key type lgssc unregistered [10593.199962] LNet: 186565:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10593.204993] LNetError: 186565:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10593.218271] LNet: Removed LNI 192.168.204.38@tcp [10593.974439] Key type .llcrypt unregistered [10593.979450] Key type ._llcrypt unregistered [10594.463678] Key type ._llcrypt registered [10594.467172] Key type .llcrypt registered [10595.932706] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 11:40:36 (1783957236) [10612.510290] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10612.562386] alg: No test for adler32 (adler32-zlib) [10613.767491] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10614.080515] LNet: Added LNI 192.168.204.38@tcp [8/256/0/180] [10615.807367] Key type lgssc registered [10617.308466] Lustre: Echo OBD driver; http://www.lustre.org/ [10817.698836] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 11:44:17 (1783957457) [10820.123700] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [10880.669964] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 10594 sec ========= 11:45:20 (1783957520) [10882.844652] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 11:45:22 (1783957522) === [10887.539733] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 11:45:27 (1783957527) === [10917.342571] Key type lgssc unregistered [10917.581938] LNet: 194237:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10917.593279] LNetError: 194237:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10917.628639] LNet: Removed LNI 192.168.204.38@tcp [10918.416694] Key type .llcrypt unregistered [10918.422186] Key type ._llcrypt unregistered