[ 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 456770140 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001013] APIC: Switch to symmetric I/O mode setup [ 0.003158] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008305] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010012] pid_max: default: 32768 minimum: 301 [ 0.011135] LSM: Security Framework initializing [ 0.012000] Yama: becoming mindful. [ 0.012035] SELinux: Initializing. [ 0.014050] *** VALIDATE selinux *** [ 0.021626] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025757] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027119] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028097] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029101] *** VALIDATE tmpfs *** [ 0.030457] *** VALIDATE proc *** [ 0.031227] *** VALIDATE cgroup *** [ 0.032011] *** VALIDATE cgroup2 *** [ 0.033272] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035043] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037029] Spectre V2 : User space: Vulnerable [ 0.038007] Speculative Store Bypass: Vulnerable [ 0.041219] debug: unmapping init [mem 0xffffffffa5e59000-0xffffffffa5e60fff] [ 0.043157] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044671] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045021] ... version: 2 [ 0.046013] ... bit width: 48 [ 0.047012] ... generic registers: 4 [ 0.048013] ... value mask: 0000ffffffffffff [ 0.049010] ... max period: 00007fffffffffff [ 0.050023] ... fixed-purpose events: 3 [ 0.051012] ... event mask: 000000070000000f [ 0.052287] rcu: Hierarchical SRCU implementation. [ 0.054248] smp: Bringing up secondary CPUs ... [ 0.055544] x86: Booting SMP configuration: [ 0.056031] .... node #0, CPUs: #1 #2 #3 [ 0.059379] smp: Brought up 1 node, 4 CPUs [ 0.061017] smpboot: Max logical packages: 1 [ 0.062015] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.136458] node 0 deferred pages initialised in 72ms [ 0.138165] devtmpfs: initialized [ 0.139228] x86/mm: Memory block size: 128MB [ 0.144134] gcov: version magic: 0x41383552 [ 0.146340] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.149074] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.151287] pinctrl core: initialized pinctrl subsystem [ 0.153133] [ 0.153464] ************************************************************* [ 0.155009] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.157011] ** ** [ 0.159012] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.161012] ** ** [ 0.163011] ** This means that this kernel is built to expose internal ** [ 0.166013] ** IOMMU data structures, which may compromise security on ** [ 0.168011] ** your system. ** [ 0.170014] ** ** [ 0.173014] ** If you see this message and you are not debugging the ** [ 0.175010] ** kernel, report this immediately to your vendor! ** [ 0.177023] ** ** [ 0.180012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.182012] ************************************************************* [ 0.184689] NET: Registered protocol family 16 [ 0.185279] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.187036] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.189040] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.192028] cpuidle: using governor menu [ 0.193676] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.195347] PCI: Using configuration type 1 for base access [ 0.196091] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.202083] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.204035] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.206165] cryptd: max_cpu_qlen set to 1000 [ 0.210205] ACPI: Added _OSI(Module Device) [ 0.212020] ACPI: Added _OSI(Processor Device) [ 0.214013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.215010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.220231] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.225497] ACPI: Interpreter enabled [ 0.227063] ACPI: PM: (supports S0 S3 S4 S5) [ 0.228012] ACPI: Using IOAPIC for interrupt routing [ 0.229098] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.231342] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.240387] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.242031] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.244018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.247060] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.250676] acpiphp: Slot [2] registered [ 0.252112] acpiphp: Slot [5] registered [ 0.253192] acpiphp: Slot [6] registered [ 0.255122] acpiphp: Slot [3] registered [ 0.256113] acpiphp: Slot [4] registered [ 0.258076] acpiphp: Slot [7] registered [ 0.259109] acpiphp: Slot [8] registered [ 0.261134] acpiphp: Slot [9] registered [ 0.263104] acpiphp: Slot [10] registered [ 0.264118] acpiphp: Slot [11] registered [ 0.266150] acpiphp: Slot [12] registered [ 0.267089] acpiphp: Slot [13] registered [ 0.269087] acpiphp: Slot [14] registered [ 0.270105] acpiphp: Slot [15] registered [ 0.272185] acpiphp: Slot [16] registered [ 0.274128] acpiphp: Slot [17] registered [ 0.275138] acpiphp: Slot [18] registered [ 0.277099] acpiphp: Slot [19] registered [ 0.278162] acpiphp: Slot [20] registered [ 0.280094] acpiphp: Slot [21] registered [ 0.281149] acpiphp: Slot [22] registered [ 0.283100] acpiphp: Slot [23] registered [ 0.284101] acpiphp: Slot [24] registered [ 0.286103] acpiphp: Slot [25] registered [ 0.288127] acpiphp: Slot [26] registered [ 0.289101] acpiphp: Slot [27] registered [ 0.291121] acpiphp: Slot [28] registered [ 0.292108] acpiphp: Slot [29] registered [ 0.294141] acpiphp: Slot [30] registered [ 0.296101] acpiphp: Slot [31] registered [ 0.297061] PCI host bridge to bus 0000:00 [ 0.299018] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.302023] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.304021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.307024] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.310023] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.313061] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.315176] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.318026] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.322000] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.330011] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.334056] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.338018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.340016] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.342021] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.345417] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.347894] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.351096] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.354940] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.360013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.370976] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.374013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.379350] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.386016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.390016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.404020] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.412669] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.419019] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.424016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.441022] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.462096] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.464283] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.465294] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.467221] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.469258] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.474199] iommu: Default domain type: Passthrough [ 0.476411] SCSI subsystem initialized [ 0.478074] ACPI: bus type USB registered [ 0.479137] usbcore: registered new interface driver usbfs [ 0.481084] usbcore: registered new interface driver hub [ 0.482066] usbcore: registered new device driver usb [ 0.483145] pps_core: LinuxPPS API ver. 1 registered [ 0.484007] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.486054] PTP clock support registered [ 0.488029] EDAC MC: Ver: 3.0.0 [ 0.489113] PCI: Using ACPI for IRQ routing [ 0.490648] NetLabel: Initializing [ 0.492008] NetLabel: domain hash size = 128 [ 0.493011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.494060] NetLabel: unlabeled traffic allowed by default [ 0.496132] vgaarb: loaded [ 0.498249] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.500010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.505365] clocksource: Switched to clocksource kvm-clock [ 0.611275] VFS: Disk quotas dquot_6.6.0 [ 0.612935] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.615761] *** VALIDATE ramfs *** [ 0.617169] *** VALIDATE hugetlbfs *** [ 0.619421] pnp: PnP ACPI init [ 0.621938] pnp: PnP ACPI: found 6 devices [ 0.653683] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.657464] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.659962] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.662303] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.664838] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.667424] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.670380] NET: Registered protocol family 2 [ 0.672791] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.677838] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.681609] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.687211] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.690574] TCP: Hash tables configured (established 65536 bind 65536) [ 0.693699] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.696891] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.699403] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.701853] NET: Registered protocol family 1 [ 0.704361] RPC: Registered named UNIX socket transport module. [ 0.706520] RPC: Registered udp transport module. [ 0.708174] RPC: Registered tcp transport module. [ 0.710096] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.712296] NET: Registered protocol family 44 [ 0.713925] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.716024] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.718060] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.720339] PCI: CLS 0 bytes, default 64 [ 0.721906] Unpacking initramfs... [ 2.075414] debug: unmapping init [mem 0xffff90af3cc64000-0xffff90af3ffcffff] [ 2.079607] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.081663] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.084663] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.561919] Initialise system trusted keyrings [ 2.564315] Key type blacklist registered [ 2.566716] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.577976] zbud: loaded [ 2.581637] *** VALIDATE nfs *** [ 2.583446] *** VALIDATE nfs4 *** [ 2.585751] pstore: using deflate compression [ 2.591121] Platform Keyring initialized [ 2.710526] NET: Registered protocol family 38 [ 2.713062] Key type asymmetric registered [ 2.715125] Asymmetric key parser 'x509' registered [ 2.717555] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.722105] io scheduler mq-deadline registered [ 2.724484] io scheduler kyber registered [ 2.726538] io scheduler bfq registered [ 2.729885] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.733414] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.735420] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.737676] ACPI: Power Button [PWRF] [ 2.741871] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.747659] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.764389] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.794345] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.824285] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.830384] Non-volatile memory driver v1.3 [ 2.831730] Linux agpgart interface v0.103 [ 2.860678] virtio_blk virtio1: [vda] 134472 512-byte logical blocks (68.8 MB/65.7 MiB) [ 2.862461] vda: detected capacity change from 0 to 68849664 [ 2.875615] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.878074] vdb: detected capacity change from 0 to 1073741824 [ 2.886872] libphy: Fixed MDIO Bus: probed [ 2.902323] usbcore: registered new interface driver usbserial_generic [ 2.904135] usbserial: USB Serial support registered for generic [ 2.905899] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.909182] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.910582] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.912274] mousedev: PS/2 mouse device common for all mice [ 2.917705] rtc_cmos 00:05: RTC can wake from S4 [ 2.919821] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.922652] rtc_cmos 00:05: registered as rtc0 [ 2.924154] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.924696] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.928109] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.929863] intel_pstate: CPU model not supported [ 2.933690] hid: raw HID events driver (C) Jiri Kosina [ 2.934886] usbcore: registered new interface driver usbhid [ 2.936172] usbhid: USB HID core driver [ 2.937724] drop_monitor: Initializing network drop monitor service [ 2.939199] Initializing XFRM netlink socket [ 2.940542] NET: Registered protocol family 10 [ 2.942377] Segment Routing with IPv6 [ 2.943201] NET: Registered protocol family 17 [ 2.944475] mpls_gso: MPLS GSO support [ 2.948540] RAS: Correctable Errors collector initialized. [ 2.949885] AVX version of gcm_enc/dec engaged. [ 2.950904] AES CTR mode by8 optimization enabled [ 3.012948] sched_clock: Marking stable (3012876060, 0)->(3888566532, -875690472) [ 3.017110] registered taskstats version 1 [ 3.019948] Loading compiled-in X.509 certificates [ 3.022943] zswap: loaded using pool lzo/zbud [ 3.043491] Key type big_key registered [ 3.052067] Key type encrypted registered [ 3.053092] ima: No TPM chip found, activating TPM-bypass! [ 3.054432] ima: Allocated hash algorithm: sha1 [ 3.055576] ima: No architecture policies found [ 3.056670] evm: Initialising EVM extended attributes: [ 3.057921] evm: security.selinux [ 3.058904] evm: security.ima [ 3.059617] evm: security.capability [ 3.060460] evm: HMAC attrs: 0x1 [ 3.062073] rtc_cmos 00:05: setting system clock to 2026-09-05 08:46:42 UTC (1788598002) [ 3.066076] debug: unmapping init [mem 0xffffffffa6e03000-0xffffffffa6ffffff] [ 3.068518] debug: unmapping init [mem 0xffffffffa5b82000-0xffffffffa5e58fff] [ 3.077250] Write protecting the kernel read-only data: 28672k [ 3.080970] debug: unmapping init [mem 0xffffffffa4203000-0xffffffffa43fffff] [ 3.082918] debug: unmapping init [mem 0xffffffffa4b14000-0xffffffffa4bfffff] [ 3.110210] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.116543] systemd[1]: Detected virtualization kvm. [ 3.117804] systemd[1]: Detected architecture x86-64. [ 3.119338] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.147677] systemd[1]: No hostname configured. [ 3.149439] systemd[1]: Set hostname to . [ 3.151736] random: systemd: uninitialized urandom read (16 bytes read) [ 3.154206] systemd[1]: Initializing machine ID from random generator. [ 3.195551] random: ln: uninitialized urandom read (6 bytes read) [ 3.265423] random: systemd: uninitialized urandom read (16 bytes read) [ 3.268420] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.274647] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.279427] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Swap. [ OK ] Reached target Paths. [ OK ] Reached target Timers. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Sockets. Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Slices. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.870095] device-mapper: uevent: version 1.0.3 [ 3.872253] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.625310] virtio_net virtio0 ens2: renamed from eth0 [ 4.728558] scsi host0: ata_piix [ 4.747522] scsi host1: ata_piix [ 4.749106] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.751564] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.100703] dracut-initqueue[589]: RTNETLINK answers: File exists [ 9.601681] random: crng init done [ 9.606231] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 11.229279] 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 dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Swap. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ 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 Cleaning Up and Shutting Down Daemons. [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.794340] printk: systemd: 24 output lines suppressed due to ratelimiting [ 15.884885] SELinux: Disabled at runtime. [ 16.100993] 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) [ 16.127391] systemd[1]: Detected virtualization kvm. [ 16.139226] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 18.265715] systemd[1]: initrd-switch-root.service: Succeeded. [ 18.277699] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 18.306688] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 18.330938] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 18.348258] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 18.395850] systemd[1]: Starting Journal Service... Starting Journal Service... [ 18.416395] systemd[1]: Mounting Kernel Debug File System... Mounting Kernel Debug File System... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting POSIX Message Queue File System... [ OK ] Stopped target Switch Root. [ OK ] Created slice User and Session Slice. Starting Apply Kernel Variables... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on udev Control Socket. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd Root File System. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Activating swap /dev/disk/by-label/SWAP... [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target Paths. [ OK ] Listening on initctl Compatibility Named Pipe. [ 18.788623] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting Huge Pages File System... [ OK ] Created slice system-getty.slice. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Reached target Slices. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 20.336673] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 22.006324] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 22.266410] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 22.961939] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 23.166626] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / 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 (9s / no limit)[ 28.266278] 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 (10s / no limit)[ 28.960743] NFS: Registering the id_resolver key type [ 28.964395] Key type id_resolver registered [ 28.967977] Key type id_legacy registered [ ***] A start job is running for Configur…only root support (11s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Rebuild Dynamic Linker Cache... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Login Service... [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... Starting Network Manager... [ OK ] Started dnf makecache --timer. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started Login Service. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg134-client login: [ 51.306016] hrtimer: interrupt took 10125297 ns [ 98.201802] libcfs: loading out-of-tree module taints kernel. [ 98.276752] Key type ._llcrypt registered [ 98.283124] Key type .llcrypt registered [ 98.811766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 98.835624] alg: No test for adler32 (adler32-zlib) [ 100.786945] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 102.413639] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 104.311629] Key type lgssc registered [ 106.789661] Lustre: Echo OBD driver; http://www.lustre.org/ [ 261.613913] Lustre: Mounted lustre-client [ 266.957751] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 283.333530] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing check_logdir /tmp/testlogs/ [ 287.201102] Lustre: lustre-OST0000-osc-ffff90af897b7800: disconnect after 23s idle [ 290.208280] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing yml_node [ 295.345569] Lustre: DEBUG MARKER: Client: 2.17.51.74 [ 297.974054] Lustre: DEBUG MARKER: MDS: 2.17.51.74 [ 300.781347] Lustre: DEBUG MARKER: OSS: 2.17.51.74 [ 302.480520] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sat Sep 5 04:51:40 EDT 2026 [ 321.745802] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 323.383779] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 327.098272] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 337.520696] Lustre: Unmounted lustre-client [ 463.965982] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 468.478428] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 490.001531] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 538.488159] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 04:55:36 (1788598536) [ 582.469770] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 587.374984] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 633.014758] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid [ 693.242567] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 699.295479] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 744.885505] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid [ 768.434231] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 04:59:26 (1788598766) [ 889.828575] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 895.069606] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 917.582500] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 918.207906] Lustre: Mounted lustre-client [ 942.080845] LustreError: 21132:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af85157800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 942.872194] Lustre: Unmounted lustre-client [ 975.514932] Key type lgssc unregistered [ 975.902634] LNet: 21535:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 975.921421] LNetError: 21535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 976.935052] LNet: Removed LNI 192.168.201.34@tcp [ 978.215163] Key type .llcrypt unregistered [ 978.217085] Key type ._llcrypt unregistered [ 996.932896] Key type ._llcrypt registered [ 996.935789] Key type .llcrypt registered [ 999.032799] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 05:03:16 (1788598996) [ 1002.411879] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1002.439255] alg: No test for adler32 (adler32-zlib) [ 1003.570605] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 1003.964709] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 1005.703913] Key type lgssc registered [ 1007.717754] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1059.822692] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1064.480480] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1086.922239] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1088.806059] Lustre: Mounted lustre-client [ 1103.470692] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 05:05:01 (1788599101) [ 1115.140983] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 05:05:13 (1788599113) [ 1125.545709] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 05:05:22 (1788599122) [ 1141.016710] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 05:05:38 (1788599138) [ 1172.122555] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 05:06:09 (1788599169) [ 1191.716964] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 05:06:29 (1788599189) [ 1208.234454] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 05:06:45 (1788599205) [ 1219.290798] LustreError: 29360:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88f2c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1219.365593] Lustre: Unmounted lustre-client [ 1219.807311] Lustre: Mounted lustre-client [ 1221.942308] Lustre: Unmounted lustre-client [ 1258.937471] Key type lgssc unregistered [ 1259.174332] LNet: 29832:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1259.178816] LNetError: 29832:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1259.197450] LNet: Removed LNI 192.168.201.34@tcp [ 1259.856190] Key type .llcrypt unregistered [ 1259.857990] Key type ._llcrypt unregistered [ 1290.016337] Key type ._llcrypt registered [ 1290.023297] Key type .llcrypt registered [ 1290.253515] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1290.263821] alg: No test for adler32 (adler32-zlib) [ 1291.472281] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 1291.663248] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 1293.313700] Key type lgssc registered [ 1294.871047] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1389.297601] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1393.692461] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1418.090622] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1475.664543] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 05:11:12 (1788599472) [ 1508.924748] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1514.021280] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1535.205941] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1536.976530] Lustre: Mounted lustre-client [ 1676.822954] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 05:14:35 (1788599675) [ 1720.699425] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 05:15:18 (1788599718) [ 1731.696181] LustreError: 38712:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af90ca5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1731.802671] Lustre: Unmounted lustre-client [ 1816.873662] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1820.917174] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1841.778507] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1842.600576] Lustre: Mounted lustre-client [ 1848.223094] LustreError: 40519:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88429800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1848.307281] Lustre: Unmounted lustre-client [ 1875.249125] Key type lgssc unregistered [ 1875.598101] LNet: 40921:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1875.605706] LNetError: 40921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1876.654084] LNet: Removed LNI 192.168.201.34@tcp [ 1877.461171] Key type .llcrypt unregistered [ 1877.465377] Key type ._llcrypt unregistered [ 1893.981728] Key type ._llcrypt registered [ 1893.985403] Key type .llcrypt registered [ 1895.272899] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 05:18:13 (1788599893) [ 1897.725831] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1897.780416] alg: No test for adler32 (adler32-zlib) [ 1898.850870] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 1899.043389] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 1900.759177] Key type lgssc registered [ 1902.508472] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1948.489739] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1952.863348] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1973.130058] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1975.138617] Lustre: Mounted lustre-client [ 1987.630481] LustreError: 44106:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af85f9a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1987.736244] Lustre: Unmounted lustre-client [ 2065.254447] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2069.817417] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2090.331405] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2091.257839] Lustre: Mounted lustre-client [ 2096.835270] LustreError: 45893:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af82ab8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2096.938976] Lustre: Unmounted lustre-client [ 2125.917834] Key type lgssc unregistered [ 2126.143617] LNet: 46298:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2126.153475] LNetError: 46298:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2126.172981] LNet: Removed LNI 192.168.201.34@tcp [ 2127.500387] Key type .llcrypt unregistered [ 2127.503442] Key type ._llcrypt unregistered [ 2144.194716] Key type ._llcrypt registered [ 2144.197122] Key type .llcrypt registered [ 2145.469672] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 05:22:23 (1788600143) [ 2148.369869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2148.384873] alg: No test for adler32 (adler32-zlib) [ 2149.517399] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 2149.820044] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 2151.511408] Key type lgssc registered [ 2152.732877] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2211.283415] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2215.031558] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2235.057492] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2237.431528] Lustre: Mounted lustre-client [ 2361.292367] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 05:25:58 (1788600358) [ 2363.203338] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 2364.982880] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 05:26:02 (1788600362) [ 2366.969866] LustreError: 51159:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af870bf000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2367.063737] Lustre: Unmounted lustre-client [ 2403.432902] Key type lgssc unregistered [ 2403.687675] LNet: 51564:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2403.698091] LNetError: 51564:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2403.723670] LNet: Removed LNI 192.168.201.34@tcp [ 2404.351473] Key type .llcrypt unregistered [ 2404.354474] Key type ._llcrypt unregistered [ 2432.285138] Key type ._llcrypt registered [ 2432.288457] Key type .llcrypt registered [ 2432.978964] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2432.994729] alg: No test for adler32 (adler32-zlib) [ 2434.081158] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 2434.282428] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 2436.015255] Key type lgssc registered [ 2437.763495] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2475.943282] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 05:27:53 (1788600473) [ 2489.194210] Key type lgssc unregistered [ 2489.467782] LNet: 53973:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2489.485348] LNetError: 53973:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2489.510657] LNet: Removed LNI 192.168.201.34@tcp [ 2490.478338] Key type .llcrypt unregistered [ 2490.480195] Key type ._llcrypt unregistered [ 2505.769843] Key type ._llcrypt registered [ 2506.022049] Key type .llcrypt registered [ 2506.530326] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2506.560458] alg: No test for adler32 (adler32-zlib) [ 2507.710854] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 2508.090563] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 2509.912852] Key type lgssc registered [ 2511.647250] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2561.119916] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2564.881505] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2584.001392] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2586.014572] Lustre: Mounted lustre-client [ 2636.343726] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 05:30:33 (1788600633) [ 2639.060035] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 2641.816913] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 05:30:38 (1788600638) [ 2644.009626] LustreError: 57586:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af927c5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2644.096273] Lustre: Unmounted lustre-client [ 2712.360177] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2716.869698] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2785.859822] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 05:33:03 (1788600783) [ 2881.513997] Lustre: Mounted lustre-client [ 2888.039260] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2907.103473] Lustre: lustre-OST0000-osc-ffff90af83c98800: disconnect after 23s idle [ 2907.113912] Lustre: lustre-MDT0001-mdc-ffff90af83c98800: Connection to lustre-MDT0001 (at 192.168.201.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2926.405110] LustreError: 62533:0:(obd_config.c:2101:class_config_llog_handler()) MGC192.168.201.134@tcp: cfg command failed: rc = -17 [ 2926.415910] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 2926.415910] [ 2926.423679] LustreError: 61763:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 2943.980334] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID ========================================================== 05:35:41 (1788600941) [ 3011.676774] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3029.986477] Lustre: lustre-OST0000-osc-ffff90af83c98800: disconnect after 22s idle [ 3029.994754] Lustre: Skipped 1 previous similar message [ 3106.738933] LustreError: 66376:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af83c98800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3107.562406] Lustre: Unmounted lustre-client [ 3294.494840] Lustre: Mounted lustre-client [ 3299.308567] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3358.477778] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 05:42:36 (1788601356) [ 3360.923576] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3361.481585] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3361.486243] Lustre: Skipped 1 previous similar message [ 3381.797706] Lustre: Unmounted lustre-client [ 3531.818771] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 05:45:29 (1788601529) [ 3533.595901] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 3535.641192] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 05:45:33 (1788601533) [ 3627.354931] Lustre: Mounted lustre-client [ 3633.928313] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4361.822855] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 05:59:19 (1788602359) [ 4365.128862] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4365.137369] Lustre: Skipped 1 previous similar message [ 4375.628816] Lustre: Unmounted lustre-client [ 4530.121860] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4534.566649] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4559.021068] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4560.245841] Lustre: Mounted lustre-client [ 6553.769128] Lustre: 94136:0:(llog_cat.c:971:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff90afa4a71000: catlog [0xa:0x5:0x0] crosses index zero [ 6582.431636] LustreError: 101932:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90afa4a71000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6582.438674] LustreError: 101932:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 6582.527458] Lustre: Unmounted lustre-client [ 6611.436902] Key type lgssc unregistered [ 6611.722071] LNet: 102336:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6611.732611] LNetError: 102336:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6612.775675] LNet: Removed LNI 192.168.201.34@tcp [ 6613.734269] Key type .llcrypt unregistered [ 6613.737828] Key type ._llcrypt unregistered [ 6626.476522] Key type ._llcrypt registered [ 6626.480346] Key type .llcrypt registered [ 6627.943808] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 06:37:05 (1788604625) [ 6653.342842] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6653.612755] alg: No test for adler32 (adler32-zlib) [ 6655.087491] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 6655.453942] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 6657.079724] Key type lgssc registered [ 6658.534581] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6757.844576] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6762.964938] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6786.586684] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6789.589825] Lustre: Mounted lustre-client [ 6806.942750] LustreError: 106742:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af8569c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6807.027563] Lustre: Unmounted lustre-client [ 6941.692503] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6946.131106] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6970.625382] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7010.365939] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 06:43:27 (1788605007) [ 7012.278877] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 7014.405343] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 06:43:32 (1788605012) [ 7048.611679] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7052.672407] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7075.219544] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7076.042110] Lustre: Mounted lustre-client [ 7081.447215] Lustre: lustre-MDT0000-mdc-ffff90af88e00000: Connection to lustre-MDT0000 (at 192.168.201.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7091.690631] Lustre: lustre-MDT0001-mdc-ffff90af88e00000: Connection to lustre-MDT0001 (at 192.168.201.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7102.943644] Lustre: 103099:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788605086/real 1788605086] req@0000000024152184 x1875487913749632/t0(0) o400->MGC192.168.201.134@tcp@192.168.201.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1788605102 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7102.968879] LustreError: MGC192.168.201.134@tcp: Connection to MGS (at 192.168.201.134@tcp) was lost; in progress operations using this service will fail [ 7248.371549] Lustre: Evicted from MGS (at 192.168.201.134@tcp) after server handle changed from 0xe2667f2b8f189554 to 0xe2667f2b8f18abea [ 7248.387767] Lustre: MGC192.168.201.134@tcp: Connection restored to 192.168.201.134@tcp (at 192.168.201.134@tcp) [ 7257.589787] Lustre: 112236:0:(mgc_request.c:1917:mgc_process_log()) MGC192.168.201.134@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 7258.612247] LustreError: lustre-MDT0000-mdc-ffff90af88e00000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7258.649328] Lustre: lustre-MDT0000-mdc-ffff90af88e00000: Connection restored to 192.168.201.134@tcp (at 192.168.201.134@tcp) [ 7263.720944] LustreError: lustre-MDT0001-mdc-ffff90af88e00000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7263.740616] Lustre: lustre-MDT0001-mdc-ffff90af88e00000: Connection restored to 192.168.201.134@tcp (at 192.168.201.134@tcp) [ 7270.091926] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7271.875413] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7276.189492] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7277.922651] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7291.696957] LustreError: 113703:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88e00000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7291.768962] Lustre: Unmounted lustre-client [ 7421.840625] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7425.696826] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7446.329192] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7490.419377] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 06:51:28 (1788605488) [ 7523.359910] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7527.355636] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7548.544587] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7549.221857] Lustre: Mounted lustre-client [ 7551.720890] LustreError: 119367:0:(lproc_llite.c:615:ll_max_cached_mb_seq_write()) lustre: cannot set max_cached_mb=0 MB more than 3693 MB: rc = -34 [ 7558.566266] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 06:52:36 (1788605556) [ 7560.375157] LustreError: 119971:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af82ab9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7560.462434] Lustre: Unmounted lustre-client [ 7588.429968] Key type lgssc unregistered [ 7588.714050] LNet: 120376:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7588.725469] LNetError: 120376:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7588.749876] LNet: Removed LNI 192.168.201.34@tcp [ 7589.650423] Key type .llcrypt unregistered [ 7589.657106] Key type ._llcrypt unregistered [ 7605.792972] Key type ._llcrypt registered [ 7605.806174] Key type .llcrypt registered [ 7606.233775] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7606.244301] alg: No test for adler32 (adler32-zlib) [ 7607.353603] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 7607.519103] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 7609.207167] Key type lgssc registered [ 7611.223184] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7701.937452] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7706.236567] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7730.378221] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7850.465220] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7855.110621] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7876.596698] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7919.631636] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 06:58:37 (1788605917) [ 7930.702601] Key type lgssc unregistered [ 7931.020089] LNet: 127421:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7931.029994] LNetError: 127421:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7931.044911] LNet: Removed LNI 192.168.201.34@tcp [ 7931.631795] Key type .llcrypt unregistered [ 7931.635495] Key type ._llcrypt unregistered [ 7943.743676] Key type ._llcrypt registered [ 7943.750702] Key type .llcrypt registered [ 7944.236020] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7944.250339] alg: No test for adler32 (adler32-zlib) [ 7945.417193] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 7945.718046] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 7947.496970] Key type lgssc registered [ 7948.806617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7995.406474] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8000.098657] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8025.803058] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8148.233486] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8153.436802] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8175.774879] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8225.741795] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 07:03:43 (1788606223) [ 8308.461177] Lustre: Mounted lustre-client [ 8314.033408] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8327.493220] Lustre: DEBUG MARKER: ADD OST3 [ 8334.310172] Lustre: lustre-OST0000-osc-ffff90af860e8000: disconnect after 23s idle [ 8339.669498] Lustre: DEBUG MARKER: STOP OST3 [ 8352.266344] Lustre: lustre-OST0003-osc-ffff90af860e8000: Connection to lustre-OST0003 (at 192.168.201.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8362.268895] Lustre: DEBUG MARKER: START OST3 again [ 8371.876548] Lustre: lustre-OST0003-osc-ffff90af860e8000: Connection restored to 192.168.201.134@tcp (at 192.168.201.134@tcp) [ 8403.338142] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8403.350540] LustreError: 138075:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff90af860e8000: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 8413.769284] Lustre: Unmounted lustre-client [ 8535.358449] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8539.112319] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8561.423394] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8599.650268] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 07:09:57 (1788606597) [ 8701.159386] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8706.089675] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8731.694634] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8799.238937] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8802.726798] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8821.883339] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8824.485652] LNetError: 127833:0:(lib-move.c:2323:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 8824.789816] Lustre: Mounted lustre-client [ 8830.083916] LustreError: 146391:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af870b9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8830.153650] Lustre: Unmounted lustre-client [ 8859.502913] Key type lgssc unregistered [ 8879.711209] LNet: 1 local NIs in recovery (showing 1): 192.168.201.34@tcp [ 8887.458280] LNet: 146802:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8887.470694] LNetError: 146802:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8955.115548] LNet: Removed LNI 192.168.201.34@tcp [ 8955.720550] Key type .llcrypt unregistered [ 8955.722488] Key type ._llcrypt unregistered [ 8972.692396] Key type ._llcrypt registered [ 8972.694329] Key type .llcrypt registered [ 8973.930427] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 07:16:11 (1788606971) [ 8992.712914] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8992.764340] alg: No test for adler32 (adler32-zlib) [ 8993.898704] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 8994.183509] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 8995.879179] Key type lgssc registered [ 8997.458978] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9078.285457] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9082.214822] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9104.277737] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9229.135399] Lustre: Mounted lustre-client [ 9235.737623] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9247.851074] LustreError: 153594:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af83c9b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9247.964392] Lustre: Unmounted lustre-client [ 9248.041893] LNetError: 147983:0:(lib-socket.c:314:lnet_sock_create()) Error trying to bind to fe80::543e:49ff:fee8:ad9c/1023: rc = -22 [ 9248.049516] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9248.228711] Lustre: Mounted lustre-client [ 9248.920772] LustreError: 153668:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88e01800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9248.947324] LustreError: 153668:0:(lov_obd.c:786:lov_cleanup()) Skipped 3 previous similar messages [ 9249.039867] Lustre: Unmounted lustre-client [ 9249.042619] Lustre: Skipped 1 previous similar message [ 9249.134824] LNetError: 147984:0:(lib-socket.c:314:lnet_sock_create()) Error trying to bind to fe80::543e:49ff:fee8:ad9c/1023: rc = -22 [ 9249.148134] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9249.529626] Lustre: Mounted lustre-client [ 9249.532869] Lustre: Skipped 1 previous similar message [ 9250.283551] LustreError: 153745:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88985800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9250.292161] LustreError: 153745:0:(lov_obd.c:786:lov_cleanup()) Skipped 3 previous similar messages [ 9250.379847] Lustre: Unmounted lustre-client [ 9250.382873] Lustre: Skipped 1 previous similar message [ 9251.606165] LNetError: 147984:0:(lib-socket.c:314:lnet_sock_create()) Error trying to bind to fe80::543e:49ff:fee8:ad9c/1023: rc = -22 [ 9251.630147] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9251.970640] Lustre: Mounted lustre-client [ 9251.981661] Lustre: Skipped 3 previous similar messages [ 9252.758313] LustreError: 153896:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88984800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9252.769542] LustreError: 153896:0:(lov_obd.c:786:lov_cleanup()) Skipped 7 previous similar messages [ 9252.841849] Lustre: Unmounted lustre-client [ 9252.843465] Lustre: Skipped 3 previous similar messages [ 9252.938451] Lustre: 153901: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 [ 9253.470438] Lustre: 153940:0:(obd_mount.c:166:lustre_add_mgc_failnodes()) MGC193.168.0.240@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 9261.015364] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 07:20:59 (1788607259) [ 9307.621726] LNet: 1 local NIs in recovery (showing 1): 192.168.201.34@tcp [ 9378.866416] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9382.742851] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9405.391487] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9485.522935] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9489.709733] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9509.136377] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9514.847680] LustreError: 159363:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 9560.543279] LNet: 1 local NIs in recovery (showing 1): 192.168.201.34@tcp [ 9619.935130] LNet: 1 local NIs in recovery (showing 1): 192.168.201.34@tcp [ 9654.239330] 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 [ 9654.260516] Lustre: Unmounted lustre-client [ 9654.266547] Lustre: Skipped 2 previous similar messages [ 9654.281243] LustreError: 159363:0:(super25.c:184:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 9686.428500] Key type lgssc unregistered [ 9702.113349] LNet: 159822:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9702.122216] LNetError: 159822:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9770.813391] LNet: Removed LNI 192.168.201.34@tcp [ 9771.785169] Key type .llcrypt unregistered [ 9771.788373] Key type ._llcrypt unregistered [ 9791.465928] Key type ._llcrypt registered [ 9791.467983] Key type .llcrypt registered [ 9793.218320] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 07:29:50 (1788607790) [ 9815.552648] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9815.621457] alg: No test for adler32 (adler32-zlib) [ 9816.801331] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [ 9817.144758] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [ 9818.960693] Key type lgssc registered [ 9820.168816] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9960.396103] Lustre: Mounted lustre-client [ 9966.524900] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9986.015841] Lustre: lustre-OST0000-osc-ffff90af88981000: disconnect after 23s idle [ 9988.804397] LustreError: 165315:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88981000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9989.039168] Lustre: Unmounted lustre-client [10165.866641] Lustre: Mounted lustre-client [10172.048983] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10184.083917] LustreError: 168335:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af84862000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10184.093983] LustreError: 168335:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [10184.213273] Lustre: Unmounted lustre-client [10231.629399] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 07:37:09 (1788608229) [10330.971338] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10336.056434] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10360.255472] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10489.237774] Lustre: Mounted lustre-client [10494.931792] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10513.442396] LustreError: 175112:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88a36800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10513.455260] LustreError: 175112:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [10513.527068] Lustre: Unmounted lustre-client [10641.519400] Lustre: Mounted lustre-client [10647.130578] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10666.976213] Lustre: lustre-OST0001-osc-ffff90af84ce1000: disconnect after 23s idle [10666.992754] Lustre: Skipped 1 previous similar message [10673.410222] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 07:44:30 (1788608670) [10676.230634] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10686.623643] Lustre: Unmounted lustre-client [10881.006654] Lustre: Mounted lustre-client [10887.990419] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10901.385663] LustreError: 182397:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88582000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10901.397341] LustreError: 182397:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [10901.488369] Lustre: Unmounted lustre-client [10902.133733] Lustre: Mounted lustre-client [10912.842499] LustreError: 182912:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88a35000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10912.861053] LustreError: 182912:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [10912.946602] Lustre: Unmounted lustre-client [10915.166473] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 07:48:32 (1788608912) [11046.482502] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11051.141345] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11072.025824] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11119.332178] Key type lgssc unregistered [11119.851175] LNet: 187399:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11119.865909] LNetError: 187399:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11119.892428] LNet: Removed LNI 192.168.201.34@tcp [11120.829168] Key type .llcrypt unregistered [11120.831437] Key type ._llcrypt unregistered [11229.072361] Key type ._llcrypt registered [11229.122067] Key type .llcrypt registered [11229.585746] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11229.612798] alg: No test for adler32 (adler32-zlib) [11230.830874] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [11231.160127] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [11232.847264] Key type lgssc registered [11234.149262] Lustre: Echo OBD driver; http://www.lustre.org/ [11297.499570] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 07:54:55 (1788609295) [11335.879607] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11339.871919] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11361.538267] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11364.095913] Lustre: Mounted lustre-client [11366.048652] LustreError: 191348:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af92769800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11366.161320] Lustre: Unmounted lustre-client [11366.534957] Lustre: Mounted lustre-client [11366.655222] LustreError: 191401:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af860da800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11366.738171] Lustre: Unmounted lustre-client [11369.965237] LustreError: 191482:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90afadf9d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11370.064826] Lustre: Unmounted lustre-client [11398.049949] Key type lgssc unregistered [11398.320685] LNet: 191885:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11398.326578] LNetError: 191885:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11398.343435] LNet: Removed LNI 192.168.201.34@tcp [11399.087555] Key type .llcrypt unregistered [11399.089566] Key type ._llcrypt unregistered [11417.635890] Key type ._llcrypt registered [11417.637459] Key type .llcrypt registered [11419.356759] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 07:56:56 (1788609416) [11423.531680] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11423.556732] alg: No test for adler32 (adler32-zlib) [11424.647559] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [11424.989372] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [11426.737113] Key type lgssc registered [11428.541195] Lustre: Echo OBD driver; http://www.lustre.org/ [11484.126867] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11488.473301] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11510.407894] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11512.466468] Lustre: Mounted lustre-client [11521.744723] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11523.760072] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11532.773943] Lustre: lustre-MDT0000-mdc-ffff90af88987000: Connection to lustre-MDT0000 (at 192.168.201.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [11543.040180] Lustre: lustre-MDT0001-mdc-ffff90af88987000: Connection to lustre-MDT0001 (at 192.168.201.134@tcp) was lost; in progress operations using this service will wait for recovery to complete [11554.085346] Lustre: 192986:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788609537/real 1788609537] req@0000000094c2ebf0 x1875492915386112/t0(0) o400->MGC192.168.201.134@tcp@192.168.201.134@tcp:26/25 lens 224/224 e 0 to 1 dl 1788609553 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11554.111993] LustreError: MGC192.168.201.134@tcp: Connection to MGS (at 192.168.201.134@tcp) was lost; in progress operations using this service will fail [11594.216622] Lustre: Evicted from MGS (at 192.168.201.134@tcp) after server handle changed from 0x8cf6733dc284af2f to 0x8cf6733dc284b0c5 [11594.233639] Lustre: MGC192.168.201.134@tcp: Connection restored to 192.168.201.134@tcp (at 192.168.201.134@tcp) [11632.591094] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11634.157030] LustreError: lustre-MDT0000-mdc-ffff90af88987000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [11634.182073] Lustre: lustre-MDT0000-mdc-ffff90af88987000: Connection restored to 192.168.201.134@tcp (at 192.168.201.134@tcp) [11634.502387] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [11638.361819] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11640.056330] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11642.313086] LustreError: 197305:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88987000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11642.418873] Lustre: Unmounted lustre-client [11670.623801] Key type lgssc unregistered [11670.862909] LNet: 197719:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11670.867371] LNetError: 197719:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11670.884401] LNet: Removed LNI 192.168.201.34@tcp [11671.467676] Key type .llcrypt unregistered [11671.472808] Key type ._llcrypt unregistered [11704.533304] Key type ._llcrypt registered [11704.538806] Key type .llcrypt registered [11705.094826] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11705.119709] alg: No test for adler32 (adler32-zlib) [11706.355759] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [11706.650522] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [11708.400681] Key type lgssc registered [11709.798871] Lustre: Echo OBD driver; http://www.lustre.org/ [11801.401897] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11805.219433] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11826.838249] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11885.793276] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 08:04:42 (1788609882) [11990.091822] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11994.904716] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12022.678339] Lustre: DEBUG MARKER: oleg134-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12024.496350] Lustre: Mounted lustre-client [12030.317655] Lustre: Mounted lustre-client [12031.635737] Lustre: Mounted lustre-client [12031.637169] Lustre: Skipped 1 previous similar message [12037.273584] LustreError: 205779:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af90ca1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12037.421811] Lustre: Unmounted lustre-client [12040.622598] LustreError: 205799:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af88e01800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12040.677548] Lustre: Unmounted lustre-client [12044.454517] LustreError: 205838:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af85154800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12044.462947] LustreError: 205838:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [12044.562472] Lustre: Unmounted lustre-client [12044.564198] Lustre: Skipped 1 previous similar message [12047.064160] LustreError: 205857:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af878cb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12047.170748] Lustre: Unmounted lustre-client [12060.442442] LustreError: 206343:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff90af860da000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12060.570603] Lustre: Unmounted lustre-client [12089.832455] Key type lgssc unregistered [12090.206992] LNet: 206747:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12090.217203] LNetError: 206747:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12090.246180] LNet: Removed LNI 192.168.201.34@tcp [12091.082216] Key type .llcrypt unregistered [12091.087604] Key type ._llcrypt unregistered [12105.254554] Key type ._llcrypt registered [12105.256341] Key type .llcrypt registered [12107.091816] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 08:08:24 (1788610104) [12120.718279] Key type .llcrypt unregistered [12120.721937] Key type ._llcrypt unregistered [12121.738945] Key type ._llcrypt registered [12121.746322] Key type .llcrypt registered [12122.265991] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [12122.281488] alg: No test for adler32 (adler32-zlib) [12123.415827] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12123.734787] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12125.488073] Key type lgssc registered [12127.288221] Lustre: Echo OBD driver; http://www.lustre.org/ [12156.033255] Key type lgssc unregistered [12156.372173] LNet: 208906:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12156.385802] LNetError: 208906:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12156.411812] LNet: Removed LNI 192.168.201.34@tcp [12157.365593] Key type .llcrypt unregistered [12157.369112] Key type ._llcrypt unregistered [12157.897312] Key type ._llcrypt registered [12157.898924] Key type .llcrypt registered [12159.580881] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 08:09:17 (1788610157) [12173.348358] Key type .llcrypt unregistered [12173.355217] Key type ._llcrypt unregistered [12174.887540] Key type ._llcrypt registered [12174.892736] Key type .llcrypt registered [12175.229949] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12175.256522] alg: No test for adler32 (adler32-zlib) [12176.373222] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12176.726810] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12178.495258] Key type lgssc registered [12179.856579] Lustre: Echo OBD driver; http://www.lustre.org/ [12199.297278] Key type lgssc unregistered [12199.675887] LNet: 210461:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12199.687372] LNetError: 210461:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12199.717664] LNet: Removed LNI 192.168.201.34@tcp [12200.784909] Key type .llcrypt unregistered [12200.787778] Key type ._llcrypt unregistered [12210.496702] Key type ._llcrypt registered [12210.516839] Key type .llcrypt registered [12211.663061] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12211.694776] alg: No test for adler32 (adler32-zlib) [12212.980433] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12213.451152] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12215.247827] Key type lgssc registered [12217.601375] Lustre: Echo OBD driver; http://www.lustre.org/ [12244.618887] Key type lgssc unregistered [12244.906628] LNet: 212225:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12244.910746] LNetError: 212225:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12244.936247] LNet: Removed LNI 192.168.201.34@tcp [12245.681502] Key type .llcrypt unregistered [12245.687679] Key type ._llcrypt unregistered [12246.060602] Key type ._llcrypt registered [12246.062783] Key type .llcrypt registered [12247.721738] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 08:10:45 (1788610245) [12263.442367] Key type .llcrypt unregistered [12263.445859] Key type ._llcrypt unregistered [12264.971879] Key type ._llcrypt registered [12265.003881] Key type .llcrypt registered [12265.621513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12265.653537] alg: No test for adler32 (adler32-zlib) [12266.901438] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12267.247556] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12269.032294] Key type lgssc registered [12271.031418] Lustre: Echo OBD driver; http://www.lustre.org/ [12291.684923] Key type lgssc unregistered [12292.055318] LNet: 213773:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12292.060860] LNetError: 213773:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12292.071906] LNet: Removed LNI 192.168.201.34@tcp [12292.801961] Key type .llcrypt unregistered [12292.804874] Key type ._llcrypt unregistered [12300.109828] Key type ._llcrypt registered [12300.117666] Key type .llcrypt registered [12300.675300] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12300.690795] alg: No test for adler32 (adler32-zlib) [12301.755362] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12302.080894] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12303.871256] Key type lgssc registered [12305.304426] Lustre: Echo OBD driver; http://www.lustre.org/ [12323.905789] Key type lgssc unregistered [12324.108561] LNet: 215095:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12324.121399] LNetError: 215095:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12324.134835] LNet: Removed LNI 192.168.201.34@tcp [12324.883618] Key type .llcrypt unregistered [12324.887418] Key type ._llcrypt unregistered [12333.653835] Key type ._llcrypt registered [12333.657249] Key type .llcrypt registered [12334.422052] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12334.441785] alg: No test for adler32 (adler32-zlib) [12335.700500] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12335.996553] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12337.696523] Key type lgssc registered [12339.232956] Lustre: Echo OBD driver; http://www.lustre.org/ [12358.847295] Key type lgssc unregistered [12359.188129] LNet: 216399:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12359.198413] LNetError: 216399:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12359.210931] LNet: Removed LNI 192.168.201.34@tcp [12359.965930] Key type .llcrypt unregistered [12359.971601] Key type ._llcrypt unregistered [12367.720252] Key type ._llcrypt registered [12367.722043] Key type .llcrypt registered [12368.447247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12368.466741] alg: No test for adler32 (adler32-zlib) [12369.642380] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12370.017537] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12371.799257] Key type lgssc registered [12373.652639] Lustre: Echo OBD driver; http://www.lustre.org/ [12400.754628] Key type lgssc unregistered [12401.093503] LNet: 218170:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12401.102825] LNetError: 218170:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12401.120185] LNet: Removed LNI 192.168.201.34@tcp [12401.767737] Key type .llcrypt unregistered [12401.769542] Key type ._llcrypt unregistered [12402.310412] Key type ._llcrypt registered [12402.312979] Key type .llcrypt registered [12403.763578] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 08:13:21 (1788610401) [12417.079381] Key type .llcrypt unregistered [12417.082209] Key type ._llcrypt unregistered [12418.777637] Key type ._llcrypt registered [12418.781899] Key type .llcrypt registered [12419.430978] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12419.456992] alg: No test for adler32 (adler32-zlib) [12420.593624] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12420.869247] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12422.671188] Key type lgssc registered [12424.047456] Lustre: Echo OBD driver; http://www.lustre.org/ [12445.620491] Key type lgssc unregistered [12445.988104] LNet: 219722:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12446.003694] LNetError: 219722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12446.019321] LNet: Removed LNI 192.168.201.34@tcp [12447.110577] Key type .llcrypt unregistered [12447.115390] Key type ._llcrypt unregistered [12457.365509] Key type ._llcrypt registered [12457.376661] Key type .llcrypt registered [12458.217834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12458.242159] alg: No test for adler32 (adler32-zlib) [12459.344373] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12459.721114] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12461.487423] Key type lgssc registered [12463.063397] Lustre: Echo OBD driver; http://www.lustre.org/ [12480.209936] Key type lgssc unregistered [12480.405584] LNet: 221038:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12480.418979] LNetError: 221038:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12480.433933] LNet: Removed LNI 192.168.201.34@tcp [12480.969448] Key type .llcrypt unregistered [12480.971540] Key type ._llcrypt unregistered [12488.542473] Key type ._llcrypt registered [12488.545556] Key type .llcrypt registered [12488.859580] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12488.876272] alg: No test for adler32 (adler32-zlib) [12490.032495] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12490.357333] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12492.079539] Key type lgssc registered [12493.511776] Lustre: Echo OBD driver; http://www.lustre.org/ [12514.021948] Key type lgssc unregistered [12514.439356] LNet: 222345:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12514.451687] LNetError: 222345:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12514.464725] LNet: Removed LNI 192.168.201.34@tcp [12515.621852] Key type .llcrypt unregistered [12515.625665] Key type ._llcrypt unregistered [12524.095711] Key type ._llcrypt registered [12524.104184] Key type .llcrypt registered [12524.627699] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12524.648775] alg: No test for adler32 (adler32-zlib) [12525.777517] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12526.029377] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12527.705049] Key type lgssc registered [12529.223456] Lustre: Echo OBD driver; http://www.lustre.org/ [12546.084945] Key type lgssc unregistered [12546.383820] LNet: 223655:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12546.394798] LNetError: 223655:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12546.412769] LNet: Removed LNI 192.168.201.34@tcp [12547.227540] Key type .llcrypt unregistered [12547.229752] Key type ._llcrypt unregistered [12555.438751] Key type ._llcrypt registered [12555.441247] Key type .llcrypt registered [12556.090563] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12556.123159] alg: No test for adler32 (adler32-zlib) [12557.248826] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12557.591825] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12559.383149] Key type lgssc registered [12561.029553] Lustre: Echo OBD driver; http://www.lustre.org/ [12578.771356] Key type lgssc unregistered [12579.044689] LNet: 224965:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12579.053867] LNetError: 224965:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12579.072302] LNet: Removed LNI 192.168.201.34@tcp [12580.095584] Key type .llcrypt unregistered [12580.101454] Key type ._llcrypt unregistered [12587.122220] Key type ._llcrypt registered [12587.135757] Key type .llcrypt registered [12587.732961] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12587.773429] alg: No test for adler32 (adler32-zlib) [12588.992954] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12589.232536] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12590.887264] Key type lgssc registered [12592.333140] Lustre: Echo OBD driver; http://www.lustre.org/ [12609.305763] Key type lgssc unregistered [12609.555502] LNet: 226269:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12609.563799] LNetError: 226269:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12609.587940] LNet: Removed LNI 192.168.201.34@tcp [12610.303886] Key type .llcrypt unregistered [12610.309141] Key type ._llcrypt unregistered [12636.852833] Key type ._llcrypt registered [12636.855370] Key type .llcrypt registered [12638.748054] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 08:17:16 (1788610636) [12650.864552] Key type .llcrypt unregistered [12650.868127] Key type ._llcrypt unregistered [12651.675727] Key type ._llcrypt registered [12651.682244] Key type .llcrypt registered [12652.201560] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12652.212977] alg: No test for adler32 (adler32-zlib) [12653.314925] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12653.602819] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12655.319114] Key type lgssc registered [12656.504696] Lustre: Echo OBD driver; http://www.lustre.org/ [12675.905536] Key type lgssc unregistered [12676.224252] LNet: 228601:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12676.228668] LNetError: 228601:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12676.246921] LNet: Removed LNI 192.168.201.34@tcp [12677.177534] Key type .llcrypt unregistered [12677.183841] Key type ._llcrypt unregistered [12686.167146] Key type ._llcrypt registered [12686.175590] Key type .llcrypt registered [12686.852193] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12686.874556] alg: No test for adler32 (adler32-zlib) [12688.181323] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12688.531583] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12690.231452] Key type lgssc registered [12691.605683] Lustre: Echo OBD driver; http://www.lustre.org/ [12708.126359] Key type lgssc unregistered [12708.430984] LNet: 229922:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12708.436901] LNetError: 229922:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12708.446870] LNet: Removed LNI 192.168.201.34@tcp [12709.080534] Key type .llcrypt unregistered [12709.083580] Key type ._llcrypt unregistered [12716.862640] Key type ._llcrypt registered [12716.865981] Key type .llcrypt registered [12717.515116] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12717.534481] alg: No test for adler32 (adler32-zlib) [12718.668607] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12718.910173] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12720.607380] Key type lgssc registered [12722.274454] Lustre: Echo OBD driver; http://www.lustre.org/ [12741.249190] Key type lgssc unregistered [12741.547132] LNet: 231230:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12741.555713] LNetError: 231230:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12741.568764] LNet: Removed LNI 192.168.201.34@tcp [12742.272206] Key type .llcrypt unregistered [12742.274064] Key type ._llcrypt unregistered [12751.156318] Key type ._llcrypt registered [12751.174900] Key type .llcrypt registered [12751.588432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12751.603908] alg: No test for adler32 (adler32-zlib) [12752.885299] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12753.166442] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12754.855759] Key type lgssc registered [12756.163297] Lustre: Echo OBD driver; http://www.lustre.org/ [12787.124507] Key type lgssc unregistered [12787.516791] LNet: 233024:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12787.530120] LNetError: 233024:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12787.558074] LNet: Removed LNI 192.168.201.34@tcp [12788.491646] Key type .llcrypt unregistered [12788.493775] Key type ._llcrypt unregistered [12789.204547] Key type ._llcrypt registered [12789.206959] Key type .llcrypt registered [12791.510699] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 08:19:48 (1788610788) [12812.894322] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12812.929032] alg: No test for adler32 (adler32-zlib) [12814.119700] Lustre: Lustre: Build Version: 2.17.51_74_g53213db [12814.337489] LNet: Added LNI 192.168.201.34@tcp [8/256/0/180] [12816.031417] Key type lgssc registered [12817.529247] Lustre: Echo OBD driver; http://www.lustre.org/ [13069.852745] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 08:24:27 (1788611067) [13071.600559] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [13135.936438] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 12831 sec ========= 08:25:33 (1788611133) [13138.350736] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 08:25:35 (1788611135) === [13142.363631] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 08:25:39 (1788611139) === [13183.102514] Key type lgssc unregistered [13183.393844] LNet: 242085:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13183.396884] LNetError: 242085:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13183.409971] LNet: Removed LNI 192.168.201.34@tcp [13183.862048] Key type .llcrypt unregistered [13183.864661] Key type ._llcrypt unregistered