[ 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 476149537 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003259] x2apic enabled [ 0.004007] Switched APIC routing to physical x2apic. [ 0.005013] kvm-guest: setup PV IPIs [ 0.007991] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.008021] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.009014] pid_max: default: 32768 minimum: 301 [ 0.010116] LSM: Security Framework initializing [ 0.012017] Yama: becoming mindful. [ 0.013032] SELinux: Initializing. [ 0.014058] *** VALIDATE selinux *** [ 0.022639] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027330] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028160] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029110] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030110] *** VALIDATE tmpfs *** [ 0.032278] *** VALIDATE proc *** [ 0.033235] *** VALIDATE cgroup *** [ 0.034010] *** VALIDATE cgroup2 *** [ 0.035282] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036149] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038031] Spectre V2 : User space: Vulnerable [ 0.039008] Speculative Store Bypass: Vulnerable [ 0.041750] debug: unmapping init [mem 0xffffffffa0659000-0xffffffffa0660fff] [ 0.043891] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044782] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045026] ... version: 2 [ 0.046010] ... bit width: 48 [ 0.047010] ... generic registers: 4 [ 0.048010] ... value mask: 0000ffffffffffff [ 0.049013] ... max period: 00007fffffffffff [ 0.050011] ... fixed-purpose events: 3 [ 0.051009] ... event mask: 000000070000000f [ 0.052301] rcu: Hierarchical SRCU implementation. [ 0.054454] smp: Bringing up secondary CPUs ... [ 0.055672] x86: Booting SMP configuration: [ 0.056023] .... node #0, CPUs: #1 #2 #3 [ 0.066019] smp: Brought up 1 node, 4 CPUs [ 0.068016] smpboot: Max logical packages: 1 [ 0.069011] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.096421] node 0 deferred pages initialised in 25ms [ 0.100033] devtmpfs: initialized [ 0.101313] x86/mm: Memory block size: 128MB [ 0.104118] gcov: version magic: 0x41383552 [ 0.106381] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.107136] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.108238] pinctrl core: initialized pinctrl subsystem [ 0.109246] [ 0.109889] ************************************************************* [ 0.110017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.111012] ** ** [ 0.112012] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.113012] ** ** [ 0.114014] ** This means that this kernel is built to expose internal ** [ 0.115013] ** IOMMU data structures, which may compromise security on ** [ 0.116017] ** your system. ** [ 0.117014] ** ** [ 0.118012] ** If you see this message and you are not debugging the ** [ 0.119017] ** kernel, report this immediately to your vendor! ** [ 0.120013] ** ** [ 0.121015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.122012] ************************************************************* [ 0.123783] NET: Registered protocol family 16 [ 0.124805] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.125054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.126066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.127692] cpuidle: using governor menu [ 0.129895] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.134498] PCI: Using configuration type 1 for base access [ 0.137123] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.146173] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.147093] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.148502] cryptd: max_cpu_qlen set to 1000 [ 0.151628] ACPI: Added _OSI(Module Device) [ 0.154013] ACPI: Added _OSI(Processor Device) [ 0.155011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.157016] ACPI: Added _OSI(Processor Aggregator Device) [ 0.163689] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.169925] ACPI: Interpreter enabled [ 0.172070] ACPI: PM: (supports S0 S3 S4 S5) [ 0.174012] ACPI: Using IOAPIC for interrupt routing [ 0.176164] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.180438] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.192565] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.194043] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.198022] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.201084] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.207465] acpiphp: Slot [2] registered [ 0.210155] acpiphp: Slot [5] registered [ 0.211101] acpiphp: Slot [6] registered [ 0.213121] acpiphp: Slot [3] registered [ 0.215088] acpiphp: Slot [4] registered [ 0.217109] acpiphp: Slot [7] registered [ 0.218077] acpiphp: Slot [8] registered [ 0.220093] acpiphp: Slot [9] registered [ 0.221251] acpiphp: Slot [10] registered [ 0.223100] acpiphp: Slot [11] registered [ 0.225114] acpiphp: Slot [12] registered [ 0.227109] acpiphp: Slot [13] registered [ 0.229114] acpiphp: Slot [14] registered [ 0.231108] acpiphp: Slot [15] registered [ 0.233131] acpiphp: Slot [16] registered [ 0.235194] acpiphp: Slot [17] registered [ 0.237087] acpiphp: Slot [18] registered [ 0.239103] acpiphp: Slot [19] registered [ 0.240156] acpiphp: Slot [20] registered [ 0.242096] acpiphp: Slot [21] registered [ 0.245106] acpiphp: Slot [22] registered [ 0.247105] acpiphp: Slot [23] registered [ 0.248087] acpiphp: Slot [24] registered [ 0.250092] acpiphp: Slot [25] registered [ 0.252206] acpiphp: Slot [26] registered [ 0.254146] acpiphp: Slot [27] registered [ 0.255185] acpiphp: Slot [28] registered [ 0.257103] acpiphp: Slot [29] registered [ 0.259099] acpiphp: Slot [30] registered [ 0.260140] acpiphp: Slot [31] registered [ 0.262124] PCI host bridge to bus 0000:00 [ 0.264020] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.267025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.270024] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.278028] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.283034] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.287026] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.288000] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.288982] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.291000] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.293000] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.297061] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.302017] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.304012] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.306014] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.308568] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.311715] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.313043] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.316844] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.320919] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.330013] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.336999] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.342121] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.354015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.460023] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.474021] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.482000] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.486000] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.489017] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.503022] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.515455] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.518517] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.521413] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.524396] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.526248] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.533211] iommu: Default domain type: Passthrough [ 0.534000] SCSI subsystem initialized [ 0.534132] ACPI: bus type USB registered [ 0.535000] usbcore: registered new interface driver usbfs [ 0.537104] usbcore: registered new interface driver hub [ 0.539117] usbcore: registered new device driver usb [ 0.541209] pps_core: LinuxPPS API ver. 1 registered [ 0.542012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.546149] PTP clock support registered [ 0.549147] EDAC MC: Ver: 3.0.0 [ 0.550517] PCI: Using ACPI for IRQ routing [ 0.586000] NetLabel: Initializing [ 0.586000] NetLabel: domain hash size = 128 [ 0.586000] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.586000] NetLabel: unlabeled traffic allowed by default [ 0.586000] vgaarb: loaded [ 0.601459] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.604018] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.610456] clocksource: Switched to clocksource kvm-clock [ 0.814376] VFS: Disk quotas dquot_6.6.0 [ 0.816224] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.819167] *** VALIDATE ramfs *** [ 0.820552] *** VALIDATE hugetlbfs *** [ 0.822411] pnp: PnP ACPI init [ 0.825706] pnp: PnP ACPI: found 6 devices [ 0.842043] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.845772] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.848371] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.850950] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.853679] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.856153] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.859035] NET: Registered protocol family 2 [ 0.861425] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.866280] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.869800] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.875046] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.878182] TCP: Hash tables configured (established 65536 bind 65536) [ 0.880972] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.883893] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.886536] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.889436] NET: Registered protocol family 1 [ 0.891980] RPC: Registered named UNIX socket transport module. [ 0.893790] RPC: Registered udp transport module. [ 0.895218] RPC: Registered tcp transport module. [ 0.897066] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.899243] NET: Registered protocol family 44 [ 0.901456] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.903515] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.905569] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.907805] PCI: CLS 0 bytes, default 64 [ 0.909256] Unpacking initramfs... [ 2.959996] debug: unmapping init [mem 0xffff968a3cc64000-0xffff968a3ffcffff] [ 2.966628] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.969643] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.972932] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 3.953941] Initialise system trusted keyrings [ 3.957778] Key type blacklist registered [ 3.960639] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 4.014271] zbud: loaded [ 4.150484] *** VALIDATE nfs *** [ 4.151899] *** VALIDATE nfs4 *** [ 4.201920] pstore: using deflate compression [ 4.211948] Platform Keyring initialized [ 4.483155] NET: Registered protocol family 38 [ 4.485016] Key type asymmetric registered [ 4.487357] Asymmetric key parser 'x509' registered [ 4.489399] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 4.492938] io scheduler mq-deadline registered [ 4.494855] io scheduler kyber registered [ 4.497995] io scheduler bfq registered [ 4.501560] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 4.506293] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 4.509423] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 4.512329] ACPI: Power Button [PWRF] [ 4.519562] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 4.530466] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 4.554197] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 4.580496] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 4.616183] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 4.621934] Non-volatile memory driver v1.3 [ 4.623820] Linux agpgart interface v0.103 [ 4.669589] virtio_blk virtio1: [vda] 139504 512-byte logical blocks (71.4 MB/68.1 MiB) [ 4.674178] vda: detected capacity change from 0 to 71426048 [ 4.722348] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 4.726518] vdb: detected capacity change from 0 to 1073741824 [ 4.736167] libphy: Fixed MDIO Bus: probed [ 4.760735] usbcore: registered new interface driver usbserial_generic [ 4.765765] usbserial: USB Serial support registered for generic [ 4.769568] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 4.776126] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 4.779378] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 4.783616] mousedev: PS/2 mouse device common for all mice [ 4.788150] rtc_cmos 00:05: RTC can wake from S4 [ 4.793869] rtc_cmos 00:05: registered as rtc0 [ 4.795736] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 4.799310] intel_pstate: CPU model not supported [ 4.803757] hid: raw HID events driver (C) Jiri Kosina [ 4.807245] usbcore: registered new interface driver usbhid [ 4.808700] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 4.810191] usbhid: USB HID core driver [ 4.810391] drop_monitor: Initializing network drop monitor service [ 4.811309] Initializing XFRM netlink socket [ 4.811836] NET: Registered protocol family 10 [ 4.813203] Segment Routing with IPv6 [ 4.813240] NET: Registered protocol family 17 [ 4.814935] mpls_gso: MPLS GSO support [ 4.836279] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 4.844318] RAS: Correctable Errors collector initialized. [ 4.846661] AVX version of gcm_enc/dec engaged. [ 4.848031] AES CTR mode by8 optimization enabled [ 4.862914] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 4.967637] sched_clock: Marking stable (4967453950, 0)->(6743910601, -1776456651) [ 4.975479] registered taskstats version 1 [ 4.978673] Loading compiled-in X.509 certificates [ 4.982104] zswap: loaded using pool lzo/zbud [ 5.027353] Key type big_key registered [ 5.047995] Key type encrypted registered [ 5.050913] ima: No TPM chip found, activating TPM-bypass! [ 5.053972] ima: Allocated hash algorithm: sha1 [ 5.056633] ima: No architecture policies found [ 5.059903] evm: Initialising EVM extended attributes: [ 5.062817] evm: security.selinux [ 5.064866] evm: security.ima [ 5.066817] evm: security.capability [ 5.069125] evm: HMAC attrs: 0x1 [ 5.072700] rtc_cmos 00:05: setting system clock to 2026-06-26 14:41:55 UTC (1782484915) [ 5.082859] debug: unmapping init [mem 0xffffffffa1603000-0xffffffffa17fffff] [ 5.087907] debug: unmapping init [mem 0xffffffffa0382000-0xffffffffa0658fff] [ 5.098127] Write protecting the kernel read-only data: 28672k [ 5.102904] debug: unmapping init [mem 0xffffffff9ea03000-0xffffffff9ebfffff] [ 5.106444] debug: unmapping init [mem 0xffffffff9f314000-0xffffffff9f3fffff] [ 5.176334] 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) [ 5.196334] systemd[1]: Detected virtualization kvm. [ 5.199835] systemd[1]: Detected architecture x86-64. [ 5.202843] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 5.239575] systemd[1]: No hostname configured. [ 5.241800] systemd[1]: Set hostname to . [ 5.245112] random: systemd: uninitialized urandom read (16 bytes read) [ 5.248137] systemd[1]: Initializing machine ID from random generator. [ 5.754948] random: systemd: uninitialized urandom read (16 bytes read) [ 5.795808] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 5.809127] random: systemd: uninitialized urandom read (16 bytes read) [ 5.812498] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 5.826718] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Sockets. Starting Setup Virtual Console... Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... [ OK ] Reached target Timers. Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ 7.794782] hrtimer: interrupt took 3922785 ns [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 9.189844] device-mapper: uevent: version 1.0.3 [ 9.192221] 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. [ 11.435276] random: fast init done [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 11.623917] virtio_net virtio0 ens2: renamed from eth0 [ 17.177890] scsi host0: ata_piix [ 17.320799] scsi host1: ata_piix [ 17.331206] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 17.337678] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 18.628103] random: crng init done [ 18.630033] random: 7 urandom warning(s) missed due to ratelimiting [ 21.929248] dracut-initqueue[581]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 27.182136] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ 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... [ 31.426102] printk: systemd: 26 output lines suppressed due to ratelimiting [ 32.804194] SELinux: Disabled at runtime. [ 32.939392] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 32.967082] systemd[1]: Detected virtualization kvm. [ 32.972284] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 35.477594] systemd[1]: initrd-switch-root.service: Succeeded. [ 35.487939] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 35.503456] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 35.520825] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 35.528579] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 35.559827] systemd[1]: Starting Journal Service... Starting Journal Service... [ 35.575655] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. Activating swap /dev/disk/by-label/SWAP... Mounting POSIX Message Queue File System... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems.[ 35.943759] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting Huge Pages File System... [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target rpc_pipefs.target. Mounting Kernel Debug File System... Starting Apply Kernel Variables... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 37.940345] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 39.677931] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 39.831076] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 40.620390] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 40.860137] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (9s / no limit) [** ] A start job is running for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…only root support (10s / no limit)[ 45.832621] Key type dns_resolver registered [ *** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (11s / no limit) [ ***] A start job is running for Configur…only root support (11s / no limit)[ 46.959256] NFS: Registering the id_resolver key type [ 46.968961] Key type id_resolver registered [ 46.983040] Key type id_legacy registered [ **] A start job is running for Configur…only root support (12s / no limit) [ *] A start job is running for Configur…only root support (12s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Reached target sshd-keygen.target. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. [ 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 Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg416-client login: [ 99.523096] libcfs: loading out-of-tree module taints kernel. [ 99.569763] Key type ._llcrypt registered [ 99.572407] Key type .llcrypt registered [ 99.859345] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 99.875878] alg: No test for adler32 (adler32-zlib) [ 101.177201] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 101.734057] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 103.432200] Key type lgssc registered [ 104.847199] Lustre: Echo OBD driver; http://www.lustre.org/ [ 218.850740] Lustre: Mounted lustre-client [ 222.739338] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 233.328640] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing check_logdir /tmp/testlogs/ [ 236.728358] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing yml_node [ 239.368585] Lustre: DEBUG MARKER: Client: 2.17.54.4 [ 240.976403] Lustre: DEBUG MARKER: MDS: 2.17.54.4 [ 242.493648] Lustre: DEBUG MARKER: OSS: 2.17.54.4 [ 243.573442] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Jun 26 10:45:53 EDT 2026 [ 244.713309] Lustre: lustre-OST0000-osc-ffff968a90ca8800: disconnect after 24s idle [ 253.954911] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 254.819672] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 256.210087] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 266.506793] Lustre: Unmounted lustre-client [ 344.321345] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 348.180540] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 362.229334] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 399.084949] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 10:48:28 (1782485308) [ 427.179529] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 430.575580] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 454.669181] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid [ 486.471561] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 489.403143] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 515.430908] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid [ 531.656578] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 10:50:41 (1782485441) [ 591.826140] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 594.663681] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 607.434690] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 607.793947] Lustre: Mounted lustre-client [ 620.930129] Lustre: Unmounted lustre-client [ 650.814440] Key type lgssc unregistered [ 650.994421] LNet: 21716:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 650.998985] LNetError: 21716:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 651.017350] LNet: Removed LNI 192.168.204.16@tcp [ 651.454156] Key type .llcrypt unregistered [ 651.457319] Key type ._llcrypt unregistered [ 659.729123] Key type ._llcrypt registered [ 659.731132] Key type .llcrypt registered [ 660.418682] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 10:52:50 (1782485570) [ 661.611659] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 661.626898] alg: No test for adler32 (adler32-zlib) [ 662.562295] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 662.682562] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 664.304184] Key type lgssc registered [ 665.033185] Lustre: Echo OBD driver; http://www.lustre.org/ [ 694.851958] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 698.009069] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 708.051958] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 710.321310] Lustre: Mounted lustre-client [ 720.097852] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 10:53:49 (1782485629) [ 725.821445] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 10:53:55 (1782485635) [ 730.154365] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 10:53:59 (1782485639) [ 737.023568] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 10:54:06 (1782485646) [ 750.222412] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 10:54:19 (1782485659) [ 758.199829] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 10:54:27 (1782485667) [ 766.685569] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 10:54:36 (1782485676) [ 772.384216] Lustre: Unmounted lustre-client [ 772.606986] Lustre: Mounted lustre-client [ 773.647620] Lustre: Unmounted lustre-client [ 806.814589] Key type lgssc unregistered [ 807.173144] LNet: 30048:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 807.194658] LNetError: 30048:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 808.236321] LNet: Removed LNI 192.168.204.16@tcp [ 809.596969] Key type .llcrypt unregistered [ 809.598691] Key type ._llcrypt unregistered [ 849.242357] Key type ._llcrypt registered [ 849.251113] Key type .llcrypt registered [ 849.569165] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 849.620696] alg: No test for adler32 (adler32-zlib) [ 850.761047] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 851.137341] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 852.936587] Key type lgssc registered [ 855.062140] Lustre: Echo OBD driver; http://www.lustre.org/ [ 926.491765] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 931.549572] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 951.134240] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 987.945821] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 10:58:17 (1782485897) [ 1019.949836] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1026.030453] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1044.655830] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1046.395564] Lustre: Mounted lustre-client [ 1171.437377] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 11:01:20 (1782486080) [ 1203.692281] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 11:01:52 (1782486112) [ 1210.498189] Lustre: Unmounted lustre-client [ 1266.021664] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1269.399298] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1281.652770] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1282.139093] Lustre: Mounted lustre-client [ 1285.262603] Lustre: Unmounted lustre-client [ 1316.552489] Key type lgssc unregistered [ 1316.720194] LNet: 41294:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1316.726595] LNetError: 41294:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1316.738544] LNet: Removed LNI 192.168.204.16@tcp [ 1317.123160] Key type .llcrypt unregistered [ 1317.125841] Key type ._llcrypt unregistered [ 1326.841209] Key type ._llcrypt registered [ 1326.843682] Key type .llcrypt registered [ 1327.710922] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 11:03:57 (1782486237) [ 1329.200736] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1329.221734] alg: No test for adler32 (adler32-zlib) [ 1330.190645] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 1330.320348] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 1331.968222] Key type lgssc registered [ 1332.861537] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1365.412791] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1368.662186] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1381.403318] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1382.854000] Lustre: Mounted lustre-client [ 1395.062781] Lustre: Unmounted lustre-client [ 1449.564718] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1453.055812] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1466.851762] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1467.311575] Lustre: Mounted lustre-client [ 1471.243705] Lustre: Unmounted lustre-client [ 1500.861104] Key type lgssc unregistered [ 1501.041176] LNet: 46769:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1501.051774] LNetError: 46769:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1501.068202] LNet: Removed LNI 192.168.204.16@tcp [ 1501.528689] Key type .llcrypt unregistered [ 1501.531583] Key type ._llcrypt unregistered [ 1509.719613] Key type ._llcrypt registered [ 1509.721389] Key type .llcrypt registered [ 1510.544837] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 11:07:00 (1782486420) [ 1511.837688] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1511.871348] alg: No test for adler32 (adler32-zlib) [ 1512.791910] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 1512.928865] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 1514.561347] Key type lgssc registered [ 1515.306621] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1544.624323] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1547.772306] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1559.461912] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1561.872400] Lustre: Mounted lustre-client [ 1626.322260] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 11:08:55 (1782486535) [ 1627.167503] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 1628.128256] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 11:08:57 (1782486537) [ 1628.820342] Lustre: Unmounted lustre-client [ 1657.201323] Key type lgssc unregistered [ 1657.346153] LNet: 52064:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1657.349542] LNetError: 52064:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1657.360335] LNet: Removed LNI 192.168.204.16@tcp [ 1657.740927] Key type .llcrypt unregistered [ 1657.743303] Key type ._llcrypt unregistered [ 1671.836412] Key type ._llcrypt registered [ 1671.839307] Key type .llcrypt registered [ 1672.000037] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1672.018253] alg: No test for adler32 (adler32-zlib) [ 1672.972577] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 1673.130980] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 1674.752154] Key type lgssc registered [ 1675.505467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1699.450867] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 11:10:09 (1782486609) [ 1706.304860] Key type lgssc unregistered [ 1706.462723] LNet: 54456:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1706.467738] LNetError: 54456:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1706.480572] LNet: Removed LNI 192.168.204.16@tcp [ 1706.845414] Key type .llcrypt unregistered [ 1706.847193] Key type ._llcrypt unregistered [ 1713.236174] Key type ._llcrypt registered [ 1713.237781] Key type .llcrypt registered [ 1713.496737] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1713.505868] alg: No test for adler32 (adler32-zlib) [ 1714.459451] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 1714.603955] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 1716.248612] Key type lgssc registered [ 1717.039474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1754.028340] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1760.359071] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1787.483789] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1789.908518] Lustre: Mounted lustre-client [ 1845.894618] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 11:12:35 (1782486755) [ 1847.448762] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 1849.009944] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 11:12:38 (1782486758) [ 1850.861034] Lustre: Unmounted lustre-client [ 1903.575599] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1907.724330] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1969.140758] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 11:14:38 (1782486878) [ 2038.676315] Lustre: Mounted lustre-client [ 2042.971848] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2054.126125] Lustre: lustre-MDT0001-mdc-ffff968a85484800: Connection to lustre-MDT0001 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2064.352912] Lustre: lustre-OST0000-osc-ffff968a85484800: disconnect after 23s idle [ 2067.556488] LustreError: 63074:0:(obd_config.c:2103:class_config_llog_handler()) MGC192.168.204.116@tcp: cfg command failed: rc = -17 [ 2067.571041] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 2067.571041] [ 2067.576511] LustreError: 62350:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 2079.046755] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID and inheritance flag ========================================================== 11:16:28 (1782486988) [ 2125.769199] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2204.006259] Lustre: Unmounted lustre-client [ 2295.797920] Lustre: Mounted lustre-client [ 2298.469348] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2324.702756] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 11:20:34 (1782487234) [ 2325.128842] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2325.144225] LustreError: 71106:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff968a885ff800: inode [0x200005222:0x1:0x0] mdc close failed: rc = -108 [ 2352.009198] Lustre: Unmounted lustre-client [ 2423.771133] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 11:22:13 (1782487333) [ 2424.519720] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 2425.366497] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 11:22:15 (1782487335) [ 2462.988888] Lustre: Mounted lustre-client [ 2465.557229] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2773.440577] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 11:28:03 (1782487683) [ 2774.071661] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2774.075620] Lustre: Skipped 3 previous similar messages [ 2784.385133] Lustre: Unmounted lustre-client [ 2871.784226] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2884.126495] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2921.742370] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2922.495772] Lustre: Mounted lustre-client [ 4297.267426] Lustre: 94297:0:(llog_cat.c:977:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff968a8760e000: catlog [0xa:0x5:0x0] crosses index zero [ 4324.460936] Lustre: Unmounted lustre-client [ 4352.243538] Key type lgssc unregistered [ 4352.534520] LNet: 102406:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4352.547839] LNetError: 102406:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4352.581394] LNet: Removed LNI 192.168.204.16@tcp [ 4353.406272] Key type .llcrypt unregistered [ 4353.410954] Key type ._llcrypt unregistered [ 4363.809428] Key type ._llcrypt registered [ 4363.811673] Key type .llcrypt registered [ 4365.242505] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 11:54:34 (1782489274) [ 4384.250286] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4384.285628] alg: No test for adler32 (adler32-zlib) [ 4385.464944] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 4385.681623] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 4387.360318] Key type lgssc registered [ 4388.836469] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4479.713600] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4486.271407] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4510.978491] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4513.894375] Lustre: Mounted lustre-client [ 4533.168137] Lustre: Unmounted lustre-client [ 4671.208897] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4677.691513] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4703.014973] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4745.440887] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 12:00:54 (1782489654) [ 4747.342047] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 4749.190975] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 12:00:58 (1782489658) [ 4787.448256] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4795.045597] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4822.764918] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4823.480436] Lustre: Mounted lustre-client [ 4833.816722] Lustre: lustre-MDT0000-mdc-ffff968a8b7a1000: Connection to lustre-MDT0000 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4838.889742] Lustre: lustre-MDT0001-mdc-ffff968a8b7a1000: Connection to lustre-MDT0001 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4855.202764] Lustre: 103167:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782489749/real 1782489749] req@00000000528ed768 x1869075496119424/t0(0) o400->MGC192.168.204.116@tcp@192.168.204.116@tcp:26/25 lens 224/224 e 0 to 1 dl 1782489765 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4855.238254] LustreError: MGC192.168.204.116@tcp: Connection to MGS (at 192.168.204.116@tcp) was lost; in progress operations using this service will fail [ 4999.730123] Lustre: Evicted from MGS (at 192.168.204.116@tcp) after server handle changed from 0xda77edd625e8d8e2 to 0xda77edd625e8ef78 [ 4999.750436] Lustre: MGC192.168.204.116@tcp: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [ 5007.862496] Lustre: 112504:0:(mgc_request.c:1901:mgc_process_log()) MGC192.168.204.116@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 5015.039849] LustreError: lustre-MDT0000-mdc-ffff968a8b7a1000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 5015.097654] Lustre: lustre-MDT0000-mdc-ffff968a8b7a1000: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [ 5020.172816] LustreError: lustre-MDT0001-mdc-ffff968a8b7a1000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5020.215956] Lustre: lustre-MDT0001-mdc-ffff968a8b7a1000: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [ 5027.793227] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5029.725222] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5037.648619] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5039.026744] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5057.447414] Lustre: Unmounted lustre-client [ 5187.313458] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5193.675901] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5218.095588] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5261.436311] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 12:09:30 (1782490170) [ 5297.474738] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5304.276832] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5332.575129] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5343.840434] Lustre: Mounted lustre-client [ 5346.375036] LustreError: 119798: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 [ 5356.598476] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 12:11:05 (1782490265) [ 5359.286317] Lustre: Unmounted lustre-client [ 5390.877744] Key type lgssc unregistered [ 5391.456939] LNet: 120806:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5391.482846] LNetError: 120806:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5391.512948] LNet: Removed LNI 192.168.204.16@tcp [ 5392.862110] Key type .llcrypt unregistered [ 5392.863492] Key type ._llcrypt unregistered [ 5410.205452] Key type ._llcrypt registered [ 5410.217107] Key type .llcrypt registered [ 5410.779642] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5410.802271] alg: No test for adler32 (adler32-zlib) [ 5411.994198] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 5412.342581] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 5414.152221] Key type lgssc registered [ 5415.839989] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5526.367444] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5533.956682] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5558.486612] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5711.036914] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5718.187441] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5749.580893] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5803.532390] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 12:18:32 (1782490712) [ 5817.276490] Key type lgssc unregistered [ 5817.585769] LNet: 127988:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5817.592630] LNetError: 127988:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5817.605526] LNet: Removed LNI 192.168.204.16@tcp [ 5818.338524] Key type .llcrypt unregistered [ 5818.345111] Key type ._llcrypt unregistered [ 5831.308790] Key type ._llcrypt registered [ 5831.313551] Key type .llcrypt registered [ 5831.803116] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5831.816540] alg: No test for adler32 (adler32-zlib) [ 5832.883795] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 5833.138645] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 5834.880272] Key type lgssc registered [ 5836.537378] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5898.428535] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5906.189391] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5936.090374] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6082.926534] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6090.173222] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6123.517892] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6185.059979] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 12:24:53 (1782491093) [ 6312.486659] Lustre: Mounted lustre-client [ 6318.558781] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 6333.094555] Lustre: DEBUG MARKER: ADD OST3 [ 6338.041534] Lustre: lustre-OST0000-osc-ffff968a85487800: disconnect after 23s idle [ 6347.812334] Lustre: DEBUG MARKER: STOP OST3 [ 6361.577813] Lustre: lustre-OST0003-osc-ffff968a85487800: Connection to lustre-OST0003 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6372.047430] Lustre: DEBUG MARKER: START OST3 again [ 6382.200988] Lustre: lustre-OST0003-osc-ffff968a85487800: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [ 6413.893686] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6413.919173] LustreError: 138792:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff968a85487800: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 6424.303508] Lustre: Unmounted lustre-client [ 6535.009478] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6540.692593] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6564.730502] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6619.443929] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 12:32:08 (1782491528) [ 6711.114551] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6716.958677] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6737.144472] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6814.494927] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6819.636489] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6837.917684] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6839.743615] LNetError: 128400:0:(lib-move.c:2064:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 6839.948426] Lustre: Mounted lustre-client [ 6845.419360] Lustre: Unmounted lustre-client [ 6878.384221] Key type lgssc unregistered [ 6890.016610] LNet: 1 local NIs in recovery (showing 1): 192.168.204.16@tcp [ 6896.036761] LNet: 147705:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6896.047857] LNetError: 147705:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6968.810857] LNet: Removed LNI 192.168.204.16@tcp [ 6969.416220] Key type .llcrypt unregistered [ 6969.418386] Key type ._llcrypt unregistered [ 6982.386953] Key type ._llcrypt registered [ 6982.389980] Key type .llcrypt registered [ 6983.486769] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 12:38:12 (1782491892) [ 6998.299804] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6998.334435] alg: No test for adler32 (adler32-zlib) [ 6999.416851] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 6999.614872] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 7001.280222] Key type lgssc registered [ 7002.367395] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7078.491367] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7083.735541] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7102.534442] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7199.785392] Lustre: Mounted lustre-client [ 7204.252119] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 7210.442125] Lustre: Unmounted lustre-client [ 7210.507639] LNetError: 148883:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::54df:dbff:fe2a:97d1/1023: rc = -22 [ 7210.516536] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 7210.698447] Lustre: Mounted lustre-client [ 7211.214203] Lustre: Unmounted lustre-client [ 7211.216188] Lustre: Skipped 1 previous similar message [ 7211.291739] LNetError: 148885:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::54df:dbff:fe2a:97d1/1023: rc = -22 [ 7211.305467] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 7211.972438] Lustre: Mounted lustre-client [ 7211.973972] Lustre: Skipped 2 previous similar messages [ 7212.484774] Lustre: Unmounted lustre-client [ 7212.487755] Lustre: Skipped 2 previous similar messages [ 7213.807858] LNetError: 148885:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::54df:dbff:fe2a:97d1/1023: rc = -22 [ 7213.817337] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 7213.827300] Lustre: 154790:0:(obd_mount.c:166: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 [ 7214.011545] Lustre: Mounted lustre-client [ 7214.013111] Lustre: Skipped 4 previous similar messages [ 7214.553290] Lustre: Unmounted lustre-client [ 7214.561206] Lustre: Skipped 4 previous similar messages [ 7220.096654] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 12:42:09 (1782492129) [ 7273.058553] LNet: 1 local NIs in recovery (showing 1): 192.168.204.16@tcp [ 7320.179435] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7324.302731] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7342.491827] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7389.565530] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7392.619963] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7406.126319] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7411.552836] LustreError: 160359:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 7458.400221] LNet: 1 local NIs in recovery (showing 1): 192.168.204.16@tcp [ 7538.272281] LNet: 1 local NIs in recovery (showing 1): 192.168.204.16@tcp [ 7548.896539] 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 [ 7548.909602] Lustre: Unmounted lustre-client [ 7548.913411] LustreError: 160359:0:(super25.c:184:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 7589.370517] Key type lgssc unregistered [ 7597.856288] LNet: 1 local NIs in recovery (showing 1): 192.168.204.16@tcp [ 7600.929365] LNet: 160820:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7600.939986] LNetError: 160820:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7669.545827] LNet: Removed LNI 192.168.204.16@tcp [ 7670.235871] Key type .llcrypt unregistered [ 7670.239884] Key type ._llcrypt unregistered [ 7687.414836] Key type ._llcrypt registered [ 7687.420270] Key type .llcrypt registered [ 7688.949928] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 12:49:57 (1782492597) [ 7706.468397] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7706.530183] alg: No test for adler32 (adler32-zlib) [ 7707.621479] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 7707.861476] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 7709.584209] Key type lgssc registered [ 7710.990309] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7849.583667] Lustre: Mounted lustre-client [ 7854.882232] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 7871.002291] Lustre: Unmounted lustre-client [ 8050.720337] Lustre: Mounted lustre-client [ 8055.412527] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8060.492129] Lustre: Unmounted lustre-client [ 8124.121573] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 12:57:13 (1782493033) [ 8220.641731] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8226.445282] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8250.529861] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8375.125163] Lustre: Mounted lustre-client [ 8381.009297] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8395.367500] Lustre: Unmounted lustre-client [ 8522.978308] Lustre: Mounted lustre-client [ 8528.762705] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8548.834115] Lustre: lustre-OST0001-osc-ffff968a84daf800: disconnect after 24s idle [ 8549.608125] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 13:04:18 (1782493458) [ 8551.938321] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8562.270994] Lustre: Unmounted lustre-client [ 8735.376201] Lustre: Mounted lustre-client [ 8741.636947] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8750.647318] Lustre: Unmounted lustre-client [ 8751.293282] Lustre: Mounted lustre-client [ 8760.884947] Lustre: Unmounted lustre-client [ 8763.194890] Lustre: DEBUG MARKER: == conf-sanity test 157a: test allow_register for MDT registration and MGS restart ========================================================== 13:07:51 (1782493671) [ 8829.285084] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8836.656993] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8860.436332] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8861.155842] Lustre: Mounted lustre-client [ 8958.443518] LustreError: lustre-OST0001-osc-ffff968a85484800: operation ost_connect to node 192.168.204.116@tcp failed: rc = -19 [ 8958.453833] Lustre: lustre-MDT0000-mdc-ffff968a85484800: Connection to lustre-MDT0000 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8973.807857] LustreError: MGC192.168.204.116@tcp: Connection to MGS (at 192.168.204.116@tcp) was lost; in progress operations using this service will fail [ 8973.832914] LustreError: lustre-MDT0000-mdc-ffff968a85484800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8973.845763] Lustre: Evicted from MGS (at 192.168.204.116@tcp) after server handle changed from 0x27f1a55b623bf8e7 to 0x27f1a55b623bfc44 [ 8973.861607] Lustre: MGC192.168.204.116@tcp: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [ 8973.867204] Lustre: Skipped 1 previous similar message [ 9028.262735] Lustre: Unmounted lustre-client [ 9073.877542] Key type lgssc unregistered [ 9074.155374] LNet: 188299:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9074.162572] LNetError: 188299:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9074.180685] LNet: Removed LNI 192.168.204.16@tcp [ 9075.051298] Key type .llcrypt unregistered [ 9075.055064] Key type ._llcrypt unregistered [ 9085.898329] Key type ._llcrypt registered [ 9085.901475] Key type .llcrypt registered [ 9087.495673] Lustre: DEBUG MARKER: == conf-sanity test 157b: verify allow_register (block new OSTs, allow existing) ========================================================== 13:13:16 (1782493996) [ 9090.048085] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9090.140307] alg: No test for adler32 (adler32-zlib) [ 9091.344188] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 9091.585042] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 9093.288695] Key type lgssc registered [ 9094.657365] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9147.805032] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9155.262652] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9178.337488] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9181.242713] Lustre: Mounted lustre-client [ 9278.444471] LustreError: lustre-OST0001-osc-ffff968aa6501000: operation ost_connect to node 192.168.204.116@tcp failed: rc = -19 [ 9413.833170] Lustre: Unmounted lustre-client [ 9461.070152] Key type lgssc unregistered [ 9461.379298] LNet: 194302:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9461.394818] LNetError: 194302:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9461.419832] LNet: Removed LNI 192.168.204.16@tcp [ 9462.355223] Key type .llcrypt unregistered [ 9462.357152] Key type ._llcrypt unregistered [ 9475.313746] Key type ._llcrypt registered [ 9475.315295] Key type .llcrypt registered [ 9477.047907] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 13:19:45 (1782494385) [ 9512.750415] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9512.797520] alg: No test for adler32 (adler32-zlib) [ 9514.001928] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 9514.317745] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 9516.088319] Key type lgssc registered [ 9518.114780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9625.629874] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9632.701022] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9658.500954] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9704.973826] Key type lgssc unregistered [ 9705.338481] LNet: 199261:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9705.357373] LNetError: 199261:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9705.372593] LNet: Removed LNI 192.168.204.16@tcp [ 9706.395738] Key type .llcrypt unregistered [ 9706.404341] Key type ._llcrypt unregistered [ 9817.499877] Key type ._llcrypt registered [ 9817.502460] Key type .llcrypt registered [ 9818.345174] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9818.377664] alg: No test for adler32 (adler32-zlib) [ 9819.738827] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [ 9820.001188] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [ 9821.745317] Key type lgssc registered [ 9823.530903] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9881.185625] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 13:26:29 (1782494789) [ 9923.859367] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9931.834918] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9957.567440] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9959.533573] Lustre: Mounted lustre-client [ 9961.883664] Lustre: Unmounted lustre-client [ 9962.246945] Lustre: Mounted lustre-client [ 9962.491370] Lustre: Unmounted lustre-client [ 9971.484318] Lustre: Unmounted lustre-client [10003.575422] Key type lgssc unregistered [10003.810668] LNet: 204213:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10003.816164] LNetError: 204213:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10004.855206] LNet: Removed LNI 192.168.204.16@tcp [10005.736358] Key type .llcrypt unregistered [10005.740049] Key type ._llcrypt unregistered [10016.280426] Key type ._llcrypt registered [10016.282101] Key type .llcrypt registered [10017.698444] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 13:28:46 (1782494926) [10021.080757] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10021.100495] alg: No test for adler32 (adler32-zlib) [10022.268456] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10022.556893] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10024.304391] Key type lgssc registered [10025.972518] Lustre: Echo OBD driver; http://www.lustre.org/ [10082.758580] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10088.274494] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10109.990544] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10112.905729] Lustre: Mounted lustre-client [10123.721210] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10125.757785] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10133.503262] Lustre: lustre-MDT0000-mdc-ffff968a8b76e800: Connection to lustre-MDT0000 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [10143.731260] Lustre: lustre-MDT0001-mdc-ffff968a8b76e800: Connection to lustre-MDT0001 (at 192.168.204.116@tcp) was lost; in progress operations using this service will wait for recovery to complete [10154.976161] Lustre: 204890:0:(client.c:2480:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782495049/real 1782495049] req@00000000a51450ee x1869081405822848/t0(0) o400->MGC192.168.204.116@tcp@192.168.204.116@tcp:26/25 lens 224/224 e 0 to 1 dl 1782495065 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10155.016555] LustreError: MGC192.168.204.116@tcp: Connection to MGS (at 192.168.204.116@tcp) was lost; in progress operations using this service will fail [10201.074738] Lustre: Evicted from MGS (at 192.168.204.116@tcp) after server handle changed from 0x5f711ece639e91b2 to 0x5f711ece639e9356 [10201.099794] Lustre: MGC192.168.204.116@tcp: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [10236.828983] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10236.905540] LustreError: lustre-MDT0000-mdc-ffff968a8b76e800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10236.928947] Lustre: lustre-MDT0000-mdc-ffff968a8b76e800: Connection restored to 192.168.204.116@tcp (at 192.168.204.116@tcp) [10238.811894] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [10244.502135] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10245.942407] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10248.849861] Lustre: Unmounted lustre-client [10281.147992] Key type lgssc unregistered [10281.510036] LNet: 209730:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10281.519035] LNetError: 209730:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10281.545378] LNet: Removed LNI 192.168.204.16@tcp [10282.296453] Key type .llcrypt unregistered [10282.300549] Key type ._llcrypt unregistered [10308.897189] Key type ._llcrypt registered [10308.926756] Key type .llcrypt registered [10309.251907] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10309.264502] alg: No test for adler32 (adler32-zlib) [10310.426593] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10310.706457] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10312.448300] Key type lgssc registered [10314.066613] Lustre: Echo OBD driver; http://www.lustre.org/ [10397.969677] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10403.232270] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10427.971990] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10469.613818] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 13:36:18 (1782495378) [10573.902864] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10579.911918] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10605.641805] Lustre: DEBUG MARKER: oleg416-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10608.352950] Lustre: Mounted lustre-client [10613.500076] Lustre: Mounted lustre-client [10615.004334] Lustre: Mounted lustre-client [10615.010296] Lustre: Skipped 1 previous similar message [10619.827525] Lustre: Unmounted lustre-client [10622.238102] Lustre: Unmounted lustre-client [10624.568947] Lustre: Unmounted lustre-client [10626.611216] Lustre: Unmounted lustre-client [10638.987380] Lustre: Unmounted lustre-client [10638.995835] Lustre: Skipped 1 previous similar message [10668.118844] Key type lgssc unregistered [10668.441262] LNet: 218854:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10668.445033] LNetError: 218854:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10668.457044] LNet: Removed LNI 192.168.204.16@tcp [10669.275392] Key type .llcrypt unregistered [10669.278116] Key type ._llcrypt unregistered [10679.926547] Key type ._llcrypt registered [10679.929513] Key type .llcrypt registered [10681.674925] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 13:39:50 (1782495590) [10694.827911] Key type .llcrypt unregistered [10694.830976] Key type ._llcrypt unregistered [10695.798249] Key type ._llcrypt registered [10695.800631] Key type .llcrypt registered [10696.248738] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [10696.260819] alg: No test for adler32 (adler32-zlib) [10697.515714] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10697.944476] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10699.672267] Key type lgssc registered [10701.539902] Lustre: Echo OBD driver; http://www.lustre.org/ [10728.438080] Key type lgssc unregistered [10728.698796] LNet: 221011:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10728.709030] LNetError: 221011:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10728.720521] LNet: Removed LNI 192.168.204.16@tcp [10729.360189] Key type .llcrypt unregistered [10729.367827] Key type ._llcrypt unregistered [10729.934848] Key type ._llcrypt registered [10729.940167] Key type .llcrypt registered [10731.498684] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 13:40:40 (1782495640) [10744.664307] Key type .llcrypt unregistered [10744.673166] Key type ._llcrypt unregistered [10745.837461] Key type ._llcrypt registered [10745.867098] Key type .llcrypt registered [10746.203182] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10746.221652] alg: No test for adler32 (adler32-zlib) [10747.282332] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10747.510595] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10749.208186] Key type lgssc registered [10750.472686] Lustre: Echo OBD driver; http://www.lustre.org/ [10766.969989] Key type lgssc unregistered [10767.238625] LNet: 222563:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10767.242543] LNetError: 222563:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10767.274164] LNet: Removed LNI 192.168.204.16@tcp [10768.041407] Key type .llcrypt unregistered [10768.044823] Key type ._llcrypt unregistered [10777.280504] Key type ._llcrypt registered [10777.286307] Key type .llcrypt registered [10777.810640] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10777.905333] alg: No test for adler32 (adler32-zlib) [10779.040694] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10779.325429] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10781.152190] Key type lgssc registered [10783.120493] Lustre: Echo OBD driver; http://www.lustre.org/ [10810.106757] Key type lgssc unregistered [10810.445681] LNet: 224329:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10810.455375] LNetError: 224329:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10810.481744] LNet: Removed LNI 192.168.204.16@tcp [10811.301764] Key type .llcrypt unregistered [10811.305406] Key type ._llcrypt unregistered [10811.848959] Key type ._llcrypt registered [10811.851780] Key type .llcrypt registered [10813.548760] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 13:42:02 (1782495722) [10826.224402] Key type .llcrypt unregistered [10826.232167] Key type ._llcrypt unregistered [10827.226754] Key type ._llcrypt registered [10827.229852] Key type .llcrypt registered [10827.914556] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10827.930878] alg: No test for adler32 (adler32-zlib) [10829.129288] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10829.339940] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10831.032200] Key type lgssc registered [10832.423122] Lustre: Echo OBD driver; http://www.lustre.org/ [10850.586769] Key type lgssc unregistered [10850.893499] LNet: 225878:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10850.898778] LNetError: 225878:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10850.944136] LNet: Removed LNI 192.168.204.16@tcp [10851.700566] Key type .llcrypt unregistered [10851.704610] Key type ._llcrypt unregistered [10859.888678] Key type ._llcrypt registered [10859.894411] Key type .llcrypt registered [10860.520257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10860.539443] alg: No test for adler32 (adler32-zlib) [10861.714820] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10861.931134] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10863.648187] Key type lgssc registered [10865.057940] Lustre: Echo OBD driver; http://www.lustre.org/ [10886.534748] Key type lgssc unregistered [10886.811842] LNet: 227187:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10886.818321] LNetError: 227187:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10886.852383] LNet: Removed LNI 192.168.204.16@tcp [10887.987599] Key type .llcrypt unregistered [10887.990316] Key type ._llcrypt unregistered [10895.559819] Key type ._llcrypt registered [10895.581793] Key type .llcrypt registered [10895.828363] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10895.842773] alg: No test for adler32 (adler32-zlib) [10896.902731] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10897.092273] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10898.762321] Key type lgssc registered [10900.343030] Lustre: Echo OBD driver; http://www.lustre.org/ [10916.346149] Key type lgssc unregistered [10916.566707] LNet: 228492:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10916.574152] LNetError: 228492:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10916.593152] LNet: Removed LNI 192.168.204.16@tcp [10917.253692] Key type .llcrypt unregistered [10917.258822] Key type ._llcrypt unregistered [10924.803580] Key type ._llcrypt registered [10924.809583] Key type .llcrypt registered [10925.327462] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10925.346843] alg: No test for adler32 (adler32-zlib) [10926.463813] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10926.685502] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10928.392680] Key type lgssc registered [10930.052501] Lustre: Echo OBD driver; http://www.lustre.org/ [10958.286359] Key type lgssc unregistered [10958.630957] LNet: 230261:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10958.642631] LNetError: 230261:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10958.658383] LNet: Removed LNI 192.168.204.16@tcp [10959.525747] Key type .llcrypt unregistered [10959.529603] Key type ._llcrypt unregistered [10960.193415] Key type ._llcrypt registered [10960.196460] Key type .llcrypt registered [10962.293755] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 13:44:30 (1782495870) [10976.075403] Key type .llcrypt unregistered [10976.080706] Key type ._llcrypt unregistered [10977.457054] Key type ._llcrypt registered [10977.460828] Key type .llcrypt registered [10977.927611] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10977.944735] alg: No test for adler32 (adler32-zlib) [10979.056519] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [10979.413703] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [10981.184197] Key type lgssc registered [10983.050025] Lustre: Echo OBD driver; http://www.lustre.org/ [11004.883188] Key type lgssc unregistered [11005.333962] LNet: 231813:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11005.346731] LNetError: 231813:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11005.373645] LNet: Removed LNI 192.168.204.16@tcp [11006.303698] Key type .llcrypt unregistered [11006.310372] Key type ._llcrypt unregistered [11013.260472] Key type ._llcrypt registered [11013.264025] Key type .llcrypt registered [11013.548722] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11013.570980] alg: No test for adler32 (adler32-zlib) [11014.782847] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11015.153438] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11016.860433] Key type lgssc registered [11018.254301] Lustre: Echo OBD driver; http://www.lustre.org/ [11036.453322] Key type lgssc unregistered [11036.810071] LNet: 233128:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11036.819786] LNetError: 233128:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11036.839990] LNet: Removed LNI 192.168.204.16@tcp [11037.621254] Key type .llcrypt unregistered [11037.622988] Key type ._llcrypt unregistered [11044.792567] Key type ._llcrypt registered [11044.797911] Key type .llcrypt registered [11044.951196] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11044.975143] alg: No test for adler32 (adler32-zlib) [11046.009752] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11046.281884] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11047.992729] Key type lgssc registered [11049.833914] Lustre: Echo OBD driver; http://www.lustre.org/ [11070.529689] Key type lgssc unregistered [11071.050815] LNet: 234434:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11071.061693] LNetError: 234434:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11071.081395] LNet: Removed LNI 192.168.204.16@tcp [11072.068520] Key type .llcrypt unregistered [11072.070186] Key type ._llcrypt unregistered [11081.209758] Key type ._llcrypt registered [11081.213430] Key type .llcrypt registered [11081.607272] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11081.625444] alg: No test for adler32 (adler32-zlib) [11082.878491] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11083.283611] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11085.080253] Key type lgssc registered [11086.783460] Lustre: Echo OBD driver; http://www.lustre.org/ [11105.912453] Key type lgssc unregistered [11106.247636] LNet: 235744:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11106.255684] LNetError: 235744:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11106.274961] LNet: Removed LNI 192.168.204.16@tcp [11107.079684] Key type .llcrypt unregistered [11107.080901] Key type ._llcrypt unregistered [11115.390654] Key type ._llcrypt registered [11115.394500] Key type .llcrypt registered [11116.102544] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11116.120360] alg: No test for adler32 (adler32-zlib) [11117.408888] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11117.801789] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11119.680260] Key type lgssc registered [11121.656440] Lustre: Echo OBD driver; http://www.lustre.org/ [11142.332473] Key type lgssc unregistered [11142.703121] LNet: 237056:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11142.713116] LNetError: 237056:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11142.730912] LNet: Removed LNI 192.168.204.16@tcp [11143.611500] Key type .llcrypt unregistered [11143.613431] Key type ._llcrypt unregistered [11151.700416] Key type ._llcrypt registered [11151.702068] Key type .llcrypt registered [11151.909217] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11151.934335] alg: No test for adler32 (adler32-zlib) [11153.050087] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11153.413148] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11155.248301] Key type lgssc registered [11157.278891] Lustre: Echo OBD driver; http://www.lustre.org/ [11179.597822] Key type lgssc unregistered [11179.920619] LNet: 238363:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11179.958500] LNetError: 238363:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11179.994724] LNet: Removed LNI 192.168.204.16@tcp [11180.877128] Key type .llcrypt unregistered [11180.879168] Key type ._llcrypt unregistered [11207.328634] Key type ._llcrypt registered [11207.334811] Key type .llcrypt registered [11208.888199] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 13:48:37 (1782496117) [11222.834404] Key type .llcrypt unregistered [11222.838114] Key type ._llcrypt unregistered [11224.068441] Key type ._llcrypt registered [11224.071862] Key type .llcrypt registered [11224.720094] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11224.735234] alg: No test for adler32 (adler32-zlib) [11226.003962] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11226.314669] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11228.040614] Key type lgssc registered [11229.705748] Lustre: Echo OBD driver; http://www.lustre.org/ [11251.619243] Key type lgssc unregistered [11252.237345] LNet: 240683:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11252.254704] LNetError: 240683:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11252.291514] LNet: Removed LNI 192.168.204.16@tcp [11253.115589] Key type .llcrypt unregistered [11253.118113] Key type ._llcrypt unregistered [11265.298154] Key type ._llcrypt registered [11265.307608] Key type .llcrypt registered [11265.536670] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11265.548301] alg: No test for adler32 (adler32-zlib) [11266.658814] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11267.085308] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11268.914101] Key type lgssc registered [11270.512420] Lustre: Echo OBD driver; http://www.lustre.org/ [11290.988372] Key type lgssc unregistered [11291.227421] LNet: 242004:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11291.237874] LNetError: 242004:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11291.251993] LNet: Removed LNI 192.168.204.16@tcp [11291.749235] Key type .llcrypt unregistered [11291.753159] Key type ._llcrypt unregistered [11300.492631] Key type ._llcrypt registered [11300.500244] Key type .llcrypt registered [11300.920208] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11300.929756] alg: No test for adler32 (adler32-zlib) [11302.032605] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11302.263363] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11304.008225] Key type lgssc registered [11305.412573] Lustre: Echo OBD driver; http://www.lustre.org/ [11324.383119] Key type lgssc unregistered [11324.680084] LNet: 243313:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11324.689625] LNetError: 243313:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11324.706957] LNet: Removed LNI 192.168.204.16@tcp [11325.425859] Key type .llcrypt unregistered [11325.427715] Key type ._llcrypt unregistered [11333.516804] Key type ._llcrypt registered [11333.518677] Key type .llcrypt registered [11334.022477] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11334.033591] alg: No test for adler32 (adler32-zlib) [11335.196688] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11335.518256] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11337.224228] Key type lgssc registered [11338.938095] Lustre: Echo OBD driver; http://www.lustre.org/ [11365.585863] Key type lgssc unregistered [11365.904860] LNet: 245107:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11365.914649] LNetError: 245107:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11365.927466] LNet: Removed LNI 192.168.204.16@tcp [11366.566789] Key type .llcrypt unregistered [11366.570625] Key type ._llcrypt unregistered [11367.058180] Key type ._llcrypt registered [11367.064029] Key type .llcrypt registered [11368.473364] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 13:51:17 (1782496277) [11388.652970] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11388.678613] alg: No test for adler32 (adler32-zlib) [11389.890605] Lustre: Lustre: Build Version: 2.17.54_4_g4cd08f3 [11390.199883] LNet: Added LNI 192.168.204.16@tcp [8/256/0/180] [11391.888189] Key type lgssc registered [11393.543091] Lustre: Echo OBD driver; http://www.lustre.org/ [11632.795893] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 13:55:41 (1782496541) [11634.219092] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [11694.318615] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11449 sec ========= 13:56:43 (1782496603) [11696.026184] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:56:44 (1782496604) === [11699.857723] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:56:48 (1782496608) === [11736.292301] Key type lgssc unregistered [11736.624122] LNet: 254166:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11736.633685] LNetError: 254166:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11736.647072] LNet: Removed LNI 192.168.204.16@tcp [11737.380215] Key type .llcrypt unregistered [11737.384047] Key type ._llcrypt unregistered