[ 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 444835811 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K 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.003392] x2apic enabled [ 0.004009] Switched APIC routing to physical x2apic. [ 0.006010] kvm-guest: setup PV IPIs [ 0.009327] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.010000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.010025] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.011013] pid_max: default: 32768 minimum: 301 [ 0.012144] LSM: Security Framework initializing [ 0.013057] Yama: becoming mindful. [ 0.014049] SELinux: Initializing. [ 0.015069] *** VALIDATE selinux *** [ 0.023505] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028599] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029165] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030109] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031137] *** VALIDATE tmpfs *** [ 0.033415] *** VALIDATE proc *** [ 0.035156] *** VALIDATE cgroup *** [ 0.036010] *** VALIDATE cgroup2 *** [ 0.038270] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.040112] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.041011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.042044] Spectre V2 : User space: Vulnerable [ 0.043013] Speculative Store Bypass: Vulnerable [ 0.046568] debug: unmapping init [mem 0xffffffffa4c59000-0xffffffffa4c60fff] [ 0.048198] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.049701] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.050024] ... version: 2 [ 0.051014] ... bit width: 48 [ 0.052016] ... generic registers: 4 [ 0.053017] ... value mask: 0000ffffffffffff [ 0.054018] ... max period: 00007fffffffffff [ 0.055020] ... fixed-purpose events: 3 [ 0.056017] ... event mask: 000000070000000f [ 0.057336] rcu: Hierarchical SRCU implementation. [ 0.059508] smp: Bringing up secondary CPUs ... [ 0.060649] x86: Booting SMP configuration: [ 0.061026] .... node #0, CPUs: #1 #2 #3 [ 0.065102] smp: Brought up 1 node, 4 CPUs [ 0.067016] smpboot: Max logical packages: 1 [ 0.068014] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.147288] node 0 deferred pages initialised in 78ms [ 0.152204] devtmpfs: initialized [ 0.153256] x86/mm: Memory block size: 128MB [ 0.155840] gcov: version magic: 0x41383552 [ 0.157214] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.160088] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.163261] pinctrl core: initialized pinctrl subsystem [ 0.165138] [ 0.165680] ************************************************************* [ 0.168010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.170012] ** ** [ 0.172013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.175014] ** ** [ 0.178013] ** This means that this kernel is built to expose internal ** [ 0.180013] ** IOMMU data structures, which may compromise security on ** [ 0.182014] ** your system. ** [ 0.184013] ** ** [ 0.187012] ** If you see this message and you are not debugging the ** [ 0.189010] ** kernel, report this immediately to your vendor! ** [ 0.192012] ** ** [ 0.194011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.197014] ************************************************************* [ 0.199601] NET: Registered protocol family 16 [ 0.201402] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.204063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.207066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.211017] cpuidle: using governor menu [ 0.212540] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.215637] PCI: Using configuration type 1 for base access [ 0.217124] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.229184] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.230031] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.233051] cryptd: max_cpu_qlen set to 1000 [ 0.237113] ACPI: Added _OSI(Module Device) [ 0.238014] ACPI: Added _OSI(Processor Device) [ 0.240023] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.241011] ACPI: Added _OSI(Processor Aggregator Device) [ 0.246231] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.251565] ACPI: Interpreter enabled [ 0.254089] ACPI: PM: (supports S0 S3 S4 S5) [ 0.256075] ACPI: Using IOAPIC for interrupt routing [ 0.259109] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.262362] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.271820] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.274036] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.276016] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.279098] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.285811] acpiphp: Slot [2] registered [ 0.288195] acpiphp: Slot [5] registered [ 0.290303] acpiphp: Slot [6] registered [ 0.292258] acpiphp: Slot [3] registered [ 0.295197] acpiphp: Slot [4] registered [ 0.297279] acpiphp: Slot [7] registered [ 0.299199] acpiphp: Slot [8] registered [ 0.301129] acpiphp: Slot [9] registered [ 0.303262] acpiphp: Slot [10] registered [ 0.305163] acpiphp: Slot [11] registered [ 0.307093] acpiphp: Slot [12] registered [ 0.308261] acpiphp: Slot [13] registered [ 0.310209] acpiphp: Slot [14] registered [ 0.313178] acpiphp: Slot [15] registered [ 0.315235] acpiphp: Slot [16] registered [ 0.317176] acpiphp: Slot [17] registered [ 0.318113] acpiphp: Slot [18] registered [ 0.320109] acpiphp: Slot [19] registered [ 0.321109] acpiphp: Slot [20] registered [ 0.323111] acpiphp: Slot [21] registered [ 0.325112] acpiphp: Slot [22] registered [ 0.327110] acpiphp: Slot [23] registered [ 0.328132] acpiphp: Slot [24] registered [ 0.330109] acpiphp: Slot [25] registered [ 0.331106] acpiphp: Slot [26] registered [ 0.333086] acpiphp: Slot [27] registered [ 0.335108] acpiphp: Slot [28] registered [ 0.336091] acpiphp: Slot [29] registered [ 0.337134] acpiphp: Slot [30] registered [ 0.339089] acpiphp: Slot [31] registered [ 0.340072] PCI host bridge to bus 0000:00 [ 0.342021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.345029] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.347026] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.350030] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.352034] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.356049] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.358253] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.362263] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.364613] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.372658] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.376992] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.381032] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.383036] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.385034] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.387664] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.390895] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.393089] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.396754] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.403017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.414912] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.422015] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.428669] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.439025] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.451017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.463017] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.471858] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.479022] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.485022] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.502016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.512827] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.515848] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.519504] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.522522] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.525298] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.533036] iommu: Default domain type: Passthrough [ 0.535451] SCSI subsystem initialized [ 0.537149] ACPI: bus type USB registered [ 0.538131] usbcore: registered new interface driver usbfs [ 0.540089] usbcore: registered new interface driver hub [ 0.542103] usbcore: registered new device driver usb [ 0.544216] pps_core: LinuxPPS API ver. 1 registered [ 0.546014] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.550070] PTP clock support registered [ 0.552095] EDAC MC: Ver: 3.0.0 [ 0.554054] PCI: Using ACPI for IRQ routing [ 0.555658] NetLabel: Initializing [ 0.556000] NetLabel: domain hash size = 128 [ 0.559014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.561084] NetLabel: unlabeled traffic allowed by default [ 0.563150] vgaarb: loaded [ 0.565382] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.567023] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.576132] clocksource: Switched to clocksource kvm-clock [ 0.694614] VFS: Disk quotas dquot_6.6.0 [ 0.696374] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.699636] *** VALIDATE ramfs *** [ 0.700938] *** VALIDATE hugetlbfs *** [ 0.702687] pnp: PnP ACPI init [ 0.705039] pnp: PnP ACPI: found 6 devices [ 0.725385] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.728440] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.730387] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.732328] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.734726] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.737025] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.739655] NET: Registered protocol family 2 [ 0.742161] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.746914] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.751422] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.756282] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.760277] TCP: Hash tables configured (established 65536 bind 65536) [ 0.763534] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.766520] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.769401] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.772459] NET: Registered protocol family 1 [ 0.775496] RPC: Registered named UNIX socket transport module. [ 0.777691] RPC: Registered udp transport module. [ 0.779317] RPC: Registered tcp transport module. [ 0.780668] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.782553] NET: Registered protocol family 44 [ 0.784164] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.785921] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.788107] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.790334] PCI: CLS 0 bytes, default 64 [ 0.792131] Unpacking initramfs... [ 2.186698] debug: unmapping init [mem 0xffff91d1fcc64000-0xffff91d1fffcffff] [ 2.190902] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.193571] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.196680] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.705345] Initialise system trusted keyrings [ 2.707208] Key type blacklist registered [ 2.709320] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.721324] zbud: loaded [ 2.725095] *** VALIDATE nfs *** [ 2.726428] *** VALIDATE nfs4 *** [ 2.728254] pstore: using deflate compression [ 2.731587] Platform Keyring initialized [ 2.841503] NET: Registered protocol family 38 [ 2.843325] Key type asymmetric registered [ 2.845199] Asymmetric key parser 'x509' registered [ 2.847026] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.850137] io scheduler mq-deadline registered [ 2.851880] io scheduler kyber registered [ 2.853401] io scheduler bfq registered [ 2.854908] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.856937] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.859059] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.861280] ACPI: Power Button [PWRF] [ 2.866878] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.873427] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.884033] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.912391] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.942646] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.953487] Non-volatile memory driver v1.3 [ 2.958334] Linux agpgart interface v0.103 [ 2.997343] virtio_blk virtio1: [vda] 145896 512-byte logical blocks (74.7 MB/71.2 MiB) [ 2.999968] vda: detected capacity change from 0 to 74698752 [ 3.014889] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.017378] vdb: detected capacity change from 0 to 1073741824 [ 3.023154] libphy: Fixed MDIO Bus: probed [ 3.028274] usbcore: registered new interface driver usbserial_generic [ 3.030530] usbserial: USB Serial support registered for generic [ 3.032779] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.038329] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.040240] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.042640] mousedev: PS/2 mouse device common for all mice [ 3.046785] rtc_cmos 00:05: RTC can wake from S4 [ 3.049335] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.051395] rtc_cmos 00:05: registered as rtc0 [ 3.055177] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.058303] intel_pstate: CPU model not supported [ 3.060782] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.063690] hid: raw HID events driver (C) Jiri Kosina [ 3.067198] usbcore: registered new interface driver usbhid [ 3.069598] usbhid: USB HID core driver [ 3.071562] drop_monitor: Initializing network drop monitor service [ 3.072034] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.074616] Initializing XFRM netlink socket [ 3.079638] NET: Registered protocol family 10 [ 3.082790] Segment Routing with IPv6 [ 3.084432] NET: Registered protocol family 17 [ 3.086964] mpls_gso: MPLS GSO support [ 3.092244] RAS: Correctable Errors collector initialized. [ 3.094712] AVX version of gcm_enc/dec engaged. [ 3.097616] AES CTR mode by8 optimization enabled [ 3.182563] sched_clock: Marking stable (3182535122, 0)->(4090343261, -907808139) [ 3.186864] registered taskstats version 1 [ 3.194921] Loading compiled-in X.509 certificates [ 3.200052] zswap: loaded using pool lzo/zbud [ 3.245843] Key type big_key registered [ 3.260085] Key type encrypted registered [ 3.262058] ima: No TPM chip found, activating TPM-bypass! [ 3.264962] ima: Allocated hash algorithm: sha1 [ 3.266664] ima: No architecture policies found [ 3.268503] evm: Initialising EVM extended attributes: [ 3.270382] evm: security.selinux [ 3.271671] evm: security.ima [ 3.272809] evm: security.capability [ 3.274552] evm: HMAC attrs: 0x1 [ 3.277494] rtc_cmos 00:05: setting system clock to 2026-09-03 13:27:24 UTC (1788442044) [ 3.284131] debug: unmapping init [mem 0xffffffffa5c03000-0xffffffffa5dfffff] [ 3.287783] debug: unmapping init [mem 0xffffffffa4982000-0xffffffffa4c58fff] [ 3.296108] Write protecting the kernel read-only data: 28672k [ 3.299719] debug: unmapping init [mem 0xffffffffa3003000-0xffffffffa31fffff] [ 3.303061] debug: unmapping init [mem 0xffffffffa3914000-0xffffffffa39fffff] [ 3.351080] 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.360730] systemd[1]: Detected virtualization kvm. [ 3.362589] systemd[1]: Detected architecture x86-64. [ 3.365391] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.394624] systemd[1]: No hostname configured. [ 3.396561] systemd[1]: Set hostname to . [ 3.399162] random: systemd: uninitialized urandom read (16 bytes read) [ 3.401521] systemd[1]: Initializing machine ID from random generator. [ 3.543480] random: systemd: uninitialized urandom read (16 bytes read) [ 3.546517] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.550553] random: systemd: uninitialized urandom read (16 bytes read) [ 3.553436] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.558358] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. Starting Create Volatile Files and Directories... [ OK ] Reached target Sockets. Starting Setup Virtual Console... Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Journal Service... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.253135] device-mapper: uevent: version 1.0.3 [ 4.255601] 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. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.006869] virtio_net virtio0 ens2: renamed from eth0 [ 5.072422] scsi host0: ata_piix [ 5.099710] scsi host1: ata_piix [ 5.118977] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.122157] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.495866] dracut-initqueue[585]: RTNETLINK answers: File exists [ 9.782949] random: crng init done [ 9.785167] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.259776] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.424469] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.717594] SELinux: Disabled at runtime. [ 11.786706] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.796947] systemd[1]: Detected virtualization kvm. [ 11.799254] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.335512] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.339847] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.347156] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.352707] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.356841] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.363700] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.367920] systemd[1]: Reached target rpc_pipefs.target. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on Process Core Dump Socket. Mounting Huge Pages File System... [ OK ] Listening on udev Kernel Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on udev Control Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting udev Coldplug all Devices... [ OK ] Created slice system-getty.slice. [ 12.448898] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Kernel Debug File System... [ OK ] Listening on initctl Compatibility Named Pipe. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting POSIX Message Queue File System... [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started 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. [ 12.856303] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.233743] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.377375] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.445354] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.457058] EDAC sbridge: Ver: 1.1.2 [ 14.596492] Key type dns_resolver registered [ 14.909257] NFS: Registering the id_resolver key type [ 14.911515] Key type id_resolver registered [ 14.913539] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ 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. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg402-client login: [ 42.413223] libcfs: loading out-of-tree module taints kernel. [ 42.458845] Key type ._llcrypt registered [ 42.460771] Key type .llcrypt registered [ 42.845734] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 42.852973] alg: No test for adler32 (adler32-zlib) [ 43.894118] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 44.266189] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 45.911232] Key type lgssc registered [ 46.711173] Lustre: Echo OBD driver; http://www.lustre.org/ [ 186.575358] hrtimer: interrupt took 8786199 ns [ 220.237655] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 225.721610] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 241.915672] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing check_logdir /tmp/testlogs/ [ 245.729508] Lustre: lustre-OST0000-osc-ffff91d249ee9000: disconnect after 23s idle [ 248.387713] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing yml_node [ 254.664041] Lustre: DEBUG MARKER: Client: 2.17.56.51 [ 257.887473] Lustre: DEBUG MARKER: MDS: 2.17.56.51 [ 260.565750] Lustre: DEBUG MARKER: OSS: 2.17.56.51 [ 262.875735] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 3 09:31:42 EDT 2026 [ 281.963294] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 283.525437] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 286.586788] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 296.990133] Lustre: Unmounted lustre-client [ 426.116652] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 432.434775] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 457.910361] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 499.759686] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 09:35:38 (1788442538) [ 548.751811] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 555.356932] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 601.819989] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 653.906217] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 660.755733] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 707.975292] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 734.763137] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 09:39:34 (1788442774) [ 863.099101] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 869.774261] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 897.263115] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 898.142156] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 923.997068] Lustre: Unmounted lustre-client [ 954.751643] Key type lgssc unregistered [ 955.055346] LNet: 21881:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 955.063240] LNetError: 21881:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 955.082466] LNet: Removed LNI 192.168.204.2@tcp [ 955.975348] Key type .llcrypt unregistered [ 955.977744] Key type ._llcrypt unregistered [ 975.090634] Key type ._llcrypt registered [ 975.093676] Key type .llcrypt registered [ 976.894249] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 09:43:36 (1788443016) [ 980.444876] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 980.754287] alg: No test for adler32 (adler32-zlib) [ 982.044822] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 982.377819] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 984.087230] Key type lgssc registered [ 985.437841] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1043.405276] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1050.746736] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1076.559606] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1088.597339] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1104.855842] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 09:45:44 (1788443144) [ 1117.768605] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 09:45:56 (1788443156) [ 1130.490455] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 09:46:09 (1788443169) [ 1146.818303] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 09:46:25 (1788443185) [ 1178.302444] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 09:46:57 (1788443217) [ 1196.709904] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 09:47:15 (1788443235) [ 1214.998258] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 09:47:33 (1788443253) [ 1227.358199] Lustre: Unmounted lustre-client [ 1228.115183] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1231.505953] Lustre: Unmounted lustre-client [ 1262.428193] Key type lgssc unregistered [ 1262.735154] LNet: 30269:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1262.748291] LNetError: 30269:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1262.777917] LNet: Removed LNI 192.168.204.2@tcp [ 1263.487099] Key type .llcrypt unregistered [ 1263.491491] Key type ._llcrypt unregistered [ 1300.213663] Key type ._llcrypt registered [ 1300.218619] Key type .llcrypt registered [ 1300.591030] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1300.618975] alg: No test for adler32 (adler32-zlib) [ 1301.809723] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1302.078144] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 1303.823261] Key type lgssc registered [ 1305.871509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1403.557671] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1411.686662] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1438.420335] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1485.474430] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 09:52:04 (1788443524) [ 1521.471590] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1528.717913] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1551.265979] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1553.207208] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1696.864799] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 09:55:35 (1788443735) [ 1743.947502] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 09:56:23 (1788443783) [ 1755.415927] Lustre: Unmounted lustre-client [ 1848.826227] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1856.871085] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1884.293353] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1885.104322] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1892.582083] Lustre: Unmounted lustre-client [ 1924.413913] Key type lgssc unregistered [ 1924.759198] LNet: 41606:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1924.765129] LNetError: 41606:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1924.780204] LNet: Removed LNI 192.168.204.2@tcp [ 1925.543087] Key type .llcrypt unregistered [ 1925.546449] Key type ._llcrypt unregistered [ 1944.726202] Key type ._llcrypt registered [ 1944.732339] Key type .llcrypt registered [ 1946.115617] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 09:59:45 (1788443985) [ 1949.504460] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1949.585978] alg: No test for adler32 (adler32-zlib) [ 1950.722029] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1951.049140] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 1952.799311] Key type lgssc registered [ 1954.319591] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2010.081928] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2016.205776] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2043.809838] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2046.594152] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2058.559867] Lustre: Unmounted lustre-client [ 2143.517761] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2150.034679] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2174.116519] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2174.889328] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2180.458588] Lustre: Unmounted lustre-client [ 2209.948640] Key type lgssc unregistered [ 2210.303146] LNet: 47169:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2210.311849] LNetError: 47169:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2210.351587] LNet: Removed LNI 192.168.204.2@tcp [ 2211.242410] Key type .llcrypt unregistered [ 2211.245372] Key type ._llcrypt unregistered [ 2231.881163] Key type ._llcrypt registered [ 2231.888693] Key type .llcrypt registered [ 2233.817645] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 10:04:32 (1788444272) [ 2237.327848] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2237.351074] alg: No test for adler32 (adler32-zlib) [ 2238.582419] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2238.963472] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 2240.687318] Key type lgssc registered [ 2241.896371] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2299.088628] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2306.484276] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2337.160435] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2340.618598] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2461.308232] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 10:08:20 (1788444500) [ 2463.773627] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 2466.135714] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 10:08:25 (1788444505) [ 2468.880832] Lustre: Unmounted lustre-client [ 2500.148444] Key type lgssc unregistered [ 2500.489318] LNet: 52519:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2500.496584] LNetError: 52519:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2500.527613] LNet: Removed LNI 192.168.204.2@tcp [ 2501.354912] Key type .llcrypt unregistered [ 2501.358221] Key type ._llcrypt unregistered [ 2533.693896] Key type ._llcrypt registered [ 2533.697744] Key type .llcrypt registered [ 2534.406150] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2534.429808] alg: No test for adler32 (adler32-zlib) [ 2535.506273] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2535.881234] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 2537.583281] Key type lgssc registered [ 2539.300681] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2578.846521] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 10:10:18 (1788444618) [ 2594.774505] Key type lgssc unregistered [ 2595.114292] LNet: 54932:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2595.135470] LNetError: 54932:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2595.155511] LNet: Removed LNI 192.168.204.2@tcp [ 2595.999927] Key type .llcrypt unregistered [ 2596.003585] Key type ._llcrypt unregistered [ 2610.084709] Key type ._llcrypt registered [ 2610.089306] Key type .llcrypt registered [ 2610.677272] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2610.691842] alg: No test for adler32 (adler32-zlib) [ 2611.847632] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2612.267482] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 2614.056516] Key type lgssc registered [ 2615.760574] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2680.430338] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2686.636582] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2709.771738] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2711.968497] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2766.131620] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 10:13:25 (1788444805) [ 2768.001959] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 2769.904658] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 10:13:29 (1788444809) [ 2772.570327] Lustre: Unmounted lustre-client [ 2848.294329] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2854.762226] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2937.643632] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 10:16:16 (1788444976) [ 3034.883569] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3040.925196] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3060.703933] Lustre: lustre-OST0000-osc-ffff91d2489f6000: disconnect after 23s idle [ 3060.716291] Lustre: lustre-MDT0001-mdc-ffff91d2489f6000: Connection to lustre-MDT0001 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3077.412105] LustreError: 63656:0:(obd_config.c:2103:class_config_llog_handler()) MGC192.168.204.102@tcp: cfg command failed: rc = -17 [ 3077.422048] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 3077.422048] [ 3077.438130] LustreError: 62897:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 3094.412577] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID and inheritance flag ========================================================== 10:18:53 (1788445133) [ 3160.885472] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3178.463716] Lustre: lustre-OST0000-osc-ffff91d2489f6000: disconnect after 21s idle [ 3178.469232] Lustre: Skipped 1 previous similar message [ 3259.522728] Lustre: Unmounted lustre-client [ 3447.189507] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3453.145140] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3516.896864] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 10:25:56 (1788445556) [ 3519.778348] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3520.567056] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3520.571723] Lustre: Skipped 1 previous similar message [ 3539.057372] Lustre: Unmounted lustre-client [ 3710.335259] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 10:29:09 (1788445749) [ 3712.464916] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 3714.790254] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 10:29:14 (1788445754) [ 3817.198556] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3823.029403] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4549.158867] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 10:43:08 (1788446588) [ 4551.518775] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4551.523069] Lustre: Skipped 1 previous similar message [ 4561.833137] Lustre: Unmounted lustre-client [ 4696.628302] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4702.174716] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4725.987485] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4726.549481] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6725.427586] Lustre: 95414:0:(llog_cat.c:310:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff91d278859000: catlog [0xa:0x5:0x0] crosses index zero [ 6751.870938] Lustre: Unmounted lustre-client [ 6782.918856] Key type lgssc unregistered [ 6783.193613] LNet: 103630:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6783.199788] LNetError: 103630:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6783.227438] LNet: Removed LNI 192.168.204.2@tcp [ 6784.028658] Key type .llcrypt unregistered [ 6784.030646] Key type ._llcrypt unregistered [ 6793.793915] Key type ._llcrypt registered [ 6793.795786] Key type .llcrypt registered [ 6795.013081] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 11:20:34 (1788448834) [ 6813.769313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6813.791456] alg: No test for adler32 (adler32-zlib) [ 6814.973927] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 6815.307483] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 6816.978630] Key type lgssc registered [ 6818.375155] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6915.452363] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6921.526793] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6945.485749] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6947.400258] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6965.218918] Lustre: Unmounted lustre-client [ 7098.895943] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7105.690320] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7130.045201] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7169.247462] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 11:26:48 (1788449208) [ 7171.191177] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 7172.750843] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 11:26:52 (1788449212) [ 7207.213263] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7212.313587] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7235.368380] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7236.016485] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7246.351172] Lustre: lustre-MDT0000-mdc-ffff91d250f04000: Connection to lustre-MDT0000 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7256.551343] Lustre: lustre-MDT0001-mdc-ffff91d250f04000: Connection to lustre-MDT0001 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7266.783298] Lustre: 104389:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788449292/real 1788449292] req@00000000703447e9 x1875324547706112/t0(0) o400->MGC192.168.204.102@tcp@192.168.204.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1788449308 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7266.818307] LustreError: MGC192.168.204.102@tcp: Connection to MGS (at 192.168.204.102@tcp) was lost; in progress operations using this service will fail [ 7397.880672] LustreError: lustre-MDT0000-mdc-ffff91d250f04000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7397.933080] Lustre: lustre-MDT0000-mdc-ffff91d250f04000: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [ 7402.992292] LustreError: lustre-MDT0001-mdc-ffff91d250f04000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7403.014515] Lustre: lustre-MDT0001-mdc-ffff91d250f04000: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [ 7408.713277] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7410.134614] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7412.204513] Lustre: Evicted from MGS (at 192.168.204.102@tcp) after server handle changed from 0xcdead3609db33066 to 0xcdead3609db348ae [ 7412.222807] Lustre: MGC192.168.204.102@tcp: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [ 7415.166360] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7416.406486] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7434.496750] Lustre: Unmounted lustre-client [ 7559.220477] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7564.191284] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7586.310466] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7633.742146] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 11:34:33 (1788449673) [ 7676.292112] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7682.427094] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7701.383837] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7701.942575] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7704.076568] LustreError: 121127:0:(lproc_llite.c:618:ll_max_cached_mb_seq_write()) lustre: cannot set max_cached_mb=0 MB more than 3693 MB: rc = -34 [ 7710.161702] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 11:35:50 (1788449750) [ 7711.837790] Lustre: Unmounted lustre-client [ 7739.779185] Key type lgssc unregistered [ 7740.091855] LNet: 122138:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7740.112800] LNetError: 122138:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7740.129985] LNet: Removed LNI 192.168.204.2@tcp [ 7740.786400] Key type .llcrypt unregistered [ 7740.788035] Key type ._llcrypt unregistered [ 7756.453477] Key type ._llcrypt registered [ 7756.456279] Key type .llcrypt registered [ 7757.323335] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7757.367109] alg: No test for adler32 (adler32-zlib) [ 7758.572908] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 7759.274434] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 7761.055231] Key type lgssc registered [ 7763.168590] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7849.123340] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7854.760440] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7874.035554] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7983.270515] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7989.621244] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8014.217190] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8063.453353] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 11:41:43 (1788450103) [ 8075.683561] Key type lgssc unregistered [ 8075.982916] LNet: 129360:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8075.992410] LNetError: 129360:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8076.003709] LNet: Removed LNI 192.168.204.2@tcp [ 8076.768840] Key type .llcrypt unregistered [ 8076.771400] Key type ._llcrypt unregistered [ 8090.204917] Key type ._llcrypt registered [ 8090.254183] Key type .llcrypt registered [ 8090.638163] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8090.648880] alg: No test for adler32 (adler32-zlib) [ 8091.714387] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 8091.929624] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 8093.664173] Key type lgssc registered [ 8095.114519] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8152.032858] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8157.575774] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8181.527519] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8312.452921] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8318.142682] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8344.982678] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8396.804574] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 11:47:16 (1788450436) [ 8485.967268] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 8491.260684] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8497.294692] Lustre: DEBUG MARKER: ADD OST3 [ 8509.654183] Lustre: DEBUG MARKER: STOP OST3 [ 8511.466598] Lustre: lustre-OST0000-osc-ffff91d278979800: disconnect after 23s idle [ 8521.716352] Lustre: lustre-OST0003-osc-ffff91d278979800: Connection to lustre-OST0003 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8531.039950] Lustre: DEBUG MARKER: START OST3 again [ 8541.059757] Lustre: lustre-OST0003-osc-ffff91d278979800: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [ 8574.500976] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8574.512637] LustreError: 140165:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff91d278979800: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 8584.962647] Lustre: Unmounted lustre-client [ 8705.986919] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8712.308664] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8735.285962] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8777.591124] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 11:53:37 (1788450817) [ 8869.209561] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8875.637295] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8898.953568] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8976.081831] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8984.015811] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9009.479429] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9011.915624] LNetError: 129772:0:(lib-move.c:2158:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 9017.440045] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 9022.683933] Lustre: Unmounted lustre-client [ 9052.382411] Key type lgssc unregistered [ 9064.736359] LNet: 1 local NIs in recovery (showing 1): 192.168.204.2@tcp [ 9071.200746] LNet: 149146:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9071.213934] LNetError: 149146:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9143.976366] LNet: Removed LNI 192.168.204.2@tcp [ 9144.689203] Key type .llcrypt unregistered [ 9144.700894] Key type ._llcrypt unregistered [ 9161.844311] Key type ._llcrypt registered [ 9161.847131] Key type .llcrypt registered [ 9163.652940] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 12:00:02 (1788451202) [ 9187.511760] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9187.700888] alg: No test for adler32 (adler32-zlib) [ 9188.856470] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 9189.167923] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [ 9190.943288] Key type lgssc registered [ 9192.246638] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9276.951244] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9283.177749] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9312.525379] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9446.103683] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 9451.320719] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9459.673456] Lustre: Unmounted lustre-client [ 9459.804556] LNetError: 150328:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5403:b4ff:fe41:d8f3/1023: rc = -22 [ 9459.818336] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9460.179578] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 9460.342941] Lustre: Unmounted lustre-client [ 9461.040702] LNetError: 150329:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5403:b4ff:fe41:d8f3/1023: rc = -22 [ 9461.050516] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9461.342252] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 9461.345701] Lustre: Skipped 1 previous similar message [ 9461.515630] Lustre: Unmounted lustre-client [ 9461.517583] Lustre: Skipped 1 previous similar message [ 9463.216665] LNetError: 150329:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5403:b4ff:fe41:d8f3/1023: rc = -22 [ 9463.222451] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9463.569755] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 9463.575988] Lustre: Skipped 3 previous similar messages [ 9463.738418] Lustre: Unmounted lustre-client [ 9463.743115] Lustre: Skipped 3 previous similar messages [ 9464.426321] Lustre: 156274:0:(obd_mount.c:175:lustre_add_mgc_failnodes()) MGC6699:7654::1234:1234:d84@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 9464.987209] Lustre: 156302:0:(obd_mount.c:175:lustre_add_mgc_failnodes()) MGC193.168.0.240@tcp: can't add failover NID 5031:db8:85a3:8d3:1319:8a2e:370:7348@tcp, rc = -75 [ 9473.181042] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 12:05:13 (1788451513) [ 9514.981090] LNet: 1 local NIs in recovery (showing 1): 192.168.204.2@tcp [ 9608.482270] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9614.472344] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9643.261461] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9723.517718] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9730.981108] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9754.529528] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9760.096793] LustreError: 161895:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 9806.815336] LNet: 1 local NIs in recovery (showing 1): 192.168.204.2@tcp [ 9867.232561] LNet: 1 local NIs in recovery (showing 1): 192.168.204.2@tcp [ 9895.904162] 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 [ 9895.945266] Lustre: Unmounted lustre-client [ 9895.956251] Lustre: Skipped 3 previous similar messages [ 9895.981382] LustreError: 161895:0:(super25.c:178:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 9927.413361] Key type lgssc unregistered [ 9947.187446] LNet: 162356:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9947.219345] LNetError: 162356:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10015.845681] LNet: Removed LNI 192.168.204.2@tcp [10016.717180] Key type .llcrypt unregistered [10016.718871] Key type ._llcrypt unregistered [10034.664580] Key type ._llcrypt registered [10034.666154] Key type .llcrypt registered [10035.968669] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 12:14:35 (1788452075) [10059.671689] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10059.703536] alg: No test for adler32 (adler32-zlib) [10060.908737] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [10061.162476] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [10062.911384] Key type lgssc registered [10064.426286] Lustre: Echo OBD driver; http://www.lustre.org/ [10212.242210] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10217.437934] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10230.963950] Lustre: Unmounted lustre-client [10397.971407] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10402.956514] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10410.296262] Lustre: Unmounted lustre-client [10469.787615] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 12:21:49 (1788452509) [10569.278975] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10576.903580] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10602.969580] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10736.798954] LustreError: 163552:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [10736.836079] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10742.290760] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10759.460121] Lustre: Unmounted lustre-client [10886.330349] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10891.348533] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10909.784464] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 12:29:09 (1788452949) [10912.180820] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10922.523675] Lustre: Unmounted lustre-client [11121.233410] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11126.874915] Lustre: DEBUG MARKER: Using TIMEOUT=20 [11137.859967] Lustre: Unmounted lustre-client [11138.435085] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11150.489199] Lustre: Unmounted lustre-client [11152.639433] Lustre: DEBUG MARKER: == conf-sanity test 157a: test allow_register for MDT registration and MGS restart ========================================================== 12:33:12 (1788453192) [11224.664608] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11231.227715] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11254.455918] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11265.574198] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11362.792431] LustreError: lustre-OST0001-osc-ffff91d249a6a000: operation ost_connect to node 192.168.204.102@tcp failed: rc = -19 [11367.918268] Lustre: lustre-MDT0000-mdc-ffff91d249a6a000: Connection to lustre-MDT0000 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [11383.284441] LustreError: MGC192.168.204.102@tcp: Connection to MGS (at 192.168.204.102@tcp) was lost; in progress operations using this service will fail [11383.300547] LustreError: lustre-MDT0000-mdc-ffff91d249a6a000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [11383.317620] Lustre: Evicted from MGS (at 192.168.204.102@tcp) after server handle changed from 0x7e21b913ab522106 to 0x7e21b913ab5223d0 [11383.328957] Lustre: lustre-MDT0000-mdc-ffff91d249a6a000: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [11437.963326] Lustre: Unmounted lustre-client [11469.907344] Key type lgssc unregistered [11470.153792] LNet: 189880:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11470.177422] LNetError: 189880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11470.192443] LNet: Removed LNI 192.168.204.2@tcp [11471.055155] Key type .llcrypt unregistered [11471.059361] Key type ._llcrypt unregistered [11484.873728] Key type ._llcrypt registered [11484.891191] Key type .llcrypt registered [11486.538547] Lustre: DEBUG MARKER: == conf-sanity test 157b: verify allow_register (block new OSTs, allow existing) ========================================================== 12:38:45 (1788453525) [11489.689189] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11489.710451] alg: No test for adler32 (adler32-zlib) [11491.149867] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [11491.659199] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [11493.447521] Key type lgssc registered [11494.582191] Lustre: Echo OBD driver; http://www.lustre.org/ [11551.878487] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11559.376474] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11591.946266] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11598.453137] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11695.605892] LustreError: lustre-OST0001-osc-ffff91d242b4a800: operation ost_connect to node 192.168.204.102@tcp failed: rc = -19 [11795.377065] Lustre: Unmounted lustre-client [11832.478235] Key type lgssc unregistered [11832.677209] LNet: 195918:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11832.685630] LNetError: 195918:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11832.701927] LNet: Removed LNI 192.168.204.2@tcp [11833.456168] Key type .llcrypt unregistered [11833.458263] Key type ._llcrypt unregistered [11844.586434] Key type ._llcrypt registered [11844.591159] Key type .llcrypt registered [11846.148885] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 12:44:45 (1788453885) [11880.248734] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11880.301175] alg: No test for adler32 (adler32-zlib) [11881.656725] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [11882.043611] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [11883.767219] Key type lgssc registered [11885.215691] Lustre: Echo OBD driver; http://www.lustre.org/ [11982.017406] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11988.290977] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12017.782333] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12064.514312] Key type lgssc unregistered [12064.785895] LNet: 200908:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12064.800626] LNetError: 200908:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12064.835709] LNet: Removed LNI 192.168.204.2@tcp [12065.762722] Key type .llcrypt unregistered [12065.765286] Key type ._llcrypt unregistered [12172.847782] Key type ._llcrypt registered [12172.856653] Key type .llcrypt registered [12173.348232] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12173.380824] alg: No test for adler32 (adler32-zlib) [12174.557677] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [12174.806945] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [12176.511255] Key type lgssc registered [12178.074974] Lustre: Echo OBD driver; http://www.lustre.org/ [12233.697509] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 12:51:12 (1788454272) [12278.515260] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12284.279927] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12306.812217] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12308.592875] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12310.798248] Lustre: Unmounted lustre-client [12311.061758] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12311.302060] Lustre: Unmounted lustre-client [12320.088239] Lustre: Unmounted lustre-client [12356.861259] Key type lgssc unregistered [12357.097042] LNet: 205890:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12357.108050] LNetError: 205890:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12357.126502] LNet: Removed LNI 192.168.204.2@tcp [12357.695170] Key type .llcrypt unregistered [12357.700176] Key type ._llcrypt unregistered [12369.757588] Key type ._llcrypt registered [12369.761968] Key type .llcrypt registered [12371.718703] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 12:53:30 (1788454410) [12375.317260] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12375.384616] alg: No test for adler32 (adler32-zlib) [12376.563152] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [12376.860800] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [12378.559220] Key type lgssc registered [12380.411184] Lustre: Echo OBD driver; http://www.lustre.org/ [12431.646401] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12437.882737] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12463.447614] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12465.553814] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12473.738752] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12475.598965] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12481.015513] Lustre: lustre-MDT0000-mdc-ffff91d247e36800: Connection to lustre-MDT0000 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [12496.375195] Lustre: lustre-MDT0001-mdc-ffff91d247e36800: Connection to lustre-MDT0001 (at 192.168.204.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [12507.615220] Lustre: 206567:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788454532/real 1788454532] req@000000002e2340d8 x1875330379814656/t0(0) o400->MGC192.168.204.102@tcp@192.168.204.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1788454548 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [12507.657315] LustreError: MGC192.168.204.102@tcp: Connection to MGS (at 192.168.204.102@tcp) was lost; in progress operations using this service will fail [12541.435370] Lustre: Evicted from MGS (at 192.168.204.102@tcp) after server handle changed from 0x32173fb2f090850f to 0x32173fb2f09086b3 [12541.473556] Lustre: MGC192.168.204.102@tcp: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [12577.268716] LustreError: lustre-MDT0000-mdc-ffff91d247e36800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [12577.302606] Lustre: lustre-MDT0000-mdc-ffff91d247e36800: Connection restored to 192.168.204.102@tcp (at 192.168.204.102@tcp) [12581.215423] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12583.198364] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [12589.273680] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12590.948803] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12593.996464] Lustre: Unmounted lustre-client [12634.532831] Key type lgssc unregistered [12634.871697] LNet: 211439:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12634.895427] LNetError: 211439:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12634.921480] LNet: Removed LNI 192.168.204.2@tcp [12635.710594] Key type .llcrypt unregistered [12635.714791] Key type ._llcrypt unregistered [12668.829354] Key type ._llcrypt registered [12668.832883] Key type .llcrypt registered [12669.479903] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12669.513710] alg: No test for adler32 (adler32-zlib) [12671.020161] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [12671.361352] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [12673.128414] Key type lgssc registered [12675.440590] Lustre: Echo OBD driver; http://www.lustre.org/ [12771.537915] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12779.287229] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12811.092746] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12871.203563] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 13:01:50 (1788454910) [12975.233813] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12981.413694] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13004.631825] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13006.159648] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [13010.783113] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [13011.997692] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [13012.004417] Lustre: Skipped 1 previous similar message [13016.285573] Lustre: Unmounted lustre-client [13018.576332] Lustre: Unmounted lustre-client [13020.756936] Lustre: Unmounted lustre-client [13024.584080] Lustre: Unmounted lustre-client [13043.402856] Lustre: Unmounted lustre-client [13043.420183] Lustre: Skipped 1 previous similar message [13071.164986] Key type lgssc unregistered [13071.556575] LNet: 220635:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13071.571392] LNetError: 220635:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13071.590275] LNet: Removed LNI 192.168.204.2@tcp [13072.380925] Key type .llcrypt unregistered [13072.382844] Key type ._llcrypt unregistered [13083.326156] Key type ._llcrypt registered [13083.329464] Key type .llcrypt registered [13084.662593] Lustre: DEBUG MARKER: == conf-sanity test 180: stats dump racing module unload must not crash ========================================================== 13:05:24 (1788455124) [13087.338534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13087.368720] alg: No test for adler32 (adler32-zlib) [13088.467365] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13088.708271] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13090.443667] Key type lgssc registered [13091.715414] Lustre: Echo OBD driver; http://www.lustre.org/ [13144.763192] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13151.660820] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13175.374702] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13177.548444] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [13184.470811] Lustre: Unmounted lustre-client [13226.301943] Key type lgssc unregistered [13226.738589] LNet: 223908:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13226.760532] LNetError: 223908:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13226.783265] LNet: Removed LNI 192.168.204.2@tcp [13228.094471] Key type .llcrypt unregistered [13228.096324] Key type ._llcrypt unregistered [13245.389488] Key type ._llcrypt registered [13245.402814] Key type .llcrypt registered [13245.995106] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13246.006313] alg: No test for adler32 (adler32-zlib) [13247.348248] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13247.652245] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13249.336064] Key type lgssc registered [13250.820816] Lustre: Echo OBD driver; http://www.lustre.org/ [13304.237926] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13310.123978] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13334.045233] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13336.937335] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [13341.349401] Lustre: Unmounted lustre-client [13372.779707] Key type lgssc unregistered [13373.226805] LNet: 226932:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13373.241430] LNetError: 226932:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13373.284938] LNet: Removed LNI 192.168.204.2@tcp [13374.104454] Key type .llcrypt unregistered [13374.111407] Key type ._llcrypt unregistered [13391.608100] Key type ._llcrypt registered [13391.617370] Key type .llcrypt registered [13392.510954] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13392.565239] alg: No test for adler32 (adler32-zlib) [13394.005058] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13394.447377] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13396.183995] Key type lgssc registered [13398.012514] Lustre: Echo OBD driver; http://www.lustre.org/ [13463.569283] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13470.721172] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13498.365420] Lustre: DEBUG MARKER: oleg402-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13505.609626] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [13514.275074] Lustre: Unmounted lustre-client [13544.833974] Key type lgssc unregistered [13545.166947] LNet: 229990:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13545.175283] LNetError: 229990:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13545.204244] LNet: Removed LNI 192.168.204.2@tcp [13546.065771] Key type .llcrypt unregistered [13546.067500] Key type ._llcrypt unregistered [13567.045859] Key type ._llcrypt registered [13567.054233] Key type .llcrypt registered [13568.865890] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 13:13:28 (1788455608) [13584.420299] Key type .llcrypt unregistered [13584.423902] Key type ._llcrypt unregistered [13585.651584] Key type ._llcrypt registered [13585.662446] Key type .llcrypt registered [13586.398792] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [13586.410221] alg: No test for adler32 (adler32-zlib) [13587.834751] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13588.179618] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13589.919447] Key type lgssc registered [13591.105566] Lustre: Echo OBD driver; http://www.lustre.org/ [13627.717368] Key type lgssc unregistered [13628.283609] LNet: 232627:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13628.297655] LNetError: 232627:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13628.318754] LNet: Removed LNI 192.168.204.2@tcp [13629.396839] Key type .llcrypt unregistered [13629.398573] Key type ._llcrypt unregistered [13630.027879] Key type ._llcrypt registered [13630.029521] Key type .llcrypt registered [13631.529656] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 13:14:30 (1788455670) [13646.627543] Key type .llcrypt unregistered [13646.630931] Key type ._llcrypt unregistered [13647.882560] Key type ._llcrypt registered [13647.892024] Key type .llcrypt registered [13648.380339] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13648.428680] alg: No test for adler32 (adler32-zlib) [13649.984673] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13650.425511] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13652.207514] Key type lgssc registered [13654.600035] Lustre: Echo OBD driver; http://www.lustre.org/ [13674.545769] Key type lgssc unregistered [13674.841214] LNet: 234187:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13674.851289] LNetError: 234187:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13674.872856] LNet: Removed LNI 192.168.204.2@tcp [13675.613555] Key type .llcrypt unregistered [13675.616752] Key type ._llcrypt unregistered [13683.399950] Key type ._llcrypt registered [13683.404562] Key type .llcrypt registered [13683.842025] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13683.857450] alg: No test for adler32 (adler32-zlib) [13685.103505] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13685.446137] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13687.215724] Key type lgssc registered [13688.689427] Lustre: Echo OBD driver; http://www.lustre.org/ [13716.962796] Key type lgssc unregistered [13717.252844] LNet: 235955:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13717.259311] LNetError: 235955:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13717.278595] LNet: Removed LNI 192.168.204.2@tcp [13718.221906] Key type .llcrypt unregistered [13718.226539] Key type ._llcrypt unregistered [13718.783944] Key type ._llcrypt registered [13718.786375] Key type .llcrypt registered [13720.436876] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 13:15:59 (1788455759) [13732.441681] Key type .llcrypt unregistered [13732.444638] Key type ._llcrypt unregistered [13733.295657] Key type ._llcrypt registered [13733.305769] Key type .llcrypt registered [13733.717155] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13733.730411] alg: No test for adler32 (adler32-zlib) [13734.737125] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13734.902186] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13736.551156] Key type lgssc registered [13737.627452] Lustre: Echo OBD driver; http://www.lustre.org/ [13752.353893] Key type lgssc unregistered [13752.597465] LNet: 237508:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13752.604517] LNetError: 237508:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13752.622972] LNet: Removed LNI 192.168.204.2@tcp [13753.340877] Key type .llcrypt unregistered [13753.343263] Key type ._llcrypt unregistered [13760.702341] Key type ._llcrypt registered [13760.713646] Key type .llcrypt registered [13761.131975] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13761.159702] alg: No test for adler32 (adler32-zlib) [13762.315833] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13762.589386] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13764.311266] Key type lgssc registered [13765.590874] Lustre: Echo OBD driver; http://www.lustre.org/ [13780.178702] Key type lgssc unregistered [13780.440051] LNet: 238817:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13780.447264] LNetError: 238817:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13780.480667] LNet: Removed LNI 192.168.204.2@tcp [13781.071815] Key type .llcrypt unregistered [13781.078435] Key type ._llcrypt unregistered [13789.045928] Key type ._llcrypt registered [13789.047712] Key type .llcrypt registered [13789.638459] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13789.674940] alg: No test for adler32 (adler32-zlib) [13790.978972] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13791.377945] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13793.119268] Key type lgssc registered [13794.816842] Lustre: Echo OBD driver; http://www.lustre.org/ [13816.541588] Key type lgssc unregistered [13816.942820] LNet: 240125:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13816.949121] LNetError: 240125:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13816.988087] LNet: Removed LNI 192.168.204.2@tcp [13817.730768] Key type .llcrypt unregistered [13817.737382] Key type ._llcrypt unregistered [13825.786272] Key type ._llcrypt registered [13825.787869] Key type .llcrypt registered [13826.364704] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13826.382268] alg: No test for adler32 (adler32-zlib) [13827.817552] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13828.105741] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13829.831288] Key type lgssc registered [13831.807475] Lustre: Echo OBD driver; http://www.lustre.org/ [13856.137941] Key type lgssc unregistered [13856.385609] LNet: 241896:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13856.399374] LNetError: 241896:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13856.426735] LNet: Removed LNI 192.168.204.2@tcp [13857.045950] Key type .llcrypt unregistered [13857.050807] Key type ._llcrypt unregistered [13857.570708] Key type ._llcrypt registered [13857.573126] Key type .llcrypt registered [13858.877953] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 13:18:18 (1788455898) [13870.245315] Key type .llcrypt unregistered [13870.249572] Key type ._llcrypt unregistered [13871.190611] Key type ._llcrypt registered [13871.195407] Key type .llcrypt registered [13871.647189] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13871.662631] alg: No test for adler32 (adler32-zlib) [13872.748599] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13872.994222] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13874.703244] Key type lgssc registered [13875.821771] Lustre: Echo OBD driver; http://www.lustre.org/ [13891.647764] Key type lgssc unregistered [13891.995101] LNet: 243453:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13892.016195] LNetError: 243453:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13892.036207] LNet: Removed LNI 192.168.204.2@tcp [13893.039477] Key type .llcrypt unregistered [13893.046591] Key type ._llcrypt unregistered [13900.827226] Key type ._llcrypt registered [13900.833250] Key type .llcrypt registered [13901.139698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13901.167328] alg: No test for adler32 (adler32-zlib) [13902.329801] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13902.654228] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13904.386380] Key type lgssc registered [13905.630647] Lustre: Echo OBD driver; http://www.lustre.org/ [13922.827213] Key type lgssc unregistered [13923.180285] LNet: 244770:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13923.195643] LNetError: 244770:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13923.244377] LNet: Removed LNI 192.168.204.2@tcp [13923.983927] Key type .llcrypt unregistered [13923.985579] Key type ._llcrypt unregistered [13934.893358] Key type ._llcrypt registered [13934.896266] Key type .llcrypt registered [13935.797492] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13935.844384] alg: No test for adler32 (adler32-zlib) [13937.425626] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13937.826146] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13939.727230] Key type lgssc registered [13942.245895] Lustre: Echo OBD driver; http://www.lustre.org/ [13963.406312] Key type lgssc unregistered [13963.695890] LNet: 246079:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13963.708872] LNetError: 246079:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13963.724997] LNet: Removed LNI 192.168.204.2@tcp [13964.568652] Key type .llcrypt unregistered [13964.574838] Key type ._llcrypt unregistered [13974.183686] Key type ._llcrypt registered [13974.196289] Key type .llcrypt registered [13974.712894] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13974.746621] alg: No test for adler32 (adler32-zlib) [13976.271869] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13976.680916] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [13978.511189] Key type lgssc registered [13980.330037] Lustre: Echo OBD driver; http://www.lustre.org/ [13999.944787] Key type lgssc unregistered [14000.256637] LNet: 247391:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14000.261317] LNetError: 247391:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14000.276651] LNet: Removed LNI 192.168.204.2@tcp [14001.113345] Key type .llcrypt unregistered [14001.121314] Key type ._llcrypt unregistered [14009.038556] Key type ._llcrypt registered [14009.053862] Key type .llcrypt registered [14009.421218] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14009.434246] alg: No test for adler32 (adler32-zlib) [14010.430902] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14010.559948] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14012.207897] Key type lgssc registered [14014.250634] Lustre: Echo OBD driver; http://www.lustre.org/ [14032.633239] Key type lgssc unregistered [14032.959576] LNet: 248705:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14032.967349] LNetError: 248705:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14032.980737] LNet: Removed LNI 192.168.204.2@tcp [14033.780340] Key type .llcrypt unregistered [14033.787060] Key type ._llcrypt unregistered [14042.107093] Key type ._llcrypt registered [14042.115575] Key type .llcrypt registered [14042.582386] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14042.612561] alg: No test for adler32 (adler32-zlib) [14043.992940] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14044.355770] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14046.255314] Key type lgssc registered [14048.259513] Lustre: Echo OBD driver; http://www.lustre.org/ [14072.147653] Key type lgssc unregistered [14072.677929] LNet: 250014:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14072.688422] LNetError: 250014:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14072.720836] LNet: Removed LNI 192.168.204.2@tcp [14073.883693] Key type .llcrypt unregistered [14073.889455] Key type ._llcrypt unregistered [14102.275801] Key type ._llcrypt registered [14102.278502] Key type .llcrypt registered [14104.059951] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 13:22:23 (1788456143) [14118.715445] Key type .llcrypt unregistered [14118.717790] Key type ._llcrypt unregistered [14120.509926] Key type ._llcrypt registered [14120.520603] Key type .llcrypt registered [14121.191504] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14121.215647] alg: No test for adler32 (adler32-zlib) [14122.633907] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14123.146577] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14124.879334] Key type lgssc registered [14126.457133] Lustre: Echo OBD driver; http://www.lustre.org/ [14145.053341] Key type lgssc unregistered [14145.283454] LNet: 252347:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14145.289688] LNetError: 252347:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14145.300743] LNet: Removed LNI 192.168.204.2@tcp [14146.144605] Key type .llcrypt unregistered [14146.148214] Key type ._llcrypt unregistered [14154.935845] Key type ._llcrypt registered [14154.943718] Key type .llcrypt registered [14155.635395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14155.653341] alg: No test for adler32 (adler32-zlib) [14156.817772] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14157.075381] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14158.751315] Key type lgssc registered [14160.160583] Lustre: Echo OBD driver; http://www.lustre.org/ [14178.616970] Key type lgssc unregistered [14178.875613] LNet: 253670:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14178.888027] LNetError: 253670:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14178.906513] LNet: Removed LNI 192.168.204.2@tcp [14179.506813] Key type .llcrypt unregistered [14179.509458] Key type ._llcrypt unregistered [14187.507665] Key type ._llcrypt registered [14187.513278] Key type .llcrypt registered [14188.069714] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14188.098091] alg: No test for adler32 (adler32-zlib) [14189.443542] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14189.751513] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14191.527286] Key type lgssc registered [14193.127248] Lustre: Echo OBD driver; http://www.lustre.org/ [14212.911577] Key type lgssc unregistered [14213.204480] LNet: 254982:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14213.212592] LNetError: 254982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14213.236954] LNet: Removed LNI 192.168.204.2@tcp [14214.130542] Key type .llcrypt unregistered [14214.133086] Key type ._llcrypt unregistered [14221.948203] Key type ._llcrypt registered [14221.951792] Key type .llcrypt registered [14222.657482] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14222.684508] alg: No test for adler32 (adler32-zlib) [14223.764505] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14224.069418] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14225.823262] Key type lgssc registered [14227.183698] Lustre: Echo OBD driver; http://www.lustre.org/ [14259.169764] Key type lgssc unregistered [14259.494096] LNet: 256795:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14259.504689] LNetError: 256795:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14259.536232] LNet: Removed LNI 192.168.204.2@tcp [14260.351001] Key type .llcrypt unregistered [14260.355443] Key type ._llcrypt unregistered [14260.923342] Key type ._llcrypt registered [14260.931481] Key type .llcrypt registered [14262.671843] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 13:25:01 (1788456301) [14283.557450] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14283.601578] alg: No test for adler32 (adler32-zlib) [14284.808640] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14285.162732] LNet: Added LNI 192.168.204.2@tcp [8/256/0/180] [14287.032562] Key type lgssc registered [14288.826593] Lustre: Echo OBD driver; http://www.lustre.org/ [14559.698592] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 13:29:58 (1788456598) [14561.568422] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [14648.944650] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14383 sec ========= 13:31:27 (1788456687) [14651.816783] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:31:30 (1788456690) === [14657.395597] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:31:35 (1788456695) === [14704.861860] Key type lgssc unregistered [14705.200386] LNet: 265873:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14705.206197] LNetError: 265873:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14705.223411] LNet: Removed LNI 192.168.204.2@tcp [14706.063310] Key type .llcrypt unregistered [14706.070984] Key type ._llcrypt unregistered