[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-10.fc44 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 438610898 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002387] x2apic enabled [ 0.003007] Switched APIC routing to physical x2apic. [ 0.004010] kvm-guest: setup PV IPIs [ 0.006699] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009004] pid_max: default: 32768 minimum: 301 [ 0.010000] LSM: Security Framework initializing [ 0.010047] Yama: becoming mindful. [ 0.012011] SELinux: Initializing. [ 0.013059] *** VALIDATE selinux *** [ 0.020500] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025305] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026131] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027091] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028098] *** VALIDATE tmpfs *** [ 0.029411] *** VALIDATE proc *** [ 0.030216] *** VALIDATE cgroup *** [ 0.031007] *** VALIDATE cgroup2 *** [ 0.032294] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.033149] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.034007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.035027] Spectre V2 : User space: Vulnerable [ 0.036008] Speculative Store Bypass: Vulnerable [ 0.039250] debug: unmapping init [mem 0xffffffffa3a59000-0xffffffffa3a60fff] [ 0.041094] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.042598] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.043023] ... version: 2 [ 0.044011] ... bit width: 48 [ 0.044929] ... generic registers: 4 [ 0.045011] ... value mask: 0000ffffffffffff [ 0.046009] ... max period: 00007fffffffffff [ 0.047011] ... fixed-purpose events: 3 [ 0.047968] ... event mask: 000000070000000f [ 0.048281] rcu: Hierarchical SRCU implementation. [ 0.050394] smp: Bringing up secondary CPUs ... [ 0.051497] x86: Booting SMP configuration: [ 0.052020] .... node #0, CPUs: #1 #2 #3 [ 0.055574] smp: Brought up 1 node, 4 CPUs [ 0.056933] smpboot: Max logical packages: 1 [ 0.057011] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.139172] node 0 deferred pages initialised in 80ms [ 0.143155] devtmpfs: initialized [ 0.145233] x86/mm: Memory block size: 128MB [ 0.148203] gcov: version magic: 0x41383552 [ 0.150474] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.154072] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.155348] pinctrl core: initialized pinctrl subsystem [ 0.156179] [ 0.156597] ************************************************************* [ 0.157011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.158009] ** ** [ 0.159010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.160010] ** ** [ 0.161010] ** This means that this kernel is built to expose internal ** [ 0.162011] ** IOMMU data structures, which may compromise security on ** [ 0.163008] ** your system. ** [ 0.164011] ** ** [ 0.165009] ** If you see this message and you are not debugging the ** [ 0.166009] ** kernel, report this immediately to your vendor! ** [ 0.167012] ** ** [ 0.168015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.169015] ************************************************************* [ 0.170776] NET: Registered protocol family 16 [ 0.171433] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.172058] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.173065] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.174594] cpuidle: using governor menu [ 0.177451] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.180667] PCI: Using configuration type 1 for base access [ 0.183134] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.194060] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.197074] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.201081] cryptd: max_cpu_qlen set to 1000 [ 0.204279] ACPI: Added _OSI(Module Device) [ 0.206016] ACPI: Added _OSI(Processor Device) [ 0.208013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.209013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.215115] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.219596] ACPI: Interpreter enabled [ 0.222069] ACPI: PM: (supports S0 S3 S4 S5) [ 0.223012] ACPI: Using IOAPIC for interrupt routing [ 0.226098] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.230367] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.242136] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.245041] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.247019] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.251106] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.257377] acpiphp: Slot [2] registered [ 0.259118] acpiphp: Slot [5] registered [ 0.260121] acpiphp: Slot [6] registered [ 0.262110] acpiphp: Slot [3] registered [ 0.264093] acpiphp: Slot [4] registered [ 0.265104] acpiphp: Slot [7] registered [ 0.267112] acpiphp: Slot [8] registered [ 0.269109] acpiphp: Slot [9] registered [ 0.270172] acpiphp: Slot [10] registered [ 0.271110] acpiphp: Slot [11] registered [ 0.273092] acpiphp: Slot [12] registered [ 0.274083] acpiphp: Slot [13] registered [ 0.275169] acpiphp: Slot [14] registered [ 0.276074] acpiphp: Slot [15] registered [ 0.277042] acpiphp: Slot [16] registered [ 0.278088] acpiphp: Slot [17] registered [ 0.279221] acpiphp: Slot [18] registered [ 0.280086] acpiphp: Slot [19] registered [ 0.282085] acpiphp: Slot [20] registered [ 0.283164] acpiphp: Slot [21] registered [ 0.284069] acpiphp: Slot [22] registered [ 0.285158] acpiphp: Slot [23] registered [ 0.287104] acpiphp: Slot [24] registered [ 0.288122] acpiphp: Slot [25] registered [ 0.289088] acpiphp: Slot [26] registered [ 0.290088] acpiphp: Slot [27] registered [ 0.291081] acpiphp: Slot [28] registered [ 0.293080] acpiphp: Slot [29] registered [ 0.294143] acpiphp: Slot [30] registered [ 0.295088] acpiphp: Slot [31] registered [ 0.296059] PCI host bridge to bus 0000:00 [ 0.297017] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.299023] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.301020] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.303021] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.304019] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.307022] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.308182] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.311051] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.313402] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.321013] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.326057] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.330018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.332016] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.335018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.337533] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.340973] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.344044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.347621] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.352011] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.362695] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.368014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.374424] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.391015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.406024] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.421021] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.431708] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.448016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.464104] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.501018] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.515166] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.517474] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.520428] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.523471] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.526326] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.532657] iommu: Default domain type: Passthrough [ 0.535597] SCSI subsystem initialized [ 0.538138] ACPI: bus type USB registered [ 0.540130] usbcore: registered new interface driver usbfs [ 0.542075] usbcore: registered new interface driver hub [ 0.544086] usbcore: registered new device driver usb [ 0.546158] pps_core: LinuxPPS API ver. 1 registered [ 0.548012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.551087] PTP clock support registered [ 0.553102] EDAC MC: Ver: 3.0.0 [ 0.554443] PCI: Using ACPI for IRQ routing [ 0.555445] NetLabel: Initializing [ 0.556000] NetLabel: domain hash size = 128 [ 0.558014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.559138] NetLabel: unlabeled traffic allowed by default [ 0.562080] vgaarb: loaded [ 0.563252] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.565019] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.570438] clocksource: Switched to clocksource kvm-clock [ 0.686779] VFS: Disk quotas dquot_6.6.0 [ 0.688664] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.691720] *** VALIDATE ramfs *** [ 0.693147] *** VALIDATE hugetlbfs *** [ 0.695723] pnp: PnP ACPI init [ 0.698550] pnp: PnP ACPI: found 6 devices [ 0.718818] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.722777] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.725303] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.728018] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.731210] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.733548] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.737321] NET: Registered protocol family 2 [ 0.739845] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.745248] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.749150] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.754859] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.758547] TCP: Hash tables configured (established 65536 bind 65536) [ 0.761479] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.764912] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.767945] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.770885] NET: Registered protocol family 1 [ 0.774564] RPC: Registered named UNIX socket transport module. [ 0.776772] RPC: Registered udp transport module. [ 0.778964] RPC: Registered tcp transport module. [ 0.780947] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.783812] NET: Registered protocol family 44 [ 0.785382] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.787597] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.789586] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.791749] PCI: CLS 0 bytes, default 64 [ 0.793265] Unpacking initramfs... [ 2.206865] debug: unmapping init [mem 0xffff93077cc64000-0xffff93077ffcffff] [ 2.211273] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.213975] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.217221] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.720149] Initialise system trusted keyrings [ 2.723238] Key type blacklist registered [ 2.725386] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.734683] zbud: loaded [ 2.741637] *** VALIDATE nfs *** [ 2.743031] *** VALIDATE nfs4 *** [ 2.744862] pstore: using deflate compression [ 2.750191] Platform Keyring initialized [ 2.866980] NET: Registered protocol family 38 [ 2.868839] Key type asymmetric registered [ 2.872134] Asymmetric key parser 'x509' registered [ 2.874957] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.878975] io scheduler mq-deadline registered [ 2.881255] io scheduler kyber registered [ 2.883463] io scheduler bfq registered [ 2.886043] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.889711] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.893317] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.896893] ACPI: Power Button [PWRF] [ 2.902569] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.909170] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.921434] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.950394] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.982378] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.989641] Non-volatile memory driver v1.3 [ 2.991870] Linux agpgart interface v0.103 [ 3.032136] virtio_blk virtio1: [vda] 146712 512-byte logical blocks (75.1 MB/71.6 MiB) [ 3.037137] vda: detected capacity change from 0 to 75116544 [ 3.053528] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.056951] vdb: detected capacity change from 0 to 1073741824 [ 3.065264] libphy: Fixed MDIO Bus: probed [ 3.070753] usbcore: registered new interface driver usbserial_generic [ 3.073872] usbserial: USB Serial support registered for generic [ 3.076633] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.081330] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.083508] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.086427] mousedev: PS/2 mouse device common for all mice [ 3.089834] rtc_cmos 00:05: RTC can wake from S4 [ 3.092604] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.097404] rtc_cmos 00:05: registered as rtc0 [ 3.099641] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.100157] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.106262] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.107245] intel_pstate: CPU model not supported [ 3.123934] hid: raw HID events driver (C) Jiri Kosina [ 3.127224] usbcore: registered new interface driver usbhid [ 3.129415] usbhid: USB HID core driver [ 3.131158] drop_monitor: Initializing network drop monitor service [ 3.133755] Initializing XFRM netlink socket [ 3.135829] NET: Registered protocol family 10 [ 3.138779] Segment Routing with IPv6 [ 3.140344] NET: Registered protocol family 17 [ 3.143257] mpls_gso: MPLS GSO support [ 3.150898] RAS: Correctable Errors collector initialized. [ 3.153434] AVX version of gcm_enc/dec engaged. [ 3.155272] AES CTR mode by8 optimization enabled [ 3.260802] sched_clock: Marking stable (3260776799, 0)->(4118377438, -857600639) [ 3.265728] registered taskstats version 1 [ 3.268139] Loading compiled-in X.509 certificates [ 3.271261] zswap: loaded using pool lzo/zbud [ 3.298051] Key type big_key registered [ 3.311976] Key type encrypted registered [ 3.313983] ima: No TPM chip found, activating TPM-bypass! [ 3.316250] ima: Allocated hash algorithm: sha1 [ 3.317937] ima: No architecture policies found [ 3.319761] evm: Initialising EVM extended attributes: [ 3.321625] evm: security.selinux [ 3.322932] evm: security.ima [ 3.324085] evm: security.capability [ 3.325314] evm: HMAC attrs: 0x1 [ 3.329224] rtc_cmos 00:05: setting system clock to 2026-09-08 05:05:19 UTC (1788843919) [ 3.335461] debug: unmapping init [mem 0xffffffffa4a03000-0xffffffffa4bfffff] [ 3.339096] debug: unmapping init [mem 0xffffffffa3782000-0xffffffffa3a58fff] [ 3.349111] Write protecting the kernel read-only data: 28672k [ 3.353504] debug: unmapping init [mem 0xffffffffa1e03000-0xffffffffa1ffffff] [ 3.356430] debug: unmapping init [mem 0xffffffffa2714000-0xffffffffa27fffff] [ 3.399476] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.409133] systemd[1]: Detected virtualization kvm. [ 3.411555] systemd[1]: Detected architecture x86-64. [ 3.413768] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.440228] systemd[1]: No hostname configured. [ 3.441918] systemd[1]: Set hostname to . [ 3.444255] random: systemd: uninitialized urandom read (16 bytes read) [ 3.447102] systemd[1]: Initializing machine ID from random generator. [ 3.589516] random: systemd: uninitialized urandom read (16 bytes read) [ 3.593126] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.597761] random: systemd: uninitialized urandom read (16 bytes read) [ 3.603884] systemd[1]: Starting Apply Kernel Variables... Starting Apply Kernel Variables... [ 3.612163] systemd[1]: Starting Setup Virtual Console... Starting Setup Virtual Console... [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Slices. [ OK ] Reached target Swap. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Initrd Root Device. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Timers. [ OK ] Reached target Paths. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.258806] device-mapper: uevent: version 1.0.3 [ 4.261646] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 5.099535] virtio_net virtio0 ens2: renamed from eth0 [ 5.159983] scsi host0: ata_piix [ 5.165728] scsi host1: ata_piix [ 5.169106] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.171368] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.714480] dracut-initqueue[581]: RTNETLINK answers: File exists [ 9.831180] random: crng init done [ 9.833212] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.272201] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Swap. [ 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 Slices. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.362535] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.649696] SELinux: Disabled at runtime. [ 11.717797] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.726592] systemd[1]: Detected virtualization kvm. [ 11.728334] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.227291] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.230933] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.236428] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.240825] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.244855] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.254296] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.262386] systemd[1]: Activating swap /dev/disk/by-label/SWAP... Activating swap /dev/disk/by-label/SWAP... Mounting Kernel Debug File System... [ OK ] Listening on udev Control Socket. Mounting Huge Pages File System... Starting Remount Root and Kernel File Systems... Startin[ 12.292200] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS g Create list of required st…ce nodes for the current kernel... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-getty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Kernel Socket. Starting Apply Kernel Variables... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting POSIX Message Queue File System... [ OK ] Reached target RPC Port Mapper. Starting udev Coldplug all Devices... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.671513] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.990251] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.056554] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.144538] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.157308] EDAC sbridge: Ver: 1.1.2 [ 14.142571] Key type dns_resolver registered [ 14.441777] NFS: Registering the id_resolver key type [ 14.443851] Key type id_resolver registered [ 14.445373] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Rebuild Dynamic Linker Cache... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Network Manager... Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting 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. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg339-client login: [ 74.323608] libcfs: loading out-of-tree module taints kernel. [ 74.549995] Key type ._llcrypt registered [ 74.558404] Key type .llcrypt registered [ 75.009106] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 75.039607] alg: No test for adler32 (adler32-zlib) [ 76.665652] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 77.698800] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 79.527307] Key type lgssc registered [ 81.636487] Lustre: Echo OBD driver; http://www.lustre.org/ [ 141.695493] hrtimer: interrupt took 3558075 ns [ 256.144502] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 261.735579] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 279.313390] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing check_logdir /tmp/testlogs/ [ 281.568179] Lustre: lustre-OST0000-osc-ffff9307d12e9000: disconnect after 22s idle [ 284.434132] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing yml_node [ 289.248967] Lustre: DEBUG MARKER: Client: 2.17.57.111 [ 292.026232] Lustre: DEBUG MARKER: MDS: 2.17.57.111 [ 295.031784] Lustre: DEBUG MARKER: OSS: 2.17.57.111 [ 296.997668] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Tue Sep 8 01:10:11 EDT 2026 [ 315.670964] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 317.410752] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 320.156749] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 330.461575] Lustre: Unmounted lustre-client [ 453.553360] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 459.518557] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 482.569609] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 521.206292] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 01:13:55 (1788844435) [ 568.604366] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 575.294122] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 619.229808] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 678.032302] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 683.886993] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 719.936655] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 742.916837] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 01:17:37 (1788844657) [ 849.850486] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 855.839218] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 877.422724] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 878.128744] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 902.105036] Lustre: Unmounted lustre-client [ 929.863940] Key type lgssc unregistered [ 930.112339] LNet: 21892:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 930.122063] LNetError: 21892:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 930.142157] LNet: Removed LNI 192.168.203.39@tcp [ 930.997147] Key type .llcrypt unregistered [ 931.001924] Key type ._llcrypt unregistered [ 946.807723] Key type ._llcrypt registered [ 946.810582] Key type .llcrypt registered [ 948.621619] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 01:21:02 (1788844862) [ 951.376845] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 951.390535] alg: No test for adler32 (adler32-zlib) [ 952.554128] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 952.940901] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 954.680492] Key type lgssc registered [ 956.508194] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1013.232285] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1018.927569] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1043.396517] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1046.372657] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 1059.744825] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 01:22:54 (1788844974) [ 1071.567719] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 01:23:06 (1788844986) [ 1081.861741] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 01:23:16 (1788844996) [ 1097.240981] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 01:23:31 (1788845011) [ 1122.937950] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 01:23:57 (1788845037) [ 1137.528536] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 01:24:12 (1788845052) [ 1151.997288] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 01:24:26 (1788845066) [ 1161.444129] Lustre: Unmounted lustre-client [ 1161.846930] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 1164.351559] Lustre: Unmounted lustre-client [ 1192.101715] Key type lgssc unregistered [ 1192.388077] LNet: 30261:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1192.397439] LNetError: 30261:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1192.415805] LNet: Removed LNI 192.168.203.39@tcp [ 1193.142663] Key type .llcrypt unregistered [ 1193.150057] Key type ._llcrypt unregistered [ 1220.078633] Key type ._llcrypt registered [ 1220.080471] Key type .llcrypt registered [ 1220.528196] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1220.556806] alg: No test for adler32 (adler32-zlib) [ 1221.647737] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 1221.955410] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1223.671199] Key type lgssc registered [ 1225.413579] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1315.918696] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1322.144942] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1345.289833] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1384.400957] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 01:28:19 (1788845299) [ 1414.913233] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1420.711242] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1443.007657] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1444.742787] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 1585.104442] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 01:31:39 (1788845499) [ 1633.015450] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 01:32:27 (1788845547) [ 1644.309160] Lustre: Unmounted lustre-client [ 1734.453398] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1742.305224] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1766.506661] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1767.544873] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 1773.713030] Lustre: Unmounted lustre-client [ 1802.615636] Key type lgssc unregistered [ 1802.864415] LNet: 41588:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1802.874531] LNetError: 41588:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1802.891319] LNet: Removed LNI 192.168.203.39@tcp [ 1803.713596] Key type .llcrypt unregistered [ 1803.721374] Key type ._llcrypt unregistered [ 1819.258495] Key type ._llcrypt registered [ 1819.261246] Key type .llcrypt registered [ 1820.723330] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 01:35:35 (1788845735) [ 1823.315101] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1823.380942] alg: No test for adler32 (adler32-zlib) [ 1824.505961] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 1824.865669] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 1826.559177] Key type lgssc registered [ 1827.898615] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1878.821385] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1884.500316] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1906.219699] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1908.985188] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 1924.521836] Lustre: Unmounted lustre-client [ 2008.933506] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2015.733831] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2035.663896] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2036.575405] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 2042.599608] Lustre: Unmounted lustre-client [ 2068.881634] Key type lgssc unregistered [ 2069.211559] LNet: 47122:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2069.231790] LNetError: 47122:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2069.257727] LNet: Removed LNI 192.168.203.39@tcp [ 2069.941934] Key type .llcrypt unregistered [ 2069.945652] Key type ._llcrypt unregistered [ 2083.949110] Key type ._llcrypt registered [ 2083.951076] Key type .llcrypt registered [ 2085.136168] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 01:39:59 (1788845999) [ 2087.776736] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2087.877593] alg: No test for adler32 (adler32-zlib) [ 2089.026308] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 2089.332205] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2091.039731] Key type lgssc registered [ 2092.407442] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2144.128681] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2149.420861] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2174.204245] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2176.258345] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 2286.215569] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 01:43:21 (1788846201) [ 2287.775201] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 2289.541901] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 01:43:24 (1788846204) [ 2291.702177] Lustre: Unmounted lustre-client [ 2319.419266] Key type lgssc unregistered [ 2319.732972] LNet: 52460:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2319.749673] LNetError: 52460:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2319.774468] LNet: Removed LNI 192.168.203.39@tcp [ 2320.530530] Key type .llcrypt unregistered [ 2320.534674] Key type ._llcrypt unregistered [ 2352.730195] Key type ._llcrypt registered [ 2352.759707] Key type .llcrypt registered [ 2353.160313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2353.173472] alg: No test for adler32 (adler32-zlib) [ 2354.321896] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 2354.485442] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2356.167260] Key type lgssc registered [ 2358.251610] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2395.383215] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 01:45:10 (1788846310) [ 2410.424295] Key type lgssc unregistered [ 2410.738703] LNet: 54869:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2410.765639] LNetError: 54869:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2410.793766] LNet: Removed LNI 192.168.203.39@tcp [ 2411.667796] Key type .llcrypt unregistered [ 2411.670495] Key type ._llcrypt unregistered [ 2426.439302] Key type ._llcrypt registered [ 2426.444122] Key type .llcrypt registered [ 2426.790227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2426.800819] alg: No test for adler32 (adler32-zlib) [ 2427.885348] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 2428.188766] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 2429.855241] Key type lgssc registered [ 2430.881583] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2491.958653] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2501.494860] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2526.405360] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2528.368673] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 2578.031515] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 01:48:12 (1788846492) [ 2580.134604] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 2582.187302] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 01:48:16 (1788846496) [ 2584.980559] Lustre: Unmounted lustre-client [ 2653.520850] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2659.940856] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2737.292629] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 01:50:51 (1788846651) [ 2827.734938] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 2832.502130] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2848.259404] Lustre: lustre-MDT0001-mdc-ffff9307c7c8d800: Connection to lustre-MDT0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2853.348061] Lustre: lustre-OST0000-osc-ffff9307c7c8d800: disconnect after 23s idle [ 2865.991862] LustreError: 63559:0:(obd_config.c:2102:class_config_llog_handler()) MGC192.168.203.139@tcp: cfg command failed: rc = -17 [ 2866.008087] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 2866.008087] [ 2866.029470] LustreError: 62823:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 2880.919137] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID and inheritance flag ========================================================== 01:53:15 (1788846795) [ 2946.447480] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3031.737488] Lustre: Unmounted lustre-client [ 3200.403443] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 3205.226458] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3265.533090] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 01:59:40 (1788847180) [ 3267.675978] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3288.195123] Lustre: Unmounted lustre-client [ 3427.228893] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 02:02:22 (1788847342) [ 3429.150650] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 3431.068413] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 02:02:25 (1788847345) [ 3520.914589] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 3526.458236] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4293.666307] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 02:16:48 (1788848208) [ 4297.087445] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4297.093974] Lustre: Skipped 3 previous similar messages [ 4307.426594] Lustre: Unmounted lustre-client [ 4448.884715] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4455.733198] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4480.462881] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4481.166554] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 6349.605917] Lustre: 95331:0:(llog_cat.c:310:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff9307c59a1000: catlog [0xa:0x5:0x0] crosses index zero [ 6367.887727] Lustre: Unmounted lustre-client [ 6395.835518] Key type lgssc unregistered [ 6395.975913] LNet: 103517:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6395.981833] LNetError: 103517:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6395.996413] LNet: Removed LNI 192.168.203.39@tcp [ 6396.340173] Key type .llcrypt unregistered [ 6396.342296] Key type ._llcrypt unregistered [ 6401.092620] Key type ._llcrypt registered [ 6401.094345] Key type .llcrypt registered [ 6401.817979] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 02:51:57 (1788850317) [ 6411.074334] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6411.127182] alg: No test for adler32 (adler32-zlib) [ 6412.122172] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 6412.293500] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 6413.927486] Key type lgssc registered [ 6414.603385] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6456.817640] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6459.763907] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6470.735319] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6477.294447] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 6483.765269] Lustre: Unmounted lustre-client [ 6547.599602] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6549.816964] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6560.159841] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6590.812561] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 02:55:06 (1788850506) [ 6591.600089] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 6592.405624] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 02:55:07 (1788850507) [ 6606.305972] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6608.681254] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6618.306614] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6623.745616] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 6633.960951] Lustre: lustre-MDT0000-mdc-ffff9307d039e800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6639.076373] Lustre: lustre-MDT0001-mdc-ffff9307d039e800: Connection to lustre-MDT0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6655.455145] Lustre: 104274:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788850555/real 1788850555] req@00000000df6ba28c x1875745521609728/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788850571 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6655.470160] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [ 6785.515824] LustreError: lustre-MDT0000-mdc-ffff9307d039e800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6785.552382] Lustre: lustre-MDT0000-mdc-ffff9307d039e800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 6790.634351] LustreError: lustre-MDT0001-mdc-ffff9307d039e800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6790.662929] Lustre: lustre-MDT0001-mdc-ffff9307d039e800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 6795.520775] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6797.752465] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6799.869792] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0xd38fbf38c2ee6d6f to 0xd38fbf38c2ee85e1 [ 6799.894908] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 6805.377985] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6807.454426] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6824.708170] Lustre: Unmounted lustre-client [ 6924.764752] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6935.340404] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6972.169400] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7020.925779] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 03:02:15 (1788850935) [ 7053.623300] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7059.604502] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7081.311068] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7081.864820] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 7087.495565] LustreError: 120975:0:(lproc_llite.c:618:ll_max_cached_mb_seq_write()) lustre: cannot set max_cached_mb=0 MB more than 3693 MB: rc = -34 [ 7094.656109] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 03:03:29 (1788851009) [ 7096.745141] Lustre: Unmounted lustre-client [ 7125.074363] Key type lgssc unregistered [ 7125.328522] LNet: 121983:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7125.337874] LNetError: 121983:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7125.365319] LNet: Removed LNI 192.168.203.39@tcp [ 7126.282774] Key type .llcrypt unregistered [ 7126.287084] Key type ._llcrypt unregistered [ 7140.932764] Key type ._llcrypt registered [ 7140.937751] Key type .llcrypt registered [ 7141.651515] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7141.673675] alg: No test for adler32 (adler32-zlib) [ 7142.922292] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 7143.205806] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 7144.927499] Key type lgssc registered [ 7146.342297] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7238.264230] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7245.032366] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7268.553858] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7387.691829] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7393.712308] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7417.249937] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7459.417766] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 03:09:34 (1788851374) [ 7470.657703] Key type lgssc unregistered [ 7470.948045] LNet: 129187:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7470.954472] LNetError: 129187:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7470.985240] LNet: Removed LNI 192.168.203.39@tcp [ 7471.833647] Key type .llcrypt unregistered [ 7471.839439] Key type ._llcrypt unregistered [ 7483.604603] Key type ._llcrypt registered [ 7483.605974] Key type .llcrypt registered [ 7483.944764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7483.985146] alg: No test for adler32 (adler32-zlib) [ 7485.032885] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 7485.322446] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 7487.079231] Key type lgssc registered [ 7488.626323] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7538.728896] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7544.261975] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7570.128675] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7699.035182] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7704.796637] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7728.524391] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7780.787741] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 03:14:55 (1788851695) [ 7855.660891] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 7860.674347] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 7867.660307] Lustre: DEBUG MARKER: ADD OST3 [ 7880.485521] Lustre: DEBUG MARKER: STOP OST3 [ 7881.191443] Lustre: lustre-OST0000-osc-ffff9307c33d0800: disconnect after 23s idle [ 7892.982660] Lustre: lustre-OST0003-osc-ffff9307c33d0800: Connection to lustre-OST0003 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7902.785904] Lustre: DEBUG MARKER: START OST3 again [ 7911.811198] Lustre: lustre-OST0003-osc-ffff9307c33d0800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [ 7941.134553] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7941.146504] LustreError: 139976:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9307c33d0800: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 7951.497182] Lustre: Unmounted lustre-client [ 8068.368250] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8078.878459] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8104.541953] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8139.678682] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 03:20:54 (1788852054) [ 8229.442644] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8234.774477] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8258.253117] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8330.933782] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8337.545724] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8360.480486] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8362.579331] LNetError: 129595:0:(lib-move.c:2158:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 8362.935120] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 8368.539330] Lustre: Unmounted lustre-client [ 8400.576639] Key type lgssc unregistered [ 8413.279498] LNet: 1 local NIs in recovery (showing 1): 192.168.203.39@tcp [ 8420.319626] LNet: 148961:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8420.326160] LNetError: 148961:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8492.011760] LNet: Removed LNI 192.168.203.39@tcp [ 8492.828151] Key type .llcrypt unregistered [ 8492.831283] Key type ._llcrypt unregistered [ 8510.548130] Key type ._llcrypt registered [ 8510.550207] Key type .llcrypt registered [ 8511.769672] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 03:27:06 (1788852426) [ 8532.003438] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8532.024185] alg: No test for adler32 (adler32-zlib) [ 8533.347802] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 8533.972220] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 8535.871637] Key type lgssc registered [ 8538.126535] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8625.848942] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8634.111585] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8670.022176] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8808.518071] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 8813.748818] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8821.053197] Lustre: Unmounted lustre-client [ 8821.202274] LNetError: 150140:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5439:f3ff:fe16:1d66/1023: rc = -22 [ 8821.214544] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 8821.532435] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 8821.731951] Lustre: Unmounted lustre-client [ 8822.661599] LNetError: 150141:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5439:f3ff:fe16:1d66/1023: rc = -22 [ 8822.695481] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 8822.972699] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 8822.975348] Lustre: Skipped 1 previous similar message [ 8823.158115] Lustre: Unmounted lustre-client [ 8823.159236] Lustre: Skipped 1 previous similar message [ 8825.161583] LNetError: 150141:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5439:f3ff:fe16:1d66/1023: rc = -22 [ 8825.169839] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 8825.519951] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 8825.529922] Lustre: Skipped 3 previous similar messages [ 8825.687907] Lustre: Unmounted lustre-client [ 8825.692193] Lustre: Skipped 3 previous similar messages [ 8826.407817] Lustre: 156082:0:(obd_mount.c:175:lustre_add_mgc_failnodes()) MGC6699:7654::1234:1234:d84@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 8826.927881] Lustre: 156112:0:(obd_mount.c:175:lustre_add_mgc_failnodes()) MGC193.168.0.240@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 8837.265351] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 03:32:30 (1788852750) [ 8885.154885] LNet: 1 local NIs in recovery (showing 1): 192.168.203.39@tcp [ 8957.777880] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8963.001660] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8988.591715] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9062.436622] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9068.893906] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9094.346488] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9099.999518] LustreError: 161711:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 9146.399458] LNet: 1 local NIs in recovery (showing 1): 192.168.203.39@tcp [ 9225.248800] LNet: 1 local NIs in recovery (showing 1): 192.168.203.39@tcp [ 9236.448988] 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 [ 9236.482770] Lustre: Unmounted lustre-client [ 9236.493399] Lustre: Skipped 3 previous similar messages [ 9236.498697] LustreError: 161711:0:(super25.c:179:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 9272.382899] Key type lgssc unregistered [ 9285.663142] LNet: 1 local NIs in recovery (showing 1): 192.168.203.39@tcp [ 9289.132707] LNet: 162168:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9289.155342] LNetError: 162168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9356.775889] LNet: Removed LNI 192.168.203.39@tcp [ 9357.873180] Key type .llcrypt unregistered [ 9357.875848] Key type ._llcrypt unregistered [ 9375.914936] Key type ._llcrypt registered [ 9375.917136] Key type .llcrypt registered [ 9377.569558] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 03:41:31 (1788853291) [ 9398.032353] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9398.054526] alg: No test for adler32 (adler32-zlib) [ 9399.570558] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [ 9400.071132] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [ 9401.905373] Key type lgssc registered [ 9403.172561] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9558.876560] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 9564.384323] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9584.608842] Lustre: lustre-OST0000-osc-ffff9307d0398800: disconnect after 23s idle [ 9586.080076] Lustre: Unmounted lustre-client [ 9769.189703] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [ 9774.256591] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9781.160237] Lustre: Unmounted lustre-client [ 9833.171637] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 03:49:06 (1788853746) [ 9946.873864] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9953.823249] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9978.405997] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10110.722809] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [10115.987664] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10134.852735] Lustre: Unmounted lustre-client [10252.952870] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [10259.760498] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10278.368861] Lustre: lustre-OST0001-osc-ffff9307c7c93000: disconnect after 23s idle [10278.380846] Lustre: Skipped 1 previous similar message [10281.193411] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 03:56:36 (1788854196) [10283.872193] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10294.285955] Lustre: Unmounted lustre-client [10482.699478] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [10488.813149] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10497.419172] Lustre: Unmounted lustre-client [10498.338673] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [10509.980415] Lustre: Unmounted lustre-client [10513.042445] Lustre: DEBUG MARKER: == conf-sanity test 157a: test allow_register for MDT registration and MGS restart ========================================================== 04:00:26 (1788854426) [10607.235683] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10616.271919] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10641.614431] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10647.659448] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [10744.814655] LustreError: lustre-OST0001-osc-ffff9307c55fb800: operation ost_connect to node 192.168.203.139@tcp failed: rc = -19 [10744.818472] Lustre: lustre-MDT0000-mdc-ffff9307c55fb800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [10760.172949] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [10760.214578] LustreError: lustre-MDT0000-mdc-ffff9307c55fb800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10760.259186] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0xe0ddf84cef1b84d0 to 0xe0ddf84cef1b8834 [10760.280955] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [10760.293481] Lustre: Skipped 1 previous similar message [10807.809638] Lustre: Unmounted lustre-client [10845.019606] Key type lgssc unregistered [10845.309394] LNet: 189716:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10845.320989] LNetError: 189716:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10845.347542] LNet: Removed LNI 192.168.203.39@tcp [10846.192210] Key type .llcrypt unregistered [10846.198531] Key type ._llcrypt unregistered [10857.515696] Key type ._llcrypt registered [10857.518740] Key type .llcrypt registered [10859.383145] Lustre: DEBUG MARKER: == conf-sanity test 157b: verify allow_register (block new OSTs, allow existing) ========================================================== 04:06:13 (1788854773) [10862.214960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10862.251942] alg: No test for adler32 (adler32-zlib) [10863.417607] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [10863.696850] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [10865.415409] Key type lgssc registered [10866.994493] Lustre: Echo OBD driver; http://www.lustre.org/ [10925.412806] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10931.684729] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10960.064297] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10961.933224] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [11059.192974] LustreError: lustre-OST0001-osc-ffff9307c7b5f000: operation ost_connect to node 192.168.203.139@tcp failed: rc = -19 [11178.341836] Lustre: Unmounted lustre-client [11208.485738] Key type lgssc unregistered [11208.949828] LNet: 195742:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11208.958702] LNetError: 195742:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11210.023380] LNet: Removed LNI 192.168.203.39@tcp [11211.584272] Key type .llcrypt unregistered [11211.589304] Key type ._llcrypt unregistered [11228.179488] Key type ._llcrypt registered [11228.181111] Key type .llcrypt registered [11230.317041] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 04:12:24 (1788855144) [11260.962781] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11260.980178] alg: No test for adler32 (adler32-zlib) [11262.289501] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [11262.598951] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11264.327186] Key type lgssc registered [11265.772684] Lustre: Echo OBD driver; http://www.lustre.org/ [11357.496180] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11365.101391] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11393.184690] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11433.725356] Key type lgssc unregistered [11434.124874] LNet: 200719:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11434.133033] LNetError: 200719:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11434.155172] LNet: Removed LNI 192.168.203.39@tcp [11434.989905] Key type .llcrypt unregistered [11434.994265] Key type ._llcrypt unregistered [11549.487861] Key type ._llcrypt registered [11549.497621] Key type .llcrypt registered [11550.031723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11550.069148] alg: No test for adler32 (adler32-zlib) [11551.239859] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [11551.532574] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11553.191296] Key type lgssc registered [11554.258118] Lustre: Echo OBD driver; http://www.lustre.org/ [11604.287741] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 04:18:38 (1788855518) [11644.998123] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11651.574962] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11677.210132] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11679.202726] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [11681.807444] Lustre: Unmounted lustre-client [11682.260600] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [11682.569573] Lustre: Unmounted lustre-client [11683.357451] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [11691.899310] Lustre: Unmounted lustre-client [11722.595649] Key type lgssc unregistered [11723.111880] LNet: 205691:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11723.119824] LNetError: 205691:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11723.152869] LNet: Removed LNI 192.168.203.39@tcp [11724.063403] Key type .llcrypt unregistered [11724.068916] Key type ._llcrypt unregistered [11739.502764] Key type ._llcrypt registered [11739.509624] Key type .llcrypt registered [11741.341873] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 04:20:55 (1788855655) [11745.406852] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11745.458723] alg: No test for adler32 (adler32-zlib) [11746.594651] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [11746.872492] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [11748.663218] Key type lgssc registered [11750.350037] Lustre: Echo OBD driver; http://www.lustre.org/ [11811.982069] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11817.930667] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11840.238045] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11842.808827] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [11854.624368] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11856.176279] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11863.528542] Lustre: lustre-MDT0000-mdc-ffff9307eb619800: Connection to lustre-MDT0000 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [11884.013882] Lustre: lustre-MDT0001-mdc-ffff9307eb619800: Connection to lustre-MDT0001 (at 192.168.203.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [11895.263498] Lustre: 206365:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788855795/real 1788855795] req@00000000be34f0a0 x1875751115692800/t0(0) o400->MGC192.168.203.139@tcp@192.168.203.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1788855811 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11895.288205] LustreError: MGC192.168.203.139@tcp: Connection to MGS (at 192.168.203.139@tcp) was lost; in progress operations using this service will fail [11940.331533] Lustre: Evicted from MGS (at 192.168.203.139@tcp) after server handle changed from 0x288adfb4ea57cd9e to 0x288adfb4ea57d022 [11940.341746] Lustre: MGC192.168.203.139@tcp: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [11971.558935] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11973.117912] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [11976.184972] LustreError: lustre-MDT0000-mdc-ffff9307eb619800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [11976.225993] Lustre: lustre-MDT0000-mdc-ffff9307eb619800: Connection restored to 192.168.203.139@tcp (at 192.168.203.139@tcp) [11979.199895] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11980.870122] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11983.226051] Lustre: Unmounted lustre-client [12009.889192] Key type lgssc unregistered [12010.161914] LNet: 211229:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12010.170231] LNetError: 211229:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12010.184430] LNet: Removed LNI 192.168.203.39@tcp [12010.927950] Key type .llcrypt unregistered [12010.931778] Key type ._llcrypt unregistered [12043.595189] Key type ._llcrypt registered [12043.604879] Key type .llcrypt registered [12043.963648] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12043.990415] alg: No test for adler32 (adler32-zlib) [12045.253394] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12045.596939] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12047.335327] Key type lgssc registered [12048.718734] Lustre: Echo OBD driver; http://www.lustre.org/ [12141.821600] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12151.577540] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12180.463070] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12224.528925] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 04:28:59 (1788856139) [12336.003809] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12341.821400] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12366.817604] Lustre: DEBUG MARKER: oleg339-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12368.595193] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [12373.644117] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [12374.860134] Lustre: Mounted lustre-client - version 2.17.57_111_g33f3974 [12374.866959] Lustre: Skipped 1 previous similar message [12379.349970] Lustre: Unmounted lustre-client [12381.302969] Lustre: Unmounted lustre-client [12383.202902] Lustre: Unmounted lustre-client [12385.449605] Lustre: Unmounted lustre-client [12398.096521] Lustre: Unmounted lustre-client [12398.103926] Lustre: Skipped 1 previous similar message [12425.797354] Key type lgssc unregistered [12426.166712] LNet: 220397:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12426.179167] LNetError: 220397:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12426.199473] LNet: Removed LNI 192.168.203.39@tcp [12426.883081] Key type .llcrypt unregistered [12426.886408] Key type ._llcrypt unregistered [12438.444819] Key type ._llcrypt registered [12438.449987] Key type .llcrypt registered [12439.902959] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 04:32:34 (1788856354) [12452.719476] Key type .llcrypt unregistered [12452.723464] Key type ._llcrypt unregistered [12453.545567] Key type ._llcrypt registered [12453.548071] Key type .llcrypt registered [12453.959749] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [12453.966563] alg: No test for adler32 (adler32-zlib) [12455.034160] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12455.313452] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12457.015357] Key type lgssc registered [12458.098102] Lustre: Echo OBD driver; http://www.lustre.org/ [12487.426284] Key type lgssc unregistered [12487.829683] LNet: 222543:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12487.847326] LNetError: 222543:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12487.868568] LNet: Removed LNI 192.168.203.39@tcp [12489.318647] Key type .llcrypt unregistered [12489.323528] Key type ._llcrypt unregistered [12490.175317] Key type ._llcrypt registered [12490.177965] Key type .llcrypt registered [12492.393124] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 04:33:25 (1788856405) [12513.304645] Key type .llcrypt unregistered [12513.307912] Key type ._llcrypt unregistered [12515.638557] Key type ._llcrypt registered [12515.644349] Key type .llcrypt registered [12516.764713] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12516.804267] alg: No test for adler32 (adler32-zlib) [12518.204417] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12518.539397] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12520.271346] Key type lgssc registered [12522.319833] Lustre: Echo OBD driver; http://www.lustre.org/ [12544.280597] Key type lgssc unregistered [12544.693972] LNet: 224089:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12544.705926] LNetError: 224089:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12544.738903] LNet: Removed LNI 192.168.203.39@tcp [12545.804523] Key type .llcrypt unregistered [12545.809710] Key type ._llcrypt unregistered [12558.737505] Key type ._llcrypt registered [12558.739950] Key type .llcrypt registered [12559.209352] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12559.234771] alg: No test for adler32 (adler32-zlib) [12560.343850] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12560.541043] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12562.223254] Key type lgssc registered [12564.780455] Lustre: Echo OBD driver; http://www.lustre.org/ [12595.310480] Key type lgssc unregistered [12595.599291] LNet: 225850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12595.612942] LNetError: 225850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12595.631369] LNet: Removed LNI 192.168.203.39@tcp [12596.399508] Key type .llcrypt unregistered [12596.405114] Key type ._llcrypt unregistered [12596.787336] Key type ._llcrypt registered [12596.790305] Key type .llcrypt registered [12598.205432] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 04:35:12 (1788856512) [12611.043056] Key type .llcrypt unregistered [12611.045751] Key type ._llcrypt unregistered [12611.637902] Key type ._llcrypt registered [12611.639769] Key type .llcrypt registered [12612.121636] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12612.132971] alg: No test for adler32 (adler32-zlib) [12613.175465] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12613.450662] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12615.135199] Key type lgssc registered [12616.433598] Lustre: Echo OBD driver; http://www.lustre.org/ [12637.001261] Key type lgssc unregistered [12637.379750] LNet: 227390:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12637.402787] LNetError: 227390:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12637.426713] LNet: Removed LNI 192.168.203.39@tcp [12638.319633] Key type .llcrypt unregistered [12638.333200] Key type ._llcrypt unregistered [12646.128696] Key type ._llcrypt registered [12646.133720] Key type .llcrypt registered [12646.562549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12646.588556] alg: No test for adler32 (adler32-zlib) [12647.649831] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12648.016621] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12649.826138] Key type lgssc registered [12651.360334] Lustre: Echo OBD driver; http://www.lustre.org/ [12668.951249] Key type lgssc unregistered [12669.333903] LNet: 228692:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12669.357986] LNetError: 228692:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12669.376271] LNet: Removed LNI 192.168.203.39@tcp [12670.212474] Key type .llcrypt unregistered [12670.215330] Key type ._llcrypt unregistered [12678.703886] Key type ._llcrypt registered [12678.719159] Key type .llcrypt registered [12679.291056] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12679.324566] alg: No test for adler32 (adler32-zlib) [12680.457812] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12680.763842] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12682.479248] Key type lgssc registered [12683.679364] Lustre: Echo OBD driver; http://www.lustre.org/ [12699.806073] Key type lgssc unregistered [12700.055717] LNet: 229993:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12700.071609] LNetError: 229993:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12700.086823] LNet: Removed LNI 192.168.203.39@tcp [12700.740660] Key type .llcrypt unregistered [12700.744278] Key type ._llcrypt unregistered [12707.211160] Key type ._llcrypt registered [12707.217568] Key type .llcrypt registered [12707.666312] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12707.678104] alg: No test for adler32 (adler32-zlib) [12708.846561] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12709.292109] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12711.031187] Key type lgssc registered [12712.243763] Lustre: Echo OBD driver; http://www.lustre.org/ [12736.749191] Key type lgssc unregistered [12736.983765] LNet: 231756:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12736.992443] LNetError: 231756:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12737.022408] LNet: Removed LNI 192.168.203.39@tcp [12737.707209] Key type .llcrypt unregistered [12737.708887] Key type ._llcrypt unregistered [12738.068887] Key type ._llcrypt registered [12738.074450] Key type .llcrypt registered [12739.416528] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 04:37:34 (1788856654) [12750.674294] Key type .llcrypt unregistered [12750.680477] Key type ._llcrypt unregistered [12751.499191] Key type ._llcrypt registered [12751.504559] Key type .llcrypt registered [12752.017866] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12752.028349] alg: No test for adler32 (adler32-zlib) [12753.095861] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12753.390383] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12755.119445] Key type lgssc registered [12756.537334] Lustre: Echo OBD driver; http://www.lustre.org/ [12772.829444] Key type lgssc unregistered [12773.144660] LNet: 233296:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12773.164308] LNetError: 233296:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12773.197522] LNet: Removed LNI 192.168.203.39@tcp [12774.240837] Key type .llcrypt unregistered [12774.248066] Key type ._llcrypt unregistered [12783.232578] Key type ._llcrypt registered [12783.238316] Key type .llcrypt registered [12784.022704] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12784.055337] alg: No test for adler32 (adler32-zlib) [12785.388471] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12785.638044] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12787.360543] Key type lgssc registered [12789.722832] Lustre: Echo OBD driver; http://www.lustre.org/ [12811.558713] Key type lgssc unregistered [12811.715541] LNet: 234608:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12811.724170] LNetError: 234608:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12811.736933] LNet: Removed LNI 192.168.203.39@tcp [12812.167869] Key type .llcrypt unregistered [12812.169744] Key type ._llcrypt unregistered [12820.242131] Key type ._llcrypt registered [12820.270832] Key type .llcrypt registered [12820.610711] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12820.641227] alg: No test for adler32 (adler32-zlib) [12821.816780] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12822.107311] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12823.783254] Key type lgssc registered [12824.774756] Lustre: Echo OBD driver; http://www.lustre.org/ [12841.341414] Key type lgssc unregistered [12841.611852] LNet: 235912:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12841.624180] LNetError: 235912:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12841.652676] LNet: Removed LNI 192.168.203.39@tcp [12842.382888] Key type .llcrypt unregistered [12842.385115] Key type ._llcrypt unregistered [12850.400425] Key type ._llcrypt registered [12850.401960] Key type .llcrypt registered [12851.077674] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12851.102028] alg: No test for adler32 (adler32-zlib) [12852.294488] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12852.725122] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12854.552244] Key type lgssc registered [12856.385647] Lustre: Echo OBD driver; http://www.lustre.org/ [12875.592254] Key type lgssc unregistered [12875.981665] LNet: 237216:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12875.989948] LNetError: 237216:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12876.029203] LNet: Removed LNI 192.168.203.39@tcp [12877.036540] Key type .llcrypt unregistered [12877.038938] Key type ._llcrypt unregistered [12885.562602] Key type ._llcrypt registered [12885.576153] Key type .llcrypt registered [12886.438512] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12886.463044] alg: No test for adler32 (adler32-zlib) [12887.839456] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12888.181864] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12889.967198] Key type lgssc registered [12891.723988] Lustre: Echo OBD driver; http://www.lustre.org/ [12909.513700] Key type lgssc unregistered [12909.795507] LNet: 238523:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12909.804197] LNetError: 238523:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12909.827935] LNet: Removed LNI 192.168.203.39@tcp [12910.381558] Key type .llcrypt unregistered [12910.383775] Key type ._llcrypt unregistered [12919.573555] Key type ._llcrypt registered [12919.582270] Key type .llcrypt registered [12920.169988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12920.197514] alg: No test for adler32 (adler32-zlib) [12921.482709] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [12922.087334] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [12923.896449] Key type lgssc registered [12926.571629] Lustre: Echo OBD driver; http://www.lustre.org/ [12949.925859] Key type lgssc unregistered [12950.250861] LNet: 239824:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12950.273370] LNetError: 239824:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12950.296776] LNet: Removed LNI 192.168.203.39@tcp [12951.413717] Key type .llcrypt unregistered [12951.415370] Key type ._llcrypt unregistered [12982.338185] Key type ._llcrypt registered [12982.339338] Key type .llcrypt registered [12983.865108] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 04:41:38 (1788856898) [12998.900910] Key type .llcrypt unregistered [12998.905412] Key type ._llcrypt unregistered [13000.288474] Key type ._llcrypt registered [13000.296534] Key type .llcrypt registered [13001.488602] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13001.514711] alg: No test for adler32 (adler32-zlib) [13002.884609] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [13003.356864] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [13005.087277] Key type lgssc registered [13006.995410] Lustre: Echo OBD driver; http://www.lustre.org/ [13026.982622] Key type lgssc unregistered [13027.284846] LNet: 242134:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13027.296885] LNetError: 242134:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13027.318751] LNet: Removed LNI 192.168.203.39@tcp [13028.028561] Key type .llcrypt unregistered [13028.030518] Key type ._llcrypt unregistered [13036.308617] Key type ._llcrypt registered [13036.314579] Key type .llcrypt registered [13036.699405] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13036.737335] alg: No test for adler32 (adler32-zlib) [13037.857953] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [13038.191966] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [13039.888898] Key type lgssc registered [13041.473446] Lustre: Echo OBD driver; http://www.lustre.org/ [13062.868792] Key type lgssc unregistered [13063.199725] LNet: 243451:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13063.209697] LNetError: 243451:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13063.223906] LNet: Removed LNI 192.168.203.39@tcp [13064.232856] Key type .llcrypt unregistered [13064.236461] Key type ._llcrypt unregistered [13072.847290] Key type ._llcrypt registered [13072.885755] Key type .llcrypt registered [13073.550033] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13073.570909] alg: No test for adler32 (adler32-zlib) [13074.711761] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [13075.015626] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [13076.800675] Key type lgssc registered [13078.396849] Lustre: Echo OBD driver; http://www.lustre.org/ [13097.194325] Key type lgssc unregistered [13097.494942] LNet: 244758:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13097.504284] LNetError: 244758:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13097.526582] LNet: Removed LNI 192.168.203.39@tcp [13098.650775] Key type .llcrypt unregistered [13098.652974] Key type ._llcrypt unregistered [13109.326423] Key type ._llcrypt registered [13109.331215] Key type .llcrypt registered [13110.283112] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13110.321793] alg: No test for adler32 (adler32-zlib) [13111.749489] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [13112.241538] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [13114.047220] Key type lgssc registered [13115.886357] Lustre: Echo OBD driver; http://www.lustre.org/ [13147.133230] Key type lgssc unregistered [13147.466270] LNet: 246547:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13147.471432] LNetError: 246547:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13147.492155] LNet: Removed LNI 192.168.203.39@tcp [13148.486420] Key type .llcrypt unregistered [13148.488697] Key type ._llcrypt unregistered [13148.982788] Key type ._llcrypt registered [13148.986351] Key type .llcrypt registered [13150.467733] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 04:44:24 (1788857064) [13172.089963] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13172.225618] alg: No test for adler32 (adler32-zlib) [13173.527626] Lustre: Lustre: Build Version: 2.17.57_111_g33f3974 [13173.916575] LNet: Added LNI 192.168.203.39@tcp [8/256/0/180] [13175.657037] Key type lgssc registered [13177.249329] Lustre: Echo OBD driver; http://www.lustre.org/ [13429.704862] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 04:49:04 (1788857344) [13431.559565] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [13498.799389] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 13200 sec ========= 04:50:13 (1788857413) [13500.588446] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 04:50:15 (1788857415) === [13504.676931] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 04:50:19 (1788857419) === [13544.088288] Key type lgssc unregistered [13544.348748] LNet: 255602:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13544.361223] LNetError: 255602:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13544.385669] LNet: Removed LNI 192.168.203.39@tcp [13545.117313] Key type .llcrypt unregistered [13545.124522] Key type ._llcrypt unregistered