[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-8.fc42 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 429236412 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 0x00000000BFFE2421 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE22BD 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 00227D (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2331 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE23C1 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE23F9 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe22bd-0xbffe2330] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22bc] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2331-0xbffe23c0] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe23c1-0xbffe23f8] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe23f9-0xbffe2420] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002361] x2apic enabled [ 0.004020] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.007993] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008020] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009013] pid_max: default: 32768 minimum: 301 [ 0.010131] LSM: Security Framework initializing [ 0.011039] Yama: becoming mindful. [ 0.012020] SELinux: Initializing. [ 0.013074] *** VALIDATE selinux *** [ 0.022187] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027143] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028168] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029113] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030122] *** VALIDATE tmpfs *** [ 0.032353] *** VALIDATE proc *** [ 0.034026] *** VALIDATE cgroup *** [ 0.035012] *** VALIDATE cgroup2 *** [ 0.036260] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037152] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039028] Spectre V2 : User space: Vulnerable [ 0.040008] Speculative Store Bypass: Vulnerable [ 0.043036] debug: unmapping init [mem 0xffffffff9ae59000-0xffffffff9ae60fff] [ 0.046000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046669] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047028] ... version: 2 [ 0.048016] ... bit width: 48 [ 0.049010] ... generic registers: 4 [ 0.050011] ... value mask: 0000ffffffffffff [ 0.051017] ... max period: 00007fffffffffff [ 0.052014] ... fixed-purpose events: 3 [ 0.053014] ... event mask: 000000070000000f [ 0.054284] rcu: Hierarchical SRCU implementation. [ 0.056264] smp: Bringing up secondary CPUs ... [ 0.057568] x86: Booting SMP configuration: [ 0.058035] .... node #0, CPUs: #1 #2 #3 [ 0.068267] smp: Brought up 1 node, 4 CPUs [ 0.070013] smpboot: Max logical packages: 1 [ 0.071020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.107927] node 0 deferred pages initialised in 34ms [ 0.112068] devtmpfs: initialized [ 0.113348] x86/mm: Memory block size: 128MB [ 0.117257] gcov: version magic: 0x41383552 [ 0.120280] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.123060] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.125201] pinctrl core: initialized pinctrl subsystem [ 0.126165] [ 0.126606] ************************************************************* [ 0.128007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.130008] ** ** [ 0.131008] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.133007] ** ** [ 0.134007] ** This means that this kernel is built to expose internal ** [ 0.136007] ** IOMMU data structures, which may compromise security on ** [ 0.138007] ** your system. ** [ 0.139006] ** ** [ 0.141007] ** If you see this message and you are not debugging the ** [ 0.143011] ** kernel, report this immediately to your vendor! ** [ 0.145013] ** ** [ 0.147011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.148011] ************************************************************* [ 0.162254] NET: Registered protocol family 16 [ 0.164589] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.168141] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.171057] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.175020] cpuidle: using governor menu [ 0.176966] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.181063] PCI: Using configuration type 1 for base access [ 0.183211] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.190238] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.191017] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.194439] cryptd: max_cpu_qlen set to 1000 [ 0.195142] ACPI: Added _OSI(Module Device) [ 0.196000] ACPI: Added _OSI(Processor Device) [ 0.197012] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.198009] ACPI: Added _OSI(Processor Aggregator Device) [ 0.203481] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.209607] ACPI: Interpreter enabled [ 0.211109] ACPI: PM: (supports S0 S3 S4 S5) [ 0.213010] ACPI: Using IOAPIC for interrupt routing [ 0.215096] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.218409] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.230373] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.232034] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.235019] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.239069] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.244628] acpiphp: Slot [2] registered [ 0.246132] acpiphp: Slot [5] registered [ 0.248117] acpiphp: Slot [6] registered [ 0.249144] acpiphp: Slot [3] registered [ 0.251174] acpiphp: Slot [4] registered [ 0.252105] acpiphp: Slot [7] registered [ 0.254089] acpiphp: Slot [8] registered [ 0.255196] acpiphp: Slot [9] registered [ 0.257278] acpiphp: Slot [10] registered [ 0.259086] acpiphp: Slot [11] registered [ 0.261101] acpiphp: Slot [12] registered [ 0.262158] acpiphp: Slot [13] registered [ 0.264095] acpiphp: Slot [14] registered [ 0.266089] acpiphp: Slot [15] registered [ 0.267105] acpiphp: Slot [16] registered [ 0.268081] acpiphp: Slot [17] registered [ 0.270079] acpiphp: Slot [18] registered [ 0.271080] acpiphp: Slot [19] registered [ 0.273076] acpiphp: Slot [20] registered [ 0.274100] acpiphp: Slot [21] registered [ 0.276136] acpiphp: Slot [22] registered [ 0.277157] acpiphp: Slot [23] registered [ 0.279166] acpiphp: Slot [24] registered [ 0.280080] acpiphp: Slot [25] registered [ 0.282200] acpiphp: Slot [26] registered [ 0.283069] acpiphp: Slot [27] registered [ 0.285155] acpiphp: Slot [28] registered [ 0.286097] acpiphp: Slot [29] registered [ 0.287071] acpiphp: Slot [30] registered [ 0.289074] acpiphp: Slot [31] registered [ 0.290063] PCI host bridge to bus 0000:00 [ 0.291014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.294047] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.296021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.298015] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.300020] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.303021] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.305146] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.308595] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.311228] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.319012] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.322000] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.325016] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.327014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.330079] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.332529] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.333000] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.334037] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.336851] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.341012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.350013] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.355011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.360338] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.366013] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.369014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.380014] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.389000] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.395110] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.401016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.415012] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.422576] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.427326] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.429616] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.432262] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.435228] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.442117] iommu: Default domain type: Passthrough [ 0.444445] SCSI subsystem initialized [ 0.446187] ACPI: bus type USB registered [ 0.447102] usbcore: registered new interface driver usbfs [ 0.449088] usbcore: registered new interface driver hub [ 0.451060] usbcore: registered new device driver usb [ 0.452184] pps_core: LinuxPPS API ver. 1 registered [ 0.454009] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.456058] PTP clock support registered [ 0.458337] EDAC MC: Ver: 3.0.0 [ 0.459427] PCI: Using ACPI for IRQ routing [ 0.460732] NetLabel: Initializing [ 0.461013] NetLabel: domain hash size = 128 [ 0.463013] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.465117] NetLabel: unlabeled traffic allowed by default [ 0.467046] vgaarb: loaded [ 0.468353] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.470010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.477000] clocksource: Switched to clocksource kvm-clock [ 0.591330] VFS: Disk quotas dquot_6.6.0 [ 0.592873] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.595426] *** VALIDATE ramfs *** [ 0.596646] *** VALIDATE hugetlbfs *** [ 0.598815] pnp: PnP ACPI init [ 0.601336] pnp: PnP ACPI: found 6 devices [ 0.618045] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.621329] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.623490] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.625785] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.628113] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.630167] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.632837] NET: Registered protocol family 2 [ 0.635220] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.640168] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.643691] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.648783] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.652102] TCP: Hash tables configured (established 65536 bind 65536) [ 0.655496] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.658806] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.662344] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.665609] NET: Registered protocol family 1 [ 0.668240] RPC: Registered named UNIX socket transport module. [ 0.670953] RPC: Registered udp transport module. [ 0.672923] RPC: Registered tcp transport module. [ 0.674648] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.677191] NET: Registered protocol family 44 [ 0.678757] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.680557] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.682511] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.684807] PCI: CLS 0 bytes, default 64 [ 0.687209] Unpacking initramfs... [ 4.604846] debug: unmapping init [mem 0xffff9dd2bcc64000-0xffff9dd2bffcffff] [ 4.613082] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 4.616850] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 4.624784] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 7.025185] Initialise system trusted keyrings [ 7.031533] Key type blacklist registered [ 7.036762] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 7.065891] zbud: loaded [ 7.074480] *** VALIDATE nfs *** [ 7.078762] *** VALIDATE nfs4 *** [ 7.082984] pstore: using deflate compression [ 7.090264] Platform Keyring initialized [ 7.392867] NET: Registered protocol family 38 [ 7.395726] Key type asymmetric registered [ 7.397979] Asymmetric key parser 'x509' registered [ 7.402886] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 7.407995] io scheduler mq-deadline registered [ 7.410729] io scheduler kyber registered [ 7.413065] io scheduler bfq registered [ 7.556962] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 7.564524] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 7.573615] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 7.584402] ACPI: Power Button [PWRF] [ 7.725272] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 7.752717] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 7.789273] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 7.855515] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 7.914541] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 7.922633] Non-volatile memory driver v1.3 [ 7.925487] Linux agpgart interface v0.103 [ 7.976409] virtio_blk virtio1: [vda] 134096 512-byte logical blocks (68.7 MB/65.5 MiB) [ 7.981703] vda: detected capacity change from 0 to 68657152 [ 8.018233] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 8.024262] vdb: detected capacity change from 0 to 1073741824 [ 8.035323] libphy: Fixed MDIO Bus: probed [ 8.044190] usbcore: registered new interface driver usbserial_generic [ 8.047083] usbserial: USB Serial support registered for generic [ 8.050159] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 8.058133] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 8.060241] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 8.063603] mousedev: PS/2 mouse device common for all mice [ 8.076314] rtc_cmos 00:05: RTC can wake from S4 [ 8.090430] rtc_cmos 00:05: registered as rtc0 [ 8.093349] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 8.101239] intel_pstate: CPU model not supported [ 8.107125] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 8.119875] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 8.126078] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 8.134605] hid: raw HID events driver (C) Jiri Kosina [ 8.143987] usbcore: registered new interface driver usbhid [ 8.150175] usbhid: USB HID core driver [ 8.236611] drop_monitor: Initializing network drop monitor service [ 8.238540] Initializing XFRM netlink socket [ 8.243330] NET: Registered protocol family 10 [ 8.279091] Segment Routing with IPv6 [ 8.280715] NET: Registered protocol family 17 [ 8.282390] mpls_gso: MPLS GSO support [ 8.288267] RAS: Correctable Errors collector initialized. [ 8.290399] AVX version of gcm_enc/dec engaged. [ 8.291790] AES CTR mode by8 optimization enabled [ 8.484909] sched_clock: Marking stable (8484689413, 0)->(9467469273, -982779860) [ 8.724224] registered taskstats version 1 [ 8.726804] Loading compiled-in X.509 certificates [ 8.729204] zswap: loaded using pool lzo/zbud [ 8.763820] Key type big_key registered [ 8.971967] Key type encrypted registered [ 8.979269] ima: No TPM chip found, activating TPM-bypass! [ 8.986980] ima: Allocated hash algorithm: sha1 [ 8.996220] ima: No architecture policies found [ 9.002102] evm: Initialising EVM extended attributes: [ 9.004631] evm: security.selinux [ 9.008580] evm: security.ima [ 9.013051] evm: security.capability [ 9.017516] evm: HMAC attrs: 0x1 [ 9.033622] rtc_cmos 00:05: setting system clock to 2026-01-16 06:55:34 UTC (1768546534) [ 9.078121] debug: unmapping init [mem 0xffffffff9be03000-0xffffffff9bffffff] [ 9.085723] debug: unmapping init [mem 0xffffffff9ab82000-0xffffffff9ae58fff] [ 9.095508] Write protecting the kernel read-only data: 28672k [ 9.104960] debug: unmapping init [mem 0xffffffff99203000-0xffffffff993fffff] [ 9.121276] debug: unmapping init [mem 0xffffffff99b14000-0xffffffff99bfffff] [ 9.254761] 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) [ 9.265977] systemd[1]: Detected virtualization kvm. [ 9.270550] systemd[1]: Detected architecture x86-64. [ 9.272937] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 9.306805] systemd[1]: No hostname configured. [ 9.308949] systemd[1]: Set hostname to . [ 9.311954] random: systemd: uninitialized urandom read (16 bytes read) [ 9.316555] systemd[1]: Initializing machine ID from random generator. [ 9.534464] random: ln: uninitialized urandom read (6 bytes read) [ 9.988449] random: systemd: uninitialized urandom read (16 bytes read) [ 10.001242] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 10.015168] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 10.161207] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Control Socket. [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... [ OK ] Reached target Timers. Starting Create Volatile Files and Directories... [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 12.656490] device-mapper: uevent: version 1.0.3 [ 12.658900] 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. [ 16.536972] random: fast init done [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 17.473031] scsi host0: ata_piix [ 17.536103] virtio_net virtio0 ens2: renamed from eth0 [ 17.629328] scsi host1: ata_piix [ 17.632993] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 17.639900] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 22.561458] random: crng init done [ 22.576427] random: 7 urandom warning(s) missed due to ratelimiting [ 25.807889] dracut-initqueue[585]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 28.193714] 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 Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket.[ 30.187714] hrtimer: interrupt took 12159176 ns Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 30.891572] printk: systemd: 26 output lines suppressed due to ratelimiting [ 32.284188] SELinux: Disabled at runtime. [ 32.383178] 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) [ 32.389963] systemd[1]: Detected virtualization kvm. [ 32.391556] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 34.253951] systemd[1]: initrd-switch-root.service: Succeeded. [ 34.257480] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 34.268669] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 34.272877] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 34.276706] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 34.283535] systemd[1]: Starting Journal Service... Starting Journal Service... [ 34.339790] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ OK ] Stopped target Switch Root. [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice User and Session Slice. [ OK ] Stopped target Initrd Root File System. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd File Systems. Mounting Huge Pages File System... Starting Apply Kernel Variables... [ OK ] Created slice system-sshd\x2dkeygen.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. Mounting Kernel Debug File System... [ OK ] Reached target Local Encrypted Volumes. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ 35.299438] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Slices. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... 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. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 38.237895] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 39.611575] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 40.336051] input: PC Speaker as /devices/platform/pcspkr/input/input5 [* ] A start job is running for Configur…only root support (10s / no limit)[ 44.539196] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 44.565896] EDAC sbridge: Ver: 1.1.2 [** ] A start job is running for Configur…only root support (10s / no limit) [*** ] A start job is running for Configur…only root support (11s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit) [ *** ] A start job is running for Configur…only root support (12s / no limit) [ ***] A start job is running for Configur…only root support (12s / no limit) [ **] A start job is running for Configur…only root support (13s / no limit) [ *] A start job is running for Configur…only root support (13s / no limit) [ **] A start job is running for Configur…only root support (14s / no limit) [ ***] A start job is running for Configur…only root support (14s / no limit) [ *** ] A start job is running for Configur…only root support (15s / no limit) [ *** ] A start job is running for Configur…only root support (15s / no limit) [*** ] A start job is running for Configur…only root support (16s / no limit)[ 50.634636] Key type dns_resolver registered [** ] A start job is running for Configur…only root support (16s / no limit) [* ] A start job is running for Configur…only root support (17s / no limit) [** ] A start job is running for Configur…only root support (17s / no limit)[ 52.102234] NFS: Registering the id_resolver key type [ 52.105604] Key type id_resolver registered [ 52.110398] Key type id_legacy registered [*** ] A start job is running for Configur…only root support (18s / no limit) [ *** ] A start job is running for Configur…only root support (18s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg258-client login: [ 103.417130] libcfs: loading out-of-tree module taints kernel. [ 103.477427] Key type ._llcrypt registered [ 103.479219] Key type .llcrypt registered [ 103.818697] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 103.824719] alg: No test for adler32 (adler32-zlib) [ 104.960196] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 105.390323] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 107.063164] Key type lgssc registered [ 108.062421] Lustre: Echo OBD driver; http://www.lustre.org/ [ 207.204430] Lustre: Mounted lustre-client [ 210.685388] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 222.669942] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing check_logdir /tmp/testlogs/ [ 225.776848] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing yml_node [ 228.548249] Lustre: DEBUG MARKER: Client: 2.17.50.30 [ 230.450866] Lustre: DEBUG MARKER: MDS: 2.17.50.30 [ 232.281213] Lustre: DEBUG MARKER: OSS: 2.17.50.30 [ 232.929808] Lustre: lustre-OST0000-osc-ffff9dd309660000: disconnect after 24s idle [ 233.298507] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Jan 16 01:59:17 EST 2026 [ 244.231594] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 245.198986] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 246.556611] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 256.809261] LustreError: 8991:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 256.832737] Lustre: Unmounted lustre-client [ 333.502551] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 336.332860] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 349.699966] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 386.690186] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 02:01:50 (1768546910) [ 418.186893] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 420.996451] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 446.079965] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid [ 478.799057] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 482.089699] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 508.878394] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid [ 525.892532] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 02:04:10 (1768547050) [ 588.309716] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 590.492370] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 603.357561] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 603.801414] Lustre: Mounted lustre-client [ 619.678112] LustreError: 21096:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd30a730000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 619.697663] LustreError: 21096:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 619.700516] LustreError: 21096:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 620.184379] Lustre: Unmounted lustre-client [ 650.790174] Key type lgssc unregistered [ 650.972988] LNet: 21499:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 650.976341] LNetError: 21499:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 650.992231] LNet: Removed LNI 192.168.202.58@tcp [ 651.462545] Key type .llcrypt unregistered [ 651.465479] Key type ._llcrypt unregistered [ 660.784113] Key type ._llcrypt registered [ 660.785181] Key type .llcrypt registered [ 661.608151] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 02:06:26 (1768547186) [ 663.044391] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 663.061079] alg: No test for adler32 (adler32-zlib) [ 664.003465] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 664.123569] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 665.735146] Key type lgssc registered [ 666.524855] Lustre: Echo OBD driver; http://www.lustre.org/ [ 692.184806] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 693.992158] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 704.659302] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 711.147622] Lustre: Mounted lustre-client [ 721.922982] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 02:07:26 (1768547246) [ 728.137077] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 02:07:32 (1768547252) [ 733.474412] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 02:07:37 (1768547257) [ 740.124514] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 02:07:44 (1768547264) [ 753.363036] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 02:07:58 (1768547278) [ 762.828875] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 02:08:07 (1768547287) [ 772.300729] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 02:08:16 (1768547296) [ 778.185823] LustreError: 29308:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd309661000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 778.191296] LustreError: 29308:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 778.236784] Lustre: Unmounted lustre-client [ 778.456194] Lustre: Mounted lustre-client [ 779.493865] LustreError: 29378:0:(obd_class.h:479:obd_check_dev()) Device 3 not setup [ 779.497323] LustreError: 29378:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 779.505158] Lustre: Unmounted lustre-client [ 800.213717] Key type lgssc unregistered [ 800.362893] LNet: 29781:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 800.369133] LNetError: 29781:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 800.380070] LNet: Removed LNI 192.168.202.58@tcp [ 800.762789] Key type .llcrypt unregistered [ 800.764779] Key type ._llcrypt unregistered [ 813.795147] Key type ._llcrypt registered [ 813.796765] Key type .llcrypt registered [ 814.062912] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 814.072372] alg: No test for adler32 (adler32-zlib) [ 815.035666] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 815.178439] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 816.831276] Key type lgssc registered [ 817.757656] Lustre: Echo OBD driver; http://www.lustre.org/ [ 900.441381] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 912.195907] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 942.120413] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 993.595782] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 02:11:57 (1768547517) [ 1030.215178] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1034.845818] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1055.081212] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1057.056983] Lustre: Mounted lustre-client [ 1206.322671] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 02:15:29 (1768547729) [ 1257.322954] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 02:16:20 (1768547780) [ 1269.104590] LustreError: 38664:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd306ef9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1269.129071] LustreError: 38664:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1269.218318] Lustre: Unmounted lustre-client [ 1355.670178] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1360.471605] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1384.996960] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1386.077864] Lustre: Mounted lustre-client [ 1392.822384] LustreError: 40457:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd3043c8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1392.844278] LustreError: 40457:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1392.855436] LustreError: 40457:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1392.944980] Lustre: Unmounted lustre-client [ 1423.672288] Key type lgssc unregistered [ 1424.029727] LNet: 40860:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1424.056889] LNetError: 40860:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1424.073387] LNet: Removed LNI 192.168.202.58@tcp [ 1425.030354] Key type .llcrypt unregistered [ 1425.033989] Key type ._llcrypt unregistered [ 1444.031753] Key type ._llcrypt registered [ 1444.044953] Key type .llcrypt registered [ 1445.638404] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 02:19:29 (1768547969) [ 1448.891754] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1448.984740] alg: No test for adler32 (adler32-zlib) [ 1450.107727] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 1450.364893] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 1452.103204] Key type lgssc registered [ 1453.348487] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1511.636818] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1516.367360] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1540.391170] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1542.488967] Lustre: Mounted lustre-client [ 1557.312948] LustreError: 44039:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd3043cb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1557.339213] LustreError: 44039:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1557.417187] Lustre: Unmounted lustre-client [ 1657.166137] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1662.314903] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1687.664570] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1688.666235] Lustre: Mounted lustre-client [ 1697.060204] LustreError: 45842:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd306ef9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1697.096498] LustreError: 45842:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1697.104640] LustreError: 45842:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1697.152323] Lustre: Unmounted lustre-client [ 1730.767566] Key type lgssc unregistered [ 1731.105783] LNet: 46246:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1731.116951] LNetError: 46246:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1731.140364] LNet: Removed LNI 192.168.202.58@tcp [ 1732.251770] Key type .llcrypt unregistered [ 1732.262648] Key type ._llcrypt unregistered [ 1751.450766] Key type ._llcrypt registered [ 1751.452458] Key type .llcrypt registered [ 1753.006544] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 02:24:36 (1768548276) [ 1757.086779] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1757.274787] alg: No test for adler32 (adler32-zlib) [ 1758.975143] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 1759.528938] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 1761.560657] Key type lgssc registered [ 1763.995338] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1821.011872] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1825.728737] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1848.016577] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1851.390524] Lustre: Mounted lustre-client [ 1987.373338] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 02:28:31 (1768548511) [ 1989.332340] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 1991.566688] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 02:28:35 (1768548515) [ 1994.997212] LustreError: 51113:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd309665800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1995.010445] LustreError: 51113:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1995.195289] Lustre: Unmounted lustre-client [ 2037.132447] Key type lgssc unregistered [ 2037.559605] LNet: 51518:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2037.575638] LNetError: 51518:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2037.603798] LNet: Removed LNI 192.168.202.58@tcp [ 2038.567505] Key type .llcrypt unregistered [ 2038.569858] Key type ._llcrypt unregistered [ 2071.692300] Key type ._llcrypt registered [ 2071.697236] Key type .llcrypt registered [ 2072.359281] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2072.389872] alg: No test for adler32 (adler32-zlib) [ 2073.543824] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 2073.908657] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 2075.633107] Key type lgssc registered [ 2077.251903] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2114.074315] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 02:30:37 (1768548637) [ 2130.178585] Key type lgssc unregistered [ 2130.598641] LNet: 53925:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2130.608172] LNetError: 53925:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2130.636461] LNet: Removed LNI 192.168.202.58@tcp [ 2131.570790] Key type .llcrypt unregistered [ 2131.577784] Key type ._llcrypt unregistered [ 2146.293306] Key type ._llcrypt registered [ 2146.295200] Key type .llcrypt registered [ 2146.969687] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2147.003636] alg: No test for adler32 (adler32-zlib) [ 2148.330784] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 2148.720937] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 2150.632433] Key type lgssc registered [ 2152.067852] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2208.202433] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2213.170448] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2235.258712] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2238.476519] Lustre: Mounted lustre-client [ 2288.649847] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 02:33:32 (1768548812) [ 2290.690828] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 2293.238968] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 02:33:36 (1768548816) [ 2295.496361] LustreError: 57540:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd30a737800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2295.533191] LustreError: 57540:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2295.609649] Lustre: Unmounted lustre-client [ 2361.462086] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2365.291164] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2447.276154] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 02:36:11 (1768548971) [ 2536.053950] Lustre: Mounted lustre-client [ 2541.763142] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2561.503948] Lustre: lustre-OST0000-osc-ffff9dd309660000: disconnect after 23s idle [ 2561.519625] Lustre: lustre-MDT0001-mdc-ffff9dd309660000: Connection to lustre-MDT0001 (at 192.168.202.158@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2576.099374] LustreError: 62465:0:(obd_config.c:2001:class_config_llog_handler()) MGC192.168.202.158@tcp: cfg command failed: rc = -17 [ 2576.109447] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 2576.109447] [ 2576.116328] LustreError: 61722:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 2591.504460] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID ========================================================== 02:38:35 (1768549115) [ 2656.198589] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2674.144217] Lustre: lustre-OST0000-osc-ffff9dd309660000: disconnect after 21s idle [ 2674.149433] Lustre: Skipped 1 previous similar message [ 2756.692264] LustreError: 66332:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd309660000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2756.944281] LustreError: 66332:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 2756.946827] LustreError: 66332:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2757.528932] Lustre: Unmounted lustre-client [ 2939.369171] Lustre: Mounted lustre-client [ 2944.781675] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3017.336125] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 02:45:40 (1768549540) [ 3020.061652] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3020.593352] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3020.597492] Lustre: Skipped 2 previous similar messages [ 3038.875971] LustreError: 70638:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3038.881246] LustreError: 70638:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3038.940148] Lustre: Unmounted lustre-client [ 3211.518309] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 02:48:55 (1768549735) [ 3213.889674] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 3216.462848] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 02:48:59 (1768549739) [ 3322.147649] Lustre: Mounted lustre-client [ 3328.500886] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4023.780687] Lustre: lustre-OST0000-osc-ffff9dd306ea6800: disconnect after 21s idle [ 4023.789201] Lustre: Skipped 1 previous similar message [ 4068.189896] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 03:03:11 (1768550591) [ 4070.716600] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4081.025856] LustreError: 90498:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4081.033223] LustreError: 90498:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4081.080340] Lustre: Unmounted lustre-client [ 4194.696886] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4200.626416] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4221.756684] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4222.803263] Lustre: Mounted lustre-client [ 6246.377915] Lustre: 94169:0:(llog_cat.c:971:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff9dd307c8f800: catlog [0xa:0x5:0x0] crosses index zero [ 6276.111893] LustreError: 101980:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd307c8f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6276.117473] LustreError: 101980:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 6276.136801] LustreError: 101980:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6276.140648] LustreError: 101980:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6276.224262] Lustre: Unmounted lustre-client [ 6324.893066] Key type lgssc unregistered [ 6325.274077] LNet: 102385:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6325.288063] LNetError: 102385:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6325.318521] LNet: Removed LNI 192.168.202.58@tcp [ 6326.634284] Key type .llcrypt unregistered [ 6326.637322] Key type ._llcrypt unregistered [ 6340.188903] Key type ._llcrypt registered [ 6340.193527] Key type .llcrypt registered [ 6341.694353] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 03:41:05 (1768552865) [ 6366.882771] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6366.918178] alg: No test for adler32 (adler32-zlib) [ 6368.094190] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 6368.492405] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 6370.303256] Key type lgssc registered [ 6371.700889] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6464.088695] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6468.426880] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6495.413987] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6498.405758] Lustre: Mounted lustre-client [ 6519.894266] LustreError: 106795:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd30827d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6519.908872] LustreError: 106795:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6519.961197] Lustre: Unmounted lustre-client [ 6660.169171] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6665.318638] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6691.679713] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6735.840156] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 03:47:39 (1768553259) [ 6737.653405] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 6739.264777] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 03:47:43 (1768553263) [ 6774.242912] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6779.046504] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6804.098937] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6804.659585] Lustre: Mounted lustre-client [ 6820.331569] Lustre: lustre-MDT0001-mdc-ffff9dd305038000: Connection to lustre-MDT0001 (at 192.168.202.158@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6820.342410] Lustre: Skipped 1 previous similar message [ 6835.679912] Lustre: 103150:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1768553345/real 1768553345] req@000000009b8504ca x1854462118407808/t0(0) o400->MGC192.168.202.158@tcp@192.168.202.158@tcp:26/25 lens 224/224 e 0 to 1 dl 1768553361 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6835.741073] LustreError: MGC192.168.202.158@tcp: Connection to MGS (at 192.168.202.158@tcp) was lost; in progress operations using this service will fail [ 6981.097222] Lustre: Evicted from MGS (at 192.168.202.158@tcp) after server handle changed from 0xede1a36664ea00fc to 0xede1a36664ea17ae [ 6981.108318] Lustre: MGC192.168.202.158@tcp: Connection restored to 192.168.202.158@tcp (at 192.168.202.158@tcp) [ 6996.479603] LustreError: lustre-MDT0000-mdc-ffff9dd305038000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6996.500907] Lustre: lustre-MDT0000-mdc-ffff9dd305038000: Connection restored to 192.168.202.158@tcp (at 192.168.202.158@tcp) [ 7001.592598] LustreError: lustre-MDT0001-mdc-ffff9dd305038000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7001.655829] Lustre: lustre-MDT0001-mdc-ffff9dd305038000: Connection restored to 192.168.202.158@tcp (at 192.168.202.158@tcp) [ 7002.559249] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7005.176963] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7009.839626] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7011.675357] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7029.621691] LustreError: 113768:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd305038000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7029.639258] LustreError: 113768:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7029.644041] LustreError: 113768:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 7029.690955] Lustre: Unmounted lustre-client [ 7155.710890] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7160.143680] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7183.703543] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7235.019182] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 03:55:58 (1768553758) [ 7269.460748] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7274.220944] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7297.645183] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7298.503899] Lustre: Mounted lustre-client [ 7300.970657] LustreError: 119441:0:(lproc_llite.c:615:ll_max_cached_mb_seq_write()) lustre: cannot set max_cached_mb=0 MB more than 3693 MB: rc = -34 [ 7308.324347] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 03:57:12 (1768553832) [ 7310.764016] LustreError: 120044:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd3043cf800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7310.785388] LustreError: 120044:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7310.790536] LustreError: 120044:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 7310.857374] Lustre: Unmounted lustre-client [ 7336.882729] Key type lgssc unregistered [ 7337.176162] LNet: 120446:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7337.184037] LNetError: 120446:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7337.212892] LNet: Removed LNI 192.168.202.58@tcp [ 7338.023591] Key type .llcrypt unregistered [ 7338.026519] Key type ._llcrypt unregistered [ 7355.048813] Key type ._llcrypt registered [ 7355.055626] Key type .llcrypt registered [ 7356.129626] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7356.140751] alg: No test for adler32 (adler32-zlib) [ 7357.575689] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 7358.075836] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 7360.023950] Key type lgssc registered [ 7361.337690] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7451.134818] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7454.855876] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7475.373721] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7596.577793] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7600.984448] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7623.144468] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7673.548557] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 04:03:17 (1768554197) [ 7686.357966] Key type lgssc unregistered [ 7686.615657] LNet: 127496:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7686.622242] LNetError: 127496:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7686.656174] LNet: Removed LNI 192.168.202.58@tcp [ 7687.374480] Key type .llcrypt unregistered [ 7687.376921] Key type ._llcrypt unregistered [ 7702.333528] Key type ._llcrypt registered [ 7702.340892] Key type .llcrypt registered [ 7702.845832] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7702.857658] alg: No test for adler32 (adler32-zlib) [ 7704.042211] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 7704.339962] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 7706.047270] Key type lgssc registered [ 7707.469681] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7759.170769] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7763.347594] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7786.690449] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7913.058584] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7917.519092] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7940.070683] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7991.102724] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 04:08:35 (1768554515) [ 8089.379224] Lustre: Mounted lustre-client [ 8095.451131] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8113.302636] Lustre: DEBUG MARKER: ADD OST3 [ 8115.169129] Lustre: lustre-OST0000-osc-ffff9dd309661000: disconnect after 23s idle [ 8128.740837] Lustre: DEBUG MARKER: STOP OST3 [ 8143.853462] Lustre: lustre-OST0003-osc-ffff9dd309661000: Connection to lustre-OST0003 (at 192.168.202.158@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8154.897388] Lustre: DEBUG MARKER: START OST3 again [ 8164.770578] Lustre: lustre-OST0003-osc-ffff9dd309661000: Connection restored to 192.168.202.158@tcp (at 192.168.202.158@tcp) [ 8196.261522] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8196.285383] LustreError: 138168:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff9dd309661000: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 8206.599111] LustreError: 138168:0:(obd_class.h:479:obd_check_dev()) Device 7 not setup [ 8206.660171] Lustre: Unmounted lustre-client [ 8321.969632] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8326.642735] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8350.009879] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8388.189718] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 04:15:12 (1768554912) [ 8488.082761] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8491.733343] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8513.569457] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8582.031879] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8587.539560] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8614.958915] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8617.967459] LNetError: 127905:0:(lib-move.c:2321:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 8618.383796] Lustre: Mounted lustre-client [ 8623.527758] LustreError: 146490:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd3043ce800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8623.566260] LustreError: 146490:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8623.573501] LustreError: 146490:0:(obd_class.h:479:obd_check_dev()) Skipped 11 previous similar messages [ 8623.671700] Lustre: Unmounted lustre-client [ 8655.820523] Key type lgssc unregistered [ 8671.135397] LNet: 1 local NIs in recovery (showing 1): 192.168.202.58@tcp [ 8676.711580] LNet: 146899:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8676.732261] LNetError: 146899:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8750.502493] LNet: Removed LNI 192.168.202.58@tcp [ 8751.022140] Key type .llcrypt unregistered [ 8751.023340] Key type ._llcrypt unregistered [ 8768.247166] Key type ._llcrypt registered [ 8768.253412] Key type .llcrypt registered [ 8770.124447] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 04:21:33 (1768555293) [ 8791.514743] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8791.587184] alg: No test for adler32 (adler32-zlib) [ 8792.901723] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 8793.265143] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 8795.015170] Key type lgssc registered [ 8797.136858] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8888.979715] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8894.368395] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8920.932429] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9058.361341] Lustre: Mounted lustre-client [ 9064.600925] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9078.368707] LustreError: 153700:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd3029f4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9078.393316] LustreError: 153700:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9078.491200] Lustre: Unmounted lustre-client [ 9078.611026] LNetError: 148080:0:(lib-socket.c:313:lnet_sock_create()) Error trying to bind to fe80::545d:33ff:fea5:8f83/1023: rc = -22 [ 9078.621047] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9079.038672] Lustre: Mounted lustre-client [ 9079.125162] LustreError: 153738:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd306efd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9079.144927] LustreError: 153738:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 9079.155413] LustreError: 153738:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9079.159229] LustreError: 153738:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 9079.227123] Lustre: Unmounted lustre-client [ 9080.140316] LNetError: 148081:0:(lib-socket.c:313:lnet_sock_create()) Error trying to bind to fe80::545d:33ff:fea5:8f83/1023: rc = -22 [ 9080.158405] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9080.486499] Lustre: Mounted lustre-client [ 9080.491874] Lustre: Skipped 1 previous similar message [ 9080.581517] LustreError: 153811:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd31067a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9080.593648] LustreError: 153811:0:(lov_obd.c:783:lov_cleanup()) Skipped 3 previous similar messages [ 9080.616575] LustreError: 153811:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9080.623058] LustreError: 153811:0:(obd_class.h:479:obd_check_dev()) Skipped 19 previous similar messages [ 9080.685107] Lustre: Unmounted lustre-client [ 9080.686683] Lustre: Skipped 1 previous similar message [ 9082.592271] LNetError: 148081:0:(lib-socket.c:313:lnet_sock_create()) Error trying to bind to fe80::545d:33ff:fea5:8f83/1023: rc = -22 [ 9082.604335] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9082.938579] Lustre: Mounted lustre-client [ 9082.940494] Lustre: Skipped 3 previous similar messages [ 9082.996974] LustreError: 153957:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd333892000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9083.007627] LustreError: 153957:0:(lov_obd.c:783:lov_cleanup()) Skipped 7 previous similar messages [ 9083.018137] LustreError: 153957:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9083.021283] LustreError: 153957:0:(obd_class.h:479:obd_check_dev()) Skipped 39 previous similar messages [ 9083.134584] Lustre: Unmounted lustre-client [ 9083.140467] Lustre: Skipped 3 previous similar messages [ 9083.929217] Lustre: 154000:0:(obd_mount.c:231: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 [ 9084.688722] Lustre: 154037:0:(obd_mount.c:231: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 [ 9084.722089] LNetError: 148082:0:(lib-socket.c:313:lnet_sock_create()) Error trying to bind to fe80::545d:33ff:fea5:8f83/1023: rc = -22 [ 9084.746122] LNetError: 148082:0:(lib-socket.c:313:lnet_sock_create()) Skipped 1 previous similar message [ 9084.776732] LNetError: Unexpected error -22 connecting to 2001:db8:85a3::8a2e:370:7334@tcp at host [2001:db8:85a3::8a2e:370:7334]:988 [ 9084.801309] LNetError: Skipped 1 previous similar message [ 9094.782887] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 04:26:58 (1768555618) [ 9131.231197] LNet: 1 local NIs in recovery (showing 1): 192.168.202.58@tcp [ 9229.383172] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9233.027813] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9256.493773] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9324.003085] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9328.267595] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9351.780478] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9357.599402] LustreError: 159461:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 9405.663674] LNet: 1 local NIs in recovery (showing 1): 192.168.202.58@tcp [ 9483.487286] LNet: 1 local NIs in recovery (showing 1): 192.168.202.58@tcp [ 9494.499075] 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 [ 9494.520912] Lustre: Unmounted lustre-client [ 9494.522381] Lustre: Skipped 3 previous similar messages [ 9494.544297] LustreError: 159461:0:(obd_class.h:479:obd_check_dev()) Device 0 not setup [ 9494.552404] LustreError: 159461:0:(obd_class.h:479:obd_check_dev()) Skipped 39 previous similar messages [ 9494.561495] LustreError: 159461:0:(super25.c:199:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 9523.538190] Key type lgssc unregistered [ 9542.879305] LNet: 1 local NIs in recovery (showing 1): 192.168.202.58@tcp [ 9547.490209] LNet: 159919:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9547.497062] LNetError: 159919:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9615.080891] LNet: Removed LNI 192.168.202.58@tcp [ 9615.807210] Key type .llcrypt unregistered [ 9615.809376] Key type ._llcrypt unregistered [ 9635.132496] Key type ._llcrypt registered [ 9635.138138] Key type .llcrypt registered [ 9637.279606] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 04:36:00 (1768556160) [ 9661.865399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9662.033439] alg: No test for adler32 (adler32-zlib) [ 9663.109618] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [ 9663.326759] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [ 9664.985429] Key type lgssc registered [ 9666.496884] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9814.947648] Lustre: Mounted lustre-client [ 9820.295892] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9840.607684] Lustre: lustre-OST0000-osc-ffff9dd333890000: disconnect after 24s idle [ 9842.165914] LustreError: 165405:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd333890000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9842.183404] LustreError: 165405:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9842.395049] Lustre: Unmounted lustre-client [10016.156443] Lustre: Mounted lustre-client [10021.311690] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10033.576566] LustreError: 168432:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd33387d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10033.594133] LustreError: 168432:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [10033.608534] LustreError: 168432:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [10033.616663] LustreError: 168432:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [10033.830910] Lustre: Unmounted lustre-client [10083.322796] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 04:43:26 (1768556606) [10178.455416] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10182.441720] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10202.194958] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10332.540638] Lustre: Mounted lustre-client [10338.986496] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10356.199731] Lustre: lustre-OST0000-osc-ffff9dd303280800: disconnect after 21s idle [10356.203550] Lustre: Skipped 1 previous similar message [10358.125454] LustreError: 175219:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd303280800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10358.146720] LustreError: 175219:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [10358.160220] LustreError: 175219:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [10358.165140] LustreError: 175219:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [10358.279786] Lustre: Unmounted lustre-client [10485.121952] Lustre: Mounted lustre-client [10490.196522] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10510.816041] Lustre: lustre-OST0001-osc-ffff9dd30475f800: disconnect after 24s idle [10510.822585] Lustre: Skipped 1 previous similar message [10512.522687] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 04:50:36 (1768557036) [10514.582102] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10524.863451] LustreError: 178169:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [10524.875073] LustreError: 178169:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [10524.920797] Lustre: Unmounted lustre-client [10692.492884] Lustre: Mounted lustre-client [10697.452947] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10711.112212] LustreError: 182509:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd30469d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10711.118098] LustreError: 182509:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [10711.128446] LustreError: 182509:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [10711.130401] LustreError: 182509:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [10711.214188] Lustre: Unmounted lustre-client [10711.800369] Lustre: Mounted lustre-client [10721.829906] LustreError: 183024:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd304133800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10721.856675] LustreError: 183024:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [10721.888509] LustreError: 183024:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [10721.893312] LustreError: 183024:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [10722.048241] Lustre: Unmounted lustre-client [10724.337346] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 04:54:07 (1768557247) [10858.550303] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10862.268083] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10882.618043] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10933.484310] Key type lgssc unregistered [10933.873278] LNet: 187514:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10933.883118] LNetError: 187514:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10933.916248] LNet: Removed LNI 192.168.202.58@tcp [10934.760190] Key type .llcrypt unregistered [10934.764588] Key type ._llcrypt unregistered [11035.803076] Key type ._llcrypt registered [11035.822472] Key type .llcrypt registered [11036.275337] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11036.296359] alg: No test for adler32 (adler32-zlib) [11037.572995] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11037.810982] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11039.639269] Key type lgssc registered [11041.244674] Lustre: Echo OBD driver; http://www.lustre.org/ [11097.822368] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 05:00:21 (1768557621) [11142.093615] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11146.785302] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11171.012310] Lustre: DEBUG MARKER: oleg258-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11173.020488] Lustre: Mounted lustre-client [11175.430454] LustreError: 191479:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd30a4dc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11175.496084] LustreError: 191479:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11175.642334] Lustre: Unmounted lustre-client [11176.119473] Lustre: Mounted lustre-client [11176.279223] LustreError: 191531:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd30829b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11176.309787] LustreError: 191531:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11176.313236] LustreError: 191531:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [11176.399241] Lustre: Unmounted lustre-client [11177.184577] Lustre: Mounted lustre-client [11179.813403] LustreError: 191610:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9dd3078e8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11179.846900] LustreError: 191610:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11179.855888] LustreError: 191610:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [11179.962353] Lustre: Unmounted lustre-client [11210.701512] Key type lgssc unregistered [11211.009142] LNet: 192014:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11211.014572] LNetError: 192014:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11211.042139] LNet: Removed LNI 192.168.202.58@tcp [11211.768586] Key type .llcrypt unregistered [11211.770882] Key type ._llcrypt unregistered [11228.463146] Key type ._llcrypt registered [11228.466611] Key type .llcrypt registered [11230.256810] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 05:02:33 (1768557753) [11245.078458] Key type .llcrypt unregistered [11245.082569] Key type ._llcrypt unregistered [11246.236896] Key type ._llcrypt registered [11246.260237] Key type .llcrypt registered [11246.923296] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [11246.986336] alg: No test for adler32 (adler32-zlib) [11248.254751] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11248.628099] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11250.351691] Key type lgssc registered [11252.173333] Lustre: Echo OBD driver; http://www.lustre.org/ [11281.580605] Key type lgssc unregistered [11281.927775] LNet: 194596:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11281.940941] LNetError: 194596:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11281.969686] LNet: Removed LNI 192.168.202.58@tcp [11282.788422] Key type .llcrypt unregistered [11282.793842] Key type ._llcrypt unregistered [11283.324499] Key type ._llcrypt registered [11283.326819] Key type .llcrypt registered [11285.183971] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 05:03:28 (1768557808) [11298.499388] Key type .llcrypt unregistered [11298.501017] Key type ._llcrypt unregistered [11299.881414] Key type ._llcrypt registered [11299.883814] Key type .llcrypt registered [11300.346902] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11300.372731] alg: No test for adler32 (adler32-zlib) [11301.582369] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11301.823708] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11303.527855] Key type lgssc registered [11305.282810] Lustre: Echo OBD driver; http://www.lustre.org/ [11321.272425] Key type lgssc unregistered [11321.478612] LNet: 196143:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11321.485451] LNetError: 196143:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11321.507236] LNet: Removed LNI 192.168.202.58@tcp [11322.163503] Key type .llcrypt unregistered [11322.165962] Key type ._llcrypt unregistered [11329.713418] Key type ._llcrypt registered [11329.714921] Key type .llcrypt registered [11329.970059] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11329.981969] alg: No test for adler32 (adler32-zlib) [11331.081311] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11331.241827] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11332.896288] Key type lgssc registered [11334.207291] Lustre: Echo OBD driver; http://www.lustre.org/ [11360.660792] Key type lgssc unregistered [11360.908857] LNet: 197906:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11360.912757] LNetError: 197906:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11360.926538] LNet: Removed LNI 192.168.202.58@tcp [11361.588382] Key type .llcrypt unregistered [11361.591473] Key type ._llcrypt unregistered [11362.069512] Key type ._llcrypt registered [11362.073486] Key type .llcrypt registered [11363.590205] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 05:04:47 (1768557887) [11376.662529] Key type .llcrypt unregistered [11376.665665] Key type ._llcrypt unregistered [11378.071605] Key type ._llcrypt registered [11378.072713] Key type .llcrypt registered [11378.315863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11378.327448] alg: No test for adler32 (adler32-zlib) [11379.412251] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11379.653604] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11381.331486] Key type lgssc registered [11383.037897] Lustre: Echo OBD driver; http://www.lustre.org/ [11402.222363] Key type lgssc unregistered [11402.593870] LNet: 199449:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11402.603728] LNetError: 199449:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11402.637083] LNet: Removed LNI 192.168.202.58@tcp [11403.532460] Key type .llcrypt unregistered [11403.535993] Key type ._llcrypt unregistered [11411.488746] Key type ._llcrypt registered [11411.490303] Key type .llcrypt registered [11411.928599] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11411.944874] alg: No test for adler32 (adler32-zlib) [11412.974831] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11413.222496] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11414.895178] Key type lgssc registered [11416.741912] Lustre: Echo OBD driver; http://www.lustre.org/ [11434.608883] Key type lgssc unregistered [11434.866764] LNet: 200753:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11434.873048] LNetError: 200753:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11434.884402] LNet: Removed LNI 192.168.202.58@tcp [11435.571595] Key type .llcrypt unregistered [11435.573124] Key type ._llcrypt unregistered [11444.046665] Key type ._llcrypt registered [11444.048290] Key type .llcrypt registered [11444.416791] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11444.442585] alg: No test for adler32 (adler32-zlib) [11445.880618] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11446.277692] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11448.034251] Key type lgssc registered [11449.895562] Lustre: Echo OBD driver; http://www.lustre.org/ [11467.723717] Key type lgssc unregistered [11468.046299] LNet: 202056:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11468.054924] LNetError: 202056:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11468.083664] LNet: Removed LNI 192.168.202.58@tcp [11468.903605] Key type .llcrypt unregistered [11468.906454] Key type ._llcrypt unregistered [11476.295588] Key type ._llcrypt registered [11476.304670] Key type .llcrypt registered [11476.851780] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11476.862959] alg: No test for adler32 (adler32-zlib) [11478.044902] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11478.347933] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11480.119254] Key type lgssc registered [11481.476506] Lustre: Echo OBD driver; http://www.lustre.org/ [11508.708877] Key type lgssc unregistered [11509.052577] LNet: 203823:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11509.067800] LNetError: 203823:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11509.085103] LNet: Removed LNI 192.168.202.58@tcp [11509.780626] Key type .llcrypt unregistered [11509.782419] Key type ._llcrypt unregistered [11510.297440] Key type ._llcrypt registered [11510.299650] Key type .llcrypt registered [11511.701529] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 05:07:15 (1768558035) [11529.135293] Key type .llcrypt unregistered [11529.139568] Key type ._llcrypt unregistered [11530.679864] Key type ._llcrypt registered [11530.685897] Key type .llcrypt registered [11531.664630] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11531.688141] alg: No test for adler32 (adler32-zlib) [11533.181918] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11533.553879] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11535.327342] Key type lgssc registered [11537.289436] Lustre: Echo OBD driver; http://www.lustre.org/ [11555.359475] Key type lgssc unregistered [11555.702990] LNet: 205372:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11555.707894] LNetError: 205372:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11555.732828] LNet: Removed LNI 192.168.202.58@tcp [11556.493590] Key type .llcrypt unregistered [11556.496628] Key type ._llcrypt unregistered [11565.510979] Key type ._llcrypt registered [11565.531586] Key type .llcrypt registered [11565.887282] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11565.899433] alg: No test for adler32 (adler32-zlib) [11567.242089] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11567.476835] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11569.200220] Key type lgssc registered [11570.460299] Lustre: Echo OBD driver; http://www.lustre.org/ [11588.477842] Key type lgssc unregistered [11588.738333] LNet: 206685:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11588.766070] LNetError: 206685:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11588.786888] LNet: Removed LNI 192.168.202.58@tcp [11589.363783] Key type .llcrypt unregistered [11589.372081] Key type ._llcrypt unregistered [11596.338228] Key type ._llcrypt registered [11596.346820] Key type .llcrypt registered [11596.822375] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11596.834501] alg: No test for adler32 (adler32-zlib) [11598.058991] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11598.273754] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11599.976055] Key type lgssc registered [11601.363374] Lustre: Echo OBD driver; http://www.lustre.org/ [11619.085698] Key type lgssc unregistered [11619.404858] LNet: 207986:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11619.409539] LNetError: 207986:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11619.443851] LNet: Removed LNI 192.168.202.58@tcp [11620.274747] Key type .llcrypt unregistered [11620.285124] Key type ._llcrypt unregistered [11627.412184] Key type ._llcrypt registered [11627.415427] Key type .llcrypt registered [11628.109349] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11628.125766] alg: No test for adler32 (adler32-zlib) [11629.287579] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11629.506076] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11631.263821] Key type lgssc registered [11632.892520] Lustre: Echo OBD driver; http://www.lustre.org/ [11651.122988] Key type lgssc unregistered [11651.342695] LNet: 209291:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11651.351114] LNetError: 209291:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11651.390791] LNet: Removed LNI 192.168.202.58@tcp [11652.206366] Key type .llcrypt unregistered [11652.209894] Key type ._llcrypt unregistered [11662.015674] Key type ._llcrypt registered [11662.024929] Key type .llcrypt registered [11662.798630] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11662.820545] alg: No test for adler32 (adler32-zlib) [11664.053974] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11664.370789] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11666.161387] Key type lgssc registered [11667.811642] Lustre: Echo OBD driver; http://www.lustre.org/ [11687.557692] Key type lgssc unregistered [11688.091166] LNet: 210597:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11688.101582] LNetError: 210597:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11688.125781] LNet: Removed LNI 192.168.202.58@tcp [11689.181993] Key type .llcrypt unregistered [11689.185931] Key type ._llcrypt unregistered [11701.950504] Key type ._llcrypt registered [11701.975589] Key type .llcrypt registered [11702.563792] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11702.611595] alg: No test for adler32 (adler32-zlib) [11704.188233] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11704.828766] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11706.735150] Key type lgssc registered [11708.883594] Lustre: Echo OBD driver; http://www.lustre.org/ [11725.732660] Key type lgssc unregistered [11725.969525] LNet: 211900:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11725.987172] LNetError: 211900:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11726.016622] LNet: Removed LNI 192.168.202.58@tcp [11726.659220] Key type .llcrypt unregistered [11726.665135] Key type ._llcrypt unregistered [11751.012967] Key type ._llcrypt registered [11751.014825] Key type .llcrypt registered [11752.497383] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 05:11:16 (1768558276) [11764.566858] Key type .llcrypt unregistered [11764.571301] Key type ._llcrypt unregistered [11765.401911] Key type ._llcrypt registered [11765.407791] Key type .llcrypt registered [11766.052680] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11766.072255] alg: No test for adler32 (adler32-zlib) [11767.130827] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11767.364761] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11769.079339] Key type lgssc registered [11770.439435] Lustre: Echo OBD driver; http://www.lustre.org/ [11787.684807] Key type lgssc unregistered [11787.930387] LNet: 214217:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11787.936507] LNetError: 214217:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11787.953870] LNet: Removed LNI 192.168.202.58@tcp [11788.591726] Key type .llcrypt unregistered [11788.598751] Key type ._llcrypt unregistered [11797.274381] Key type ._llcrypt registered [11797.276432] Key type .llcrypt registered [11797.906525] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11797.932413] alg: No test for adler32 (adler32-zlib) [11799.149157] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11799.365228] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11801.023567] Key type lgssc registered [11802.494859] Lustre: Echo OBD driver; http://www.lustre.org/ [11819.979183] Key type lgssc unregistered [11820.200539] LNet: 215531:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11820.206241] LNetError: 215531:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11820.253270] LNet: Removed LNI 192.168.202.58@tcp [11820.932699] Key type .llcrypt unregistered [11820.935840] Key type ._llcrypt unregistered [11827.384244] Key type ._llcrypt registered [11827.386506] Key type .llcrypt registered [11827.765605] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11827.797576] alg: No test for adler32 (adler32-zlib) [11828.811089] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11828.988134] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11830.623335] Key type lgssc registered [11831.629198] Lustre: Echo OBD driver; http://www.lustre.org/ [11846.829524] Key type lgssc unregistered [11847.022546] LNet: 216837:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11847.027262] LNetError: 216837:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11847.047901] LNet: Removed LNI 192.168.202.58@tcp [11847.693917] Key type .llcrypt unregistered [11847.699296] Key type ._llcrypt unregistered [11853.852675] Key type ._llcrypt registered [11853.861288] Key type .llcrypt registered [11854.332084] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11854.350989] alg: No test for adler32 (adler32-zlib) [11855.384543] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11855.610856] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11857.287760] Key type lgssc registered [11858.383261] Lustre: Echo OBD driver; http://www.lustre.org/ [11883.213228] Key type lgssc unregistered [11883.484142] LNet: 218627:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11883.490584] LNetError: 218627:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11883.503476] LNet: Removed LNI 192.168.202.58@tcp [11884.179715] Key type .llcrypt unregistered [11884.181840] Key type ._llcrypt unregistered [11884.639301] Key type ._llcrypt registered [11884.644057] Key type .llcrypt registered [11886.330263] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 05:13:29 (1768558409) [11888.335890] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [11907.969341] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11907.983295] alg: No test for adler32 (adler32-zlib) [11909.206915] Lustre: Lustre: Build Version: 2.17.50_30_gbb2e37c [11909.616544] LNet: Added LNI 192.168.202.58@tcp [8/256/0/180] [11911.367334] Key type lgssc registered [11913.019666] Lustre: Echo OBD driver; http://www.lustre.org/ [11967.449683] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11733 sec ========= 05:14:51 (1768558491) [11969.002399] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 05:14:53 (1768558493) === [11972.377608] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 05:14:56 (1768558496) === [12008.756324] Key type lgssc unregistered [12008.993046] LNet: 222376:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12008.997338] LNetError: 222376:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [12009.009368] LNet: Removed LNI 192.168.202.58@tcp [12009.892699] Key type .llcrypt unregistered [12009.899606] Key type ._llcrypt unregistered