[ 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 481527586 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002318] x2apic enabled [ 0.003008] Switched APIC routing to physical x2apic. [ 0.004009] kvm-guest: setup PV IPIs [ 0.006288] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008030] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009010] pid_max: default: 32768 minimum: 301 [ 0.011053] LSM: Security Framework initializing [ 0.012045] Yama: becoming mindful. [ 0.013034] SELinux: Initializing. [ 0.014061] *** VALIDATE selinux *** [ 0.022797] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026474] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028158] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030031] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032032] *** VALIDATE tmpfs *** [ 0.033454] *** VALIDATE proc *** [ 0.034227] *** VALIDATE cgroup *** [ 0.035013] *** VALIDATE cgroup2 *** [ 0.037264] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.039065] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041030] Spectre V2 : User space: Vulnerable [ 0.042008] Speculative Store Bypass: Vulnerable [ 0.045397] debug: unmapping init [mem 0xffffffff9dc59000-0xffffffff9dc60fff] [ 0.047145] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048640] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049028] ... version: 2 [ 0.050013] ... bit width: 48 [ 0.051013] ... generic registers: 4 [ 0.052014] ... value mask: 0000ffffffffffff [ 0.053014] ... max period: 00007fffffffffff [ 0.054015] ... fixed-purpose events: 3 [ 0.055012] ... event mask: 000000070000000f [ 0.056296] rcu: Hierarchical SRCU implementation. [ 0.058398] smp: Bringing up secondary CPUs ... [ 0.059519] x86: Booting SMP configuration: [ 0.060021] .... node #0, CPUs: #1 #2 #3 [ 0.063356] smp: Brought up 1 node, 4 CPUs [ 0.065014] smpboot: Max logical packages: 1 [ 0.066019] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.142855] node 0 deferred pages initialised in 74ms [ 0.147008] devtmpfs: initialized [ 0.148232] x86/mm: Memory block size: 128MB [ 0.150773] gcov: version magic: 0x41383552 [ 0.151621] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.157053] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.159339] pinctrl core: initialized pinctrl subsystem [ 0.161165] [ 0.161596] ************************************************************* [ 0.163013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.165011] ** ** [ 0.167010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.169010] ** ** [ 0.171010] ** This means that this kernel is built to expose internal ** [ 0.172009] ** IOMMU data structures, which may compromise security on ** [ 0.174010] ** your system. ** [ 0.176009] ** ** [ 0.178010] ** If you see this message and you are not debugging the ** [ 0.180011] ** kernel, report this immediately to your vendor! ** [ 0.182010] ** ** [ 0.183009] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.185010] ************************************************************* [ 0.187753] NET: Registered protocol family 16 [ 0.189404] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.192045] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.194052] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.197095] cpuidle: using governor menu [ 0.199071] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.201406] PCI: Using configuration type 1 for base access [ 0.203112] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.213068] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.214014] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.216046] cryptd: max_cpu_qlen set to 1000 [ 0.218248] ACPI: Added _OSI(Module Device) [ 0.220018] ACPI: Added _OSI(Processor Device) [ 0.222016] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.224014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.229065] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.235316] ACPI: Interpreter enabled [ 0.237065] ACPI: PM: (supports S0 S3 S4 S5) [ 0.238008] ACPI: Using IOAPIC for interrupt routing [ 0.240100] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.242328] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.252069] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.254029] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.256012] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.259096] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.264000] acpiphp: Slot [2] registered [ 0.266120] acpiphp: Slot [5] registered [ 0.267120] acpiphp: Slot [6] registered [ 0.269092] acpiphp: Slot [3] registered [ 0.270117] acpiphp: Slot [4] registered [ 0.272113] acpiphp: Slot [7] registered [ 0.273084] acpiphp: Slot [8] registered [ 0.275090] acpiphp: Slot [9] registered [ 0.276083] acpiphp: Slot [10] registered [ 0.277085] acpiphp: Slot [11] registered [ 0.279107] acpiphp: Slot [12] registered [ 0.281097] acpiphp: Slot [13] registered [ 0.282000] acpiphp: Slot [14] registered [ 0.282000] acpiphp: Slot [15] registered [ 0.283103] acpiphp: Slot [16] registered [ 0.285095] acpiphp: Slot [17] registered [ 0.287089] acpiphp: Slot [18] registered [ 0.288112] acpiphp: Slot [19] registered [ 0.289088] acpiphp: Slot [20] registered [ 0.291084] acpiphp: Slot [21] registered [ 0.292089] acpiphp: Slot [22] registered [ 0.293077] acpiphp: Slot [23] registered [ 0.295080] acpiphp: Slot [24] registered [ 0.296084] acpiphp: Slot [25] registered [ 0.297083] acpiphp: Slot [26] registered [ 0.299097] acpiphp: Slot [27] registered [ 0.300099] acpiphp: Slot [28] registered [ 0.302104] acpiphp: Slot [29] registered [ 0.303071] acpiphp: Slot [30] registered [ 0.304086] acpiphp: Slot [31] registered [ 0.306060] PCI host bridge to bus 0000:00 [ 0.308014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.310025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.313022] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.315018] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.317018] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.319022] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.321139] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.324056] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.327633] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.335014] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.338596] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.341018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.344014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.347017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.350476] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.353949] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.356040] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.359946] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.365011] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.375014] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.380015] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.384448] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.389918] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.395014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.411013] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.419997] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.426014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.431015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.446020] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.456828] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.459541] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.462369] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.466424] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.468210] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.472029] iommu: Default domain type: Passthrough [ 0.474399] SCSI subsystem initialized [ 0.475097] ACPI: bus type USB registered [ 0.477080] usbcore: registered new interface driver usbfs [ 0.479155] usbcore: registered new interface driver hub [ 0.481079] usbcore: registered new device driver usb [ 0.482117] pps_core: LinuxPPS API ver. 1 registered [ 0.483007] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.486053] PTP clock support registered [ 0.488297] EDAC MC: Ver: 3.0.0 [ 0.490111] PCI: Using ACPI for IRQ routing [ 0.492832] NetLabel: Initializing [ 0.494010] NetLabel: domain hash size = 128 [ 0.496011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.497076] NetLabel: unlabeled traffic allowed by default [ 0.500035] vgaarb: loaded [ 0.501327] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.502013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.508000] clocksource: Switched to clocksource kvm-clock [ 0.609627] VFS: Disk quotas dquot_6.6.0 [ 0.611618] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.614192] *** VALIDATE ramfs *** [ 0.615496] *** VALIDATE hugetlbfs *** [ 0.616930] pnp: PnP ACPI init [ 0.619834] pnp: PnP ACPI: found 6 devices [ 0.647860] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.650138] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.651876] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.653937] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.655750] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.657990] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.660401] NET: Registered protocol family 2 [ 0.662565] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.667459] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.671488] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.677179] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.680429] TCP: Hash tables configured (established 65536 bind 65536) [ 0.683629] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.686357] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.688774] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.691602] NET: Registered protocol family 1 [ 0.693936] RPC: Registered named UNIX socket transport module. [ 0.696407] RPC: Registered udp transport module. [ 0.698224] RPC: Registered tcp transport module. [ 0.700152] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.702566] NET: Registered protocol family 44 [ 0.703840] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.705809] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.707903] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.710248] PCI: CLS 0 bytes, default 64 [ 0.712404] Unpacking initramfs... [ 2.104362] debug: unmapping init [mem 0xffff964ffcc64000-0xffff964ffffcffff] [ 2.108655] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.113221] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.116336] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.615478] Initialise system trusted keyrings [ 2.617282] Key type blacklist registered [ 2.619462] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.628633] zbud: loaded [ 2.633204] *** VALIDATE nfs *** [ 2.634793] *** VALIDATE nfs4 *** [ 2.636763] pstore: using deflate compression [ 2.640581] Platform Keyring initialized [ 2.744813] NET: Registered protocol family 38 [ 2.746946] Key type asymmetric registered [ 2.748593] Asymmetric key parser 'x509' registered [ 2.750961] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.753676] io scheduler mq-deadline registered [ 2.755444] io scheduler kyber registered [ 2.757410] io scheduler bfq registered [ 2.759550] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.762696] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.765287] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.768477] ACPI: Power Button [PWRF] [ 2.773733] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.780593] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.789766] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.817535] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.846174] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.851709] Non-volatile memory driver v1.3 [ 2.853614] Linux agpgart interface v0.103 [ 2.884616] virtio_blk virtio1: [vda] 146152 512-byte logical blocks (74.8 MB/71.4 MiB) [ 2.887640] vda: detected capacity change from 0 to 74829824 [ 2.902507] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.905577] vdb: detected capacity change from 0 to 1073741824 [ 2.911106] libphy: Fixed MDIO Bus: probed [ 2.916671] usbcore: registered new interface driver usbserial_generic [ 2.919404] usbserial: USB Serial support registered for generic [ 2.922533] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.926361] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.927948] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.930621] mousedev: PS/2 mouse device common for all mice [ 2.933891] rtc_cmos 00:05: RTC can wake from S4 [ 2.938590] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.943593] rtc_cmos 00:05: registered as rtc0 [ 2.946665] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.947483] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.954914] intel_pstate: CPU model not supported [ 2.957433] hid: raw HID events driver (C) Jiri Kosina [ 2.963783] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.964485] usbcore: registered new interface driver usbhid [ 2.971652] usbhid: USB HID core driver [ 2.973382] drop_monitor: Initializing network drop monitor service [ 2.976059] Initializing XFRM netlink socket [ 2.979430] NET: Registered protocol family 10 [ 2.982458] Segment Routing with IPv6 [ 2.984518] NET: Registered protocol family 17 [ 2.986386] mpls_gso: MPLS GSO support [ 2.990872] RAS: Correctable Errors collector initialized. [ 2.992827] AVX version of gcm_enc/dec engaged. [ 2.994367] AES CTR mode by8 optimization enabled [ 3.064068] sched_clock: Marking stable (3064025226, 0)->(3940285537, -876260311) [ 3.067595] registered taskstats version 1 [ 3.069793] Loading compiled-in X.509 certificates [ 3.072353] zswap: loaded using pool lzo/zbud [ 3.099058] Key type big_key registered [ 3.110988] Key type encrypted registered [ 3.112723] ima: No TPM chip found, activating TPM-bypass! [ 3.114760] ima: Allocated hash algorithm: sha1 [ 3.116278] ima: No architecture policies found [ 3.117859] evm: Initialising EVM extended attributes: [ 3.119715] evm: security.selinux [ 3.120865] evm: security.ima [ 3.122400] evm: security.capability [ 3.123707] evm: HMAC attrs: 0x1 [ 3.126470] rtc_cmos 00:05: setting system clock to 2026-08-24 13:52:42 UTC (1787579562) [ 3.133187] debug: unmapping init [mem 0xffffffff9ec03000-0xffffffff9edfffff] [ 3.136459] debug: unmapping init [mem 0xffffffff9d982000-0xffffffff9dc58fff] [ 3.146177] Write protecting the kernel read-only data: 28672k [ 3.149578] debug: unmapping init [mem 0xffffffff9c003000-0xffffffff9c1fffff] [ 3.152812] debug: unmapping init [mem 0xffffffff9c914000-0xffffffff9c9fffff] [ 3.186570] 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.195849] systemd[1]: Detected virtualization kvm. [ 3.197871] systemd[1]: Detected architecture x86-64. [ 3.200711] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.231733] systemd[1]: No hostname configured. [ 3.233449] systemd[1]: Set hostname to . [ 3.235531] random: systemd: uninitialized urandom read (16 bytes read) [ 3.237800] systemd[1]: Initializing machine ID from random generator. [ 3.288098] random: ln: uninitialized urandom read (6 bytes read) [ 3.382384] random: systemd: uninitialized urandom read (16 bytes read) [ 3.385750] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.393356] systemd[1]: Reached target Local Encrypted Volumes. [ OK ] Reached target Local Encrypted Volumes. [ 3.398486] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Timers. [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... Starting Journal Service... Starting Apply Kernel Variables... [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Sockets. Starting Create Volatile Files and Directories... [ OK ] Reached target Initrd Root Device. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.055540] device-mapper: uevent: version 1.0.3 [ 4.057732] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.803637] virtio_net virtio0 ens2: renamed from eth0 [ 4.846829] scsi host0: ata_piix [ 4.866693] scsi host1: ata_piix [ 4.868695] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.871246] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.647610] dracut-initqueue[580]: RTNETLINK answers: File exists [ 9.631470] random: crng init done [ 9.632759] 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.121298] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ 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.347367] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.625225] SELinux: Disabled at runtime. [ 11.689171] 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.698976] systemd[1]: Detected virtualization kvm. [ 11.700869] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.225038] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.228765] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.235840] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.240014] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.244329] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.253987] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.258484] systemd[1]: Reached target rpc_pipefs.target. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Remount Root and Kernel File Systems... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-getty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Listening on udev Kernel Socket. Mounting POSIX Message Queue File System... [ OK ] Listening on Process Core Dump Socket. Mounting Huge Pages File System... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Dispatch Password Requests to Console Directory Watch. Starting udev Coldplug all Devices... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ 12.425206] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target RPC Port Mapper. Starting Apply Kernel Variables... [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.695996] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.044526] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.062642] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.154497] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.168695] EDAC sbridge: Ver: 1.1.2 [ 14.533762] Key type dns_resolver registered [ 14.847520] NFS: Registering the id_resolver key type [ 14.850046] Key type id_resolver registered [ 14.851913] 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ 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 GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg304-client login: [ 44.361242] libcfs: loading out-of-tree module taints kernel. [ 44.441156] Key type ._llcrypt registered [ 44.442966] Key type .llcrypt registered [ 44.726965] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 44.735260] alg: No test for adler32 (adler32-zlib) [ 45.814398] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 46.182607] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 47.815562] Key type lgssc registered [ 48.576907] Lustre: Echo OBD driver; http://www.lustre.org/ [ 208.487031] hrtimer: interrupt took 6366474 ns [ 223.452968] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 228.826089] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 241.322874] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing check_logdir /tmp/testlogs/ [ 246.543429] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing yml_node [ 249.313197] Lustre: lustre-OST0000-osc-ffff965049be9800: disconnect after 23s idle [ 251.051488] Lustre: DEBUG MARKER: Client: 2.17.57.80 [ 253.795510] Lustre: DEBUG MARKER: MDS: 2.17.57.80 [ 256.844430] Lustre: DEBUG MARKER: OSS: 2.17.57.80 [ 258.834591] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Aug 24 09:56:56 EDT 2026 [ 277.718788] Lustre: DEBUG MARKER: excepting tests: 32newtarball [ 279.583434] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 283.122844] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 293.497537] Lustre: Unmounted lustre-client [ 412.037964] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 419.163735] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 443.423653] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 482.255187] Lustre: DEBUG MARKER: == conf-sanity test 121: failover MGS ==================== 10:00:40 (1787580040) [ 529.988208] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 537.454382] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 583.529676] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 634.781679] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 641.354988] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 677.579817] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mgc.*.mgs_server_uuid 1475 0 [ 701.698198] Lustre: DEBUG MARKER: == conf-sanity test 122a: Check OST sequence update ====== 10:04:19 (1787580259) [ 813.789401] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 820.307782] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 845.939632] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 846.602214] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 871.484091] Lustre: Unmounted lustre-client [ 900.126296] Key type lgssc unregistered [ 900.432549] LNet: 21862:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 900.442571] LNetError: 21862:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 900.474168] LNet: Removed LNI 192.168.203.4@tcp [ 901.234277] Key type .llcrypt unregistered [ 901.239527] Key type ._llcrypt unregistered [ 918.690587] Key type ._llcrypt registered [ 918.698410] Key type .llcrypt registered [ 920.217754] Lustre: DEBUG MARKER: == conf-sanity test 123aa: llog_print works with FIDs and simple names ========================================================== 10:07:57 (1787580477) [ 923.011261] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 923.031447] alg: No test for adler32 (adler32-zlib) [ 924.095424] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 924.321210] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 926.015127] Key type lgssc registered [ 927.347069] Lustre: Echo OBD driver; http://www.lustre.org/ [ 978.249594] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 983.525969] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1003.737953] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1006.370288] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 1016.542857] Lustre: DEBUG MARKER: == conf-sanity test 123ab: llog_print params output values from set_param -P ========================================================== 10:09:34 (1787580574) [ 1026.337414] Lustre: DEBUG MARKER: == conf-sanity test 123ac: llog_print with --start and --end ========================================================== 10:09:44 (1787580584) [ 1034.646824] Lustre: DEBUG MARKER: == conf-sanity test 123ad: llog_print shows all records == 10:09:52 (1787580592) [ 1046.837643] Lustre: DEBUG MARKER: == conf-sanity test 123ae: llog_cancel can cancel requested record ========================================================== 10:10:04 (1787580604) [ 1075.179950] Lustre: DEBUG MARKER: == conf-sanity test 123af: llog_catlist can show all config files correctly ========================================================== 10:10:32 (1787580632) [ 1094.985772] Lustre: DEBUG MARKER: == conf-sanity test 123ag: llog_print skips values deleted by set_param -P -d ========================================================== 10:10:52 (1787580652) [ 1109.707821] Lustre: DEBUG MARKER: == conf-sanity test 123ah: del_ost cancels config log entries correctly ========================================================== 10:11:07 (1787580667) [ 1117.604055] Lustre: Unmounted lustre-client [ 1118.035981] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 1119.827385] Lustre: Unmounted lustre-client [ 1145.460429] Key type lgssc unregistered [ 1145.674683] LNet: 30232:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1145.680553] LNetError: 30232:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1145.699070] LNet: Removed LNI 192.168.203.4@tcp [ 1146.331723] Key type .llcrypt unregistered [ 1146.336483] Key type ._llcrypt unregistered [ 1178.211311] Key type ._llcrypt registered [ 1178.219133] Key type .llcrypt registered [ 1178.638195] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1178.648483] alg: No test for adler32 (adler32-zlib) [ 1179.640610] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 1179.813512] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1181.431436] Key type lgssc registered [ 1182.509107] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1265.951748] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1271.581961] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1297.794487] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1353.943905] Lustre: DEBUG MARKER: == conf-sanity test 123ai: llog_print display all non skipped records ========================================================== 10:15:12 (1787580912) [ 1388.274343] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1393.965958] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1416.460745] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1418.227965] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 1564.926914] Lustre: DEBUG MARKER: == conf-sanity test 123aj: check permanent TBF rules ===== 10:18:42 (1787581122) [ 1613.326828] Lustre: DEBUG MARKER: == conf-sanity test 123F: clear and reset all parameters using set_param -F ========================================================== 10:19:30 (1787581170) [ 1625.634512] Lustre: Unmounted lustre-client [ 1708.130816] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1714.172810] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1734.125044] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1734.840224] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 1739.993517] Lustre: Unmounted lustre-client [ 1778.725348] Key type lgssc unregistered [ 1779.176055] LNet: 41559:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1779.198683] LNetError: 41559:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1779.224872] LNet: Removed LNI 192.168.203.4@tcp [ 1780.205133] Key type .llcrypt unregistered [ 1780.207292] Key type ._llcrypt unregistered [ 1801.946629] Key type ._llcrypt registered [ 1801.948608] Key type .llcrypt registered [ 1803.766719] Lustre: DEBUG MARKER: == conf-sanity test 123G: clear and reset all parameters using apply_yaml ========================================================== 10:22:41 (1787581361) [ 1806.971384] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1807.009833] alg: No test for adler32 (adler32-zlib) [ 1808.208314] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 1808.553266] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1810.287494] Key type lgssc registered [ 1811.948510] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1867.140950] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1872.994384] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1895.414171] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1898.587199] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 1913.410683] Lustre: Unmounted lustre-client [ 2004.099616] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2010.465886] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2035.042328] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2035.805884] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 2043.523484] Lustre: Unmounted lustre-client [ 2075.006963] Key type lgssc unregistered [ 2075.340803] LNet: 47104:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2075.367797] LNetError: 47104:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2075.393145] LNet: Removed LNI 192.168.203.4@tcp [ 2076.171278] Key type .llcrypt unregistered [ 2076.175436] Key type ._llcrypt unregistered [ 2096.064187] Key type ._llcrypt registered [ 2096.067301] Key type .llcrypt registered [ 2097.493926] Lustre: DEBUG MARKER: == conf-sanity test 123H: check concurent accesses with 'lctl llog_print ========================================================== 10:27:35 (1787581655) [ 2101.368791] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2101.400083] alg: No test for adler32 (adler32-zlib) [ 2102.710197] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 2103.040646] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2104.831223] Key type lgssc registered [ 2106.714604] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2165.683452] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2170.596662] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2191.163622] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2193.255673] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 2314.325355] Lustre: DEBUG MARKER: == conf-sanity test 124: check failover after replace_nids ========================================================== 10:31:12 (1787581872) [ 2316.035692] Lustre: DEBUG MARKER: SKIP: conf-sanity test_124 needs MDT failover setup [ 2317.913195] Lustre: DEBUG MARKER: == conf-sanity test 126: mount in parallel shouldn't cause a crash ========================================================== 10:31:15 (1787581875) [ 2320.326180] Lustre: Unmounted lustre-client [ 2347.671195] Key type lgssc unregistered [ 2348.022115] LNet: 52453:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2348.030932] LNetError: 52453:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2348.057041] LNet: Removed LNI 192.168.203.4@tcp [ 2348.926858] Key type .llcrypt unregistered [ 2348.935505] Key type ._llcrypt unregistered [ 2374.996954] Key type ._llcrypt registered [ 2375.004826] Key type .llcrypt registered [ 2375.492917] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2375.510293] alg: No test for adler32 (adler32-zlib) [ 2376.609238] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 2376.912447] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2378.575261] Key type lgssc registered [ 2379.788823] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2414.710971] Lustre: DEBUG MARKER: == conf-sanity test 127: direct io overwrite on full ost ========================================================== 10:32:52 (1787581972) [ 2426.674807] Key type lgssc unregistered [ 2426.980357] LNet: 54871:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2426.991226] LNetError: 54871:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2427.022373] LNet: Removed LNI 192.168.203.4@tcp [ 2427.692711] Key type .llcrypt unregistered [ 2427.699667] Key type ._llcrypt unregistered [ 2441.397073] Key type ._llcrypt registered [ 2441.399834] Key type .llcrypt registered [ 2442.000836] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2442.023591] alg: No test for adler32 (adler32-zlib) [ 2443.381445] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 2443.634584] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2445.335187] Key type lgssc registered [ 2447.232769] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2504.168183] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2511.079684] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2533.854974] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2535.850980] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 2584.823866] Lustre: DEBUG MARKER: == conf-sanity test 128: Force using remote logs with --nolocallogs ========================================================== 10:35:42 (1787582142) [ 2586.578317] Lustre: DEBUG MARKER: SKIP: conf-sanity test_128 need separate mgs device [ 2588.562515] Lustre: DEBUG MARKER: == conf-sanity test 129: attempt to connect an OST with the same index should fail ========================================================== 10:35:46 (1787582146) [ 2590.811908] Lustre: Unmounted lustre-client [ 2658.072931] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2664.481047] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2743.214398] Lustre: DEBUG MARKER: == conf-sanity test 130: re-register an MDT after writeconf ========================================================== 10:38:21 (1787582301) [ 2834.100314] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 2839.556960] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2849.777707] Lustre: lustre-MDT0001-mdc-ffff965045cd7000: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2860.000394] Lustre: lustre-OST0000-osc-ffff965045cd7000: disconnect after 24s idle [ 2878.806888] LustreError: 63548:0:(obd_config.c:2102:class_config_llog_handler()) MGC192.168.203.104@tcp: cfg command failed: rc = -17 [ 2878.839991] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 2878.839991] [ 2878.855431] LustreError: 62821:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 2894.019419] Lustre: DEBUG MARKER: == conf-sanity test 131: MDT backup restore with project ID and inheritance flag ========================================================== 10:40:51 (1787582451) [ 2960.520670] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3053.119129] Lustre: Unmounted lustre-client [ 3219.125211] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 3224.662970] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3283.386585] Lustre: DEBUG MARKER: == conf-sanity test 132: hsm_actions processed after failover ========================================================== 10:47:21 (1787582841) [ 3285.470527] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3286.078481] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3286.085697] Lustre: Skipped 2 previous similar messages [ 3305.153138] Lustre: Unmounted lustre-client [ 3470.490846] Lustre: DEBUG MARKER: == conf-sanity test 133: stripe QOS: free space balance in a pool ========================================================== 10:50:28 (1787583028) [ 3472.275592] Lustre: DEBUG MARKER: SKIP: conf-sanity test_133 needs >= 4 OSTs [ 3473.893777] Lustre: DEBUG MARKER: == conf-sanity test 134: check_iam works without faults == 10:50:31 (1787583031) [ 3561.831733] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 3567.372502] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4284.933801] Lustre: DEBUG MARKER: == conf-sanity test 135: check the behavior when changelog is wrapped around ========================================================== 11:04:02 (1787583842) [ 4287.828419] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4298.175436] Lustre: Unmounted lustre-client [ 4444.288745] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4450.622872] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4476.402909] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4477.094573] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 6537.637722] Lustre: 95256:0:(llog_cat.c:310:llog_cat_process_or_fork()) lustre-MDT0000-mdc-ffff965047986800: catlog [0xa:0x5:0x0] crosses index zero [ 6566.587552] Lustre: Unmounted lustre-client [ 6594.709058] Key type lgssc unregistered [ 6595.171673] LNet: 103474:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6595.191360] LNetError: 103474:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6596.284299] LNet: Removed LNI 192.168.203.4@tcp [ 6597.294366] Key type .llcrypt unregistered [ 6597.300736] Key type ._llcrypt unregistered [ 6610.966088] Key type ._llcrypt registered [ 6610.967587] Key type .llcrypt registered [ 6612.907377] Lustre: DEBUG MARKER: == conf-sanity test 136: don't panic with bad obdecho setup ========================================================== 11:42:50 (1787586170) [ 6635.150373] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6635.165654] alg: No test for adler32 (adler32-zlib) [ 6636.412176] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 6636.749974] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 6638.599990] Key type lgssc registered [ 6640.237906] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6726.233569] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6732.564266] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6758.092567] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6760.095780] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 6778.877817] Lustre: Unmounted lustre-client [ 6919.748460] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6925.769450] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6949.297312] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6990.306173] Lustre: DEBUG MARKER: == conf-sanity test 137: a new MDT should inherit pools, parameters and failnode ========================================================== 11:49:08 (1787586548) [ 6992.944506] Lustre: DEBUG MARKER: SKIP: conf-sanity test_137 needs >= 3 MDTs [ 6995.495593] Lustre: DEBUG MARKER: == conf-sanity test 140: remove_updatelog script actions ========================================================== 11:49:12 (1787586552) [ 7034.220480] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7040.189618] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7063.420511] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7064.513136] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 7079.922244] Lustre: lustre-MDT0000-mdc-ffff965049910800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7090.156794] Lustre: lustre-MDT0001-mdc-ffff965049910800: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7101.408485] Lustre: 104235:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787586644/real 1787586644] req@0000000086cb35ad x1874419983134464/t0(0) o400->MGC192.168.203.104@tcp@192.168.203.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1787586660 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7101.455200] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 7246.319742] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0x56a16165d1c0da2a to 0x56a16165d1c0f0c7 [ 7246.333441] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 7254.012103] Lustre: 113628:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.203.104@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 7259.755902] LustreError: lustre-MDT0000-mdc-ffff965049910800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7259.820659] Lustre: lustre-MDT0000-mdc-ffff965049910800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 7266.829682] LustreError: lustre-MDT0001-mdc-ffff965049910800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7266.858638] Lustre: lustre-MDT0001-mdc-ffff965049910800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 7273.906531] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7276.043400] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7283.220830] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7285.182583] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7304.105123] Lustre: Unmounted lustre-client [ 7456.157988] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7463.886173] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7490.571813] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7537.697770] Lustre: DEBUG MARKER: == conf-sanity test 150: test setting max_cached_mb to a % ========================================================== 11:58:15 (1787587095) [ 7574.899195] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7584.281666] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7609.463925] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7620.717476] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 7623.538212] LustreError: 120964: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 [ 7636.091085] Lustre: DEBUG MARKER: == conf-sanity test 151a: damaged local config doesn't prevent mounting ========================================================== 11:59:53 (1787587193) [ 7641.927812] Lustre: Unmounted lustre-client [ 7675.212659] Key type lgssc unregistered [ 7675.572221] LNet: 121979:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7675.593204] LNetError: 121979:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7675.622689] LNet: Removed LNI 192.168.203.4@tcp [ 7676.576562] Key type .llcrypt unregistered [ 7676.579456] Key type ._llcrypt unregistered [ 7694.793615] Key type ._llcrypt registered [ 7694.795346] Key type .llcrypt registered [ 7695.560762] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7695.611620] alg: No test for adler32 (adler32-zlib) [ 7696.769123] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 7697.121472] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 7698.823312] Key type lgssc registered [ 7700.769464] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7801.246386] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7807.960987] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7829.102951] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7944.501755] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7951.700788] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7979.235561] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8029.502295] Lustre: DEBUG MARKER: == conf-sanity test 151b: -ENOSPC doesn't affect mount === 12:06:27 (1787587587) [ 8043.093969] Key type lgssc unregistered [ 8043.405704] LNet: 129217:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8043.411255] LNetError: 129217:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8043.433660] LNet: Removed LNI 192.168.203.4@tcp [ 8044.068889] Key type .llcrypt unregistered [ 8044.072459] Key type ._llcrypt unregistered [ 8057.239952] Key type ._llcrypt registered [ 8057.245736] Key type .llcrypt registered [ 8057.744708] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8057.757814] alg: No test for adler32 (adler32-zlib) [ 8058.856268] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 8059.084901] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 8060.801543] Key type lgssc registered [ 8061.912247] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8114.059959] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8120.055139] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8144.561235] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8281.614569] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8288.250423] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8312.684476] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8355.353086] Lustre: DEBUG MARKER: == conf-sanity test 152: seq allocation error in OSP ===== 12:11:53 (1787587913) [ 8443.706393] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 8448.604693] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 8461.098286] Lustre: DEBUG MARKER: ADD OST3 [ 8469.472391] Lustre: lustre-OST0000-osc-ffff965044e0b000: disconnect after 23s idle [ 8472.993735] Lustre: DEBUG MARKER: STOP OST3 [ 8484.340386] Lustre: lustre-OST0003-osc-ffff965044e0b000: Connection to lustre-OST0003 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8493.376163] Lustre: DEBUG MARKER: START OST3 again [ 8502.207745] Lustre: lustre-OST0003-osc-ffff965044e0b000: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 8534.686650] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8534.700900] LustreError: 140043:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff965044e0b000: inode [0x240000bd0:0x1:0x0] mdc close failed: rc = -108 [ 8545.099421] Lustre: Unmounted lustre-client [ 8657.251860] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8664.417102] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8689.092733] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8724.341677] Lustre: DEBUG MARKER: == conf-sanity test 153a: bypass invalid NIDs quickly ==== 12:18:02 (1787588282) [ 8814.349426] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8821.188481] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8843.832601] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8924.195545] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8931.255733] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8953.143282] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8955.064805] LNetError: 129628:0:(lib-move.c:2158:lnet_handle_find_routed_path()) peer 192.168.252.112@tcp2 has no available nets [ 8955.318101] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 8960.842116] Lustre: Unmounted lustre-client [ 8982.343659] Key type lgssc unregistered [ 9007.329279] LNet: 1 local NIs in recovery (showing 1): 192.168.203.4@tcp [ 9014.367546] LNet: 149020:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9014.389427] LNetError: 149020:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9086.123530] LNet: Removed LNI 192.168.203.4@tcp [ 9086.891154] Key type .llcrypt unregistered [ 9086.894081] Key type ._llcrypt unregistered [ 9103.463404] Key type ._llcrypt registered [ 9103.467638] Key type .llcrypt registered [ 9104.993872] Lustre: DEBUG MARKER: == conf-sanity test 153b: added IPv6 NID support ========= 12:24:22 (1787588662) [ 9123.969369] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9124.004157] alg: No test for adler32 (adler32-zlib) [ 9125.058654] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 9125.419139] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 9127.207863] Key type lgssc registered [ 9128.905101] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9209.177344] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9215.540167] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9242.011672] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9376.004304] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 9381.266190] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 9389.431172] Lustre: Unmounted lustre-client [ 9389.537217] LNetError: 150204:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5439:6dff:fe3e:a0ad/1023: rc = -22 [ 9389.565337] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9389.887968] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 9390.106340] Lustre: Unmounted lustre-client [ 9390.988950] LNetError: 150205:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5439:6dff:fe3e:a0ad/1023: rc = -22 [ 9391.013604] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9391.342296] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 9391.349858] Lustre: Skipped 1 previous similar message [ 9391.604707] Lustre: Unmounted lustre-client [ 9391.607392] Lustre: Skipped 1 previous similar message [ 9393.527692] LNetError: 150205:0:(lib-socket.c:308:lnet_sock_create()) Error trying to bind to fe80::5439:6dff:fe3e:a0ad/1023: rc = -22 [ 9393.539388] LNetError: Unexpected error -22 connecting to 6699:7654::1234:1234:d84@tcp at host [6699:7654::1234:1234:d84]:988 [ 9393.860487] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [ 9393.863709] Lustre: Skipped 3 previous similar messages [ 9394.109047] Lustre: Unmounted lustre-client [ 9394.115125] Lustre: Skipped 3 previous similar messages [ 9395.022688] Lustre: 156130: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 [ 9395.556164] Lustre: 156159: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 [ 9403.157904] Lustre: DEBUG MARKER: == conf-sanity test 153c: don't stuck on unreached NID === 12:29:21 (1787588961) [ 9450.080267] LNet: 1 local NIs in recovery (showing 1): 192.168.203.4@tcp [ 9519.827974] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9525.248354] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9549.829499] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9615.071346] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9621.465960] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9642.402680] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9647.967688] LustreError: 161748:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.252.112@tcp: failed processing log, type 1: rc = -110 [ 9698.911146] LNet: 1 local NIs in recovery (showing 1): 192.168.203.4@tcp [ 9774.687433] LNet: 1 local NIs in recovery (showing 1): 192.168.203.4@tcp [ 9785.311617] 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 [ 9785.340179] Lustre: Unmounted lustre-client [ 9785.345503] Lustre: Skipped 3 previous similar messages [ 9785.353841] LustreError: 161748:0:(super25.c:179:lustre_fill_super()) llite: Unable to mount : rc = -110 [ 9812.884264] Key type lgssc unregistered [ 9833.631811] LNet: 162207:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9833.646170] LNetError: 162207:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9905.319748] LNet: Removed LNI 192.168.203.4@tcp [ 9906.465134] Key type .llcrypt unregistered [ 9906.468658] Key type ._llcrypt unregistered [ 9926.484537] Key type ._llcrypt registered [ 9926.491824] Key type .llcrypt registered [ 9928.626465] Lustre: DEBUG MARKER: == conf-sanity test 154: expand .. on rename after MDT backup restore ========================================================== 12:38:05 (1787589485) [ 9948.905858] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9948.983949] alg: No test for adler32 (adler32-zlib) [ 9950.122809] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [ 9950.499848] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 9952.248521] Key type lgssc registered [ 9953.982659] Lustre: Echo OBD driver; http://www.lustre.org/ [10081.361654] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [10086.867920] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10102.506629] Lustre: Unmounted lustre-client [10265.994418] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [10270.731819] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10277.312456] Lustre: Unmounted lustre-client [10324.130441] Lustre: DEBUG MARKER: == conf-sanity test 155: gap in seq allocation from ofd after restarting ========================================================== 12:44:42 (1787589882) [10415.807897] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10421.101557] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10443.394633] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10572.343376] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [10577.581122] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10592.097249] Lustre: Unmounted lustre-client [10721.757125] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [10727.304775] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10746.642629] Lustre: DEBUG MARKER: == conf-sanity test 156: root_fid on export consistent with client mount ========================================================== 12:51:44 (1787590304) [10747.368983] Lustre: lustre-OST0001-osc-ffff965044e0b800: disconnect after 23s idle [10749.095879] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10759.503418] Lustre: Unmounted lustre-client [10947.098392] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [10952.707773] Lustre: DEBUG MARKER: Using TIMEOUT=20 [10962.053526] Lustre: Unmounted lustre-client [10962.644505] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [10972.574261] Lustre: Unmounted lustre-client [10974.526742] Lustre: DEBUG MARKER: == conf-sanity test 157a: test allow_register for MDT registration and MGS restart ========================================================== 12:55:32 (1787590532) [11034.724720] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11041.680418] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11066.189643] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11077.698329] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [11174.896674] LustreError: lustre-OST0001-osc-ffff965050627800: operation ost_connect to node 192.168.203.104@tcp failed: rc = -19 [11180.025046] Lustre: lustre-MDT0000-mdc-ffff965050627800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [11195.382279] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [11195.398866] LustreError: lustre-MDT0000-mdc-ffff965050627800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [11195.436026] Lustre: lustre-MDT0000-mdc-ffff965050627800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [11195.450689] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0xaa31ed895815ede5 to 0xaa31ed895815f0af [11251.324526] Lustre: Unmounted lustre-client [11279.654091] Key type lgssc unregistered [11279.958344] LNet: 189752:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11279.965369] LNetError: 189752:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11279.994697] LNet: Removed LNI 192.168.203.4@tcp [11280.807159] Key type .llcrypt unregistered [11280.814068] Key type ._llcrypt unregistered [11292.786924] Key type ._llcrypt registered [11292.789453] Key type .llcrypt registered [11294.433086] Lustre: DEBUG MARKER: == conf-sanity test 157b: verify allow_register (block new OSTs, allow existing) ========================================================== 13:00:51 (1787590851) [11297.511429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11297.701817] alg: No test for adler32 (adler32-zlib) [11298.859757] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [11299.214755] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11300.935203] Key type lgssc registered [11302.060883] Lustre: Echo OBD driver; http://www.lustre.org/ [11357.652381] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11363.774683] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11386.773080] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11389.628646] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [11487.222181] LustreError: lustre-OST0001-osc-ffff965058212000: operation ost_connect to node 192.168.203.104@tcp failed: rc = -19 [11615.948580] Lustre: Unmounted lustre-client [11656.403549] Key type lgssc unregistered [11656.616530] LNet: 195799:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11656.622110] LNetError: 195799:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11656.641457] LNet: Removed LNI 192.168.203.4@tcp [11657.302785] Key type .llcrypt unregistered [11657.307256] Key type ._llcrypt unregistered [11669.665435] Key type ._llcrypt registered [11669.668102] Key type .llcrypt registered [11671.443036] Lustre: DEBUG MARKER: == conf-sanity test 160: MGC updates failnodes from all participants ========================================================== 13:07:08 (1787591228) [11710.444453] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11710.466924] alg: No test for adler32 (adler32-zlib) [11711.724736] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [11712.118884] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11713.831399] Key type lgssc registered [11715.120322] Lustre: Echo OBD driver; http://www.lustre.org/ [11814.035209] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11822.461977] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11848.909473] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11889.893990] Key type lgssc unregistered [11890.376339] LNet: 200790:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11890.384918] LNetError: 200790:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11890.421630] LNet: Removed LNI 192.168.203.4@tcp [11891.557621] Key type .llcrypt unregistered [11891.560117] Key type ._llcrypt unregistered [12006.517628] Key type ._llcrypt registered [12006.567766] Key type .llcrypt registered [12007.014506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12007.037743] alg: No test for adler32 (adler32-zlib) [12008.215440] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12008.505776] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12010.191207] Key type lgssc registered [12011.566400] Lustre: Echo OBD driver; http://www.lustre.org/ [12062.823716] Lustre: DEBUG MARKER: == conf-sanity test 161: test '-o mgsname' option ======== 13:13:40 (1787591620) [12109.302128] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12115.863413] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12142.236394] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12145.210788] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [12147.272924] Lustre: Unmounted lustre-client [12147.757402] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [12148.097906] Lustre: Unmounted lustre-client [12158.834912] Lustre: Unmounted lustre-client [12190.206573] Key type lgssc unregistered [12190.491773] LNet: 205776:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12190.516076] LNetError: 205776:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12190.538617] LNet: Removed LNI 192.168.203.4@tcp [12191.312633] Key type .llcrypt unregistered [12191.322966] Key type ._llcrypt unregistered [12202.983739] Key type ._llcrypt registered [12202.986252] Key type .llcrypt registered [12204.440407] Lustre: DEBUG MARKER: == conf-sanity test 162: replace nids with -o noclient === 13:16:02 (1787591762) [12208.204638] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12208.230414] alg: No test for adler32 (adler32-zlib) [12209.356113] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12209.613924] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12211.351171] Key type lgssc registered [12212.569677] Lustre: Echo OBD driver; http://www.lustre.org/ [12265.983958] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12272.764395] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12297.745879] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12299.526059] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [12307.148817] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12309.094458] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12315.124100] Lustre: lustre-MDT0000-mdc-ffff965048495800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [12335.606316] Lustre: lustre-MDT0001-mdc-ffff965048495800: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [12345.823382] Lustre: 206450:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787591889/real 1787591889] req@00000000405f9933 x1874425825728768/t0(0) o400->MGC192.168.203.104@tcp@192.168.203.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1787591905 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [12345.903163] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [12391.014750] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0xb0ec098443ac6a63 to 0xb0ec098443ac6c07 [12391.041848] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [12424.143675] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12426.108471] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [12426.229741] LustreError: lustre-MDT0000-mdc-ffff965048495800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [12426.259084] Lustre: lustre-MDT0000-mdc-ffff965048495800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [12432.254755] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12434.086706] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12437.262446] Lustre: Unmounted lustre-client [12462.988782] Key type lgssc unregistered [12463.332779] LNet: 211321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12463.347582] LNetError: 211321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12463.364612] LNet: Removed LNI 192.168.203.4@tcp [12464.085867] Key type .llcrypt unregistered [12464.088683] Key type ._llcrypt unregistered [12492.811563] Key type ._llcrypt registered [12492.818290] Key type .llcrypt registered [12493.466485] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12493.496755] alg: No test for adler32 (adler32-zlib) [12494.748456] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12495.042450] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12496.887137] Key type lgssc registered [12497.980037] Lustre: Echo OBD driver; http://www.lustre.org/ [12589.288700] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12594.996665] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12618.452862] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12659.932429] Lustre: DEBUG MARKER: == conf-sanity test 164: test expected_clients parameter and max client tracking ========================================================== 13:23:37 (1787592217) [12751.208605] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12755.895731] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12777.071169] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12778.762122] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [12782.963957] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [12784.122557] Lustre: Mounted lustre-client - version 2.17.57_80_g35a8f2d [12784.128143] Lustre: Skipped 1 previous similar message [12788.047942] Lustre: Unmounted lustre-client [12789.876886] Lustre: Unmounted lustre-client [12791.774519] Lustre: Unmounted lustre-client [12793.894415] Lustre: Unmounted lustre-client [12803.955658] Lustre: Unmounted lustre-client [12803.959871] Lustre: Skipped 1 previous similar message [12830.718432] Key type lgssc unregistered [12831.029700] LNet: 220489:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12831.045252] LNetError: 220489:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12831.071411] LNet: Removed LNI 192.168.203.4@tcp [12831.795555] Key type .llcrypt unregistered [12831.798504] Key type ._llcrypt unregistered [12843.349157] Key type ._llcrypt registered [12843.352169] Key type .llcrypt registered [12844.862612] Lustre: DEBUG MARKER: == conf-sanity test 200a: check CPU partitions =========== 13:26:42 (1787592402) [12858.584468] Key type .llcrypt unregistered [12858.589603] Key type ._llcrypt unregistered [12859.593620] Key type ._llcrypt registered [12859.596621] Key type .llcrypt registered [12860.185195] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 4 [12860.205161] alg: No test for adler32 (adler32-zlib) [12861.686211] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12862.137394] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12863.984906] Key type lgssc registered [12865.617239] Lustre: Echo OBD driver; http://www.lustre.org/ [12894.419295] Key type lgssc unregistered [12894.675105] LNet: 222652:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12894.682155] LNetError: 222652:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12894.699931] LNet: Removed LNI 192.168.203.4@tcp [12895.367896] Key type .llcrypt unregistered [12895.370127] Key type ._llcrypt unregistered [12895.792621] Key type ._llcrypt registered [12895.794749] Key type .llcrypt registered [12897.303928] Lustre: DEBUG MARKER: == conf-sanity test 200b: set CPU pattern using core selection ========================================================== 13:27:34 (1787592454) [12910.352368] Key type .llcrypt unregistered [12910.357637] Key type ._llcrypt unregistered [12911.603155] Key type ._llcrypt registered [12911.605087] Key type .llcrypt registered [12912.339703] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12912.375126] alg: No test for adler32 (adler32-zlib) [12913.667170] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12914.038592] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12915.864214] Key type lgssc registered [12916.856589] Lustre: Echo OBD driver; http://www.lustre.org/ [12934.874162] Key type lgssc unregistered [12935.081785] LNet: 224214:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12935.088713] LNetError: 224214:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12935.104668] LNet: Removed LNI 192.168.203.4@tcp [12935.924435] Key type .llcrypt unregistered [12935.926308] Key type ._llcrypt unregistered [12943.060673] Key type ._llcrypt registered [12943.064073] Key type .llcrypt registered [12943.353612] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12943.372597] alg: No test for adler32 (adler32-zlib) [12944.502821] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12944.761783] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12946.439188] Key type lgssc registered [12947.707176] Lustre: Echo OBD driver; http://www.lustre.org/ [12973.805854] Key type lgssc unregistered [12974.156921] LNet: 225981:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12974.165259] LNetError: 225981:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12974.197846] LNet: Removed LNI 192.168.203.4@tcp [12974.975399] Key type .llcrypt unregistered [12974.978193] Key type ._llcrypt unregistered [12975.373341] Key type ._llcrypt registered [12975.375414] Key type .llcrypt registered [12977.019553] Lustre: DEBUG MARKER: == conf-sanity test 200c: set CPU pattern using NUMA node layout ========================================================== 13:28:54 (1787592534) [12990.121603] Key type .llcrypt unregistered [12990.123980] Key type ._llcrypt unregistered [12991.078617] Key type ._llcrypt registered [12991.097596] Key type .llcrypt registered [12991.494528] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12991.504824] alg: No test for adler32 (adler32-zlib) [12992.688512] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [12992.890242] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12994.553676] Key type lgssc registered [12995.939822] Lustre: Echo OBD driver; http://www.lustre.org/ [13009.947489] Key type lgssc unregistered [13010.142877] LNet: 227534:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13010.150529] LNetError: 227534:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13010.160834] LNet: Removed LNI 192.168.203.4@tcp [13010.719900] Key type .llcrypt unregistered [13010.722383] Key type ._llcrypt unregistered [13016.347104] Key type ._llcrypt registered [13016.348732] Key type .llcrypt registered [13016.641361] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13016.667656] alg: No test for adler32 (adler32-zlib) [13017.676597] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13017.871973] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13019.544042] Key type lgssc registered [13020.766281] Lustre: Echo OBD driver; http://www.lustre.org/ [13035.969715] Key type lgssc unregistered [13036.367952] LNet: 228843:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13036.378284] LNetError: 228843:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13036.414346] LNet: Removed LNI 192.168.203.4@tcp [13037.255794] Key type .llcrypt unregistered [13037.258688] Key type ._llcrypt unregistered [13046.243083] Key type ._llcrypt registered [13046.245745] Key type .llcrypt registered [13046.940830] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13046.953496] alg: No test for adler32 (adler32-zlib) [13048.272408] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13048.762388] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13050.552129] Key type lgssc registered [13051.926275] Lustre: Echo OBD driver; http://www.lustre.org/ [13069.639778] Key type lgssc unregistered [13069.874870] LNet: 230152:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13069.889198] LNetError: 230152:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13069.911078] LNet: Removed LNI 192.168.203.4@tcp [13070.723757] Key type .llcrypt unregistered [13070.726221] Key type ._llcrypt unregistered [13080.023426] Key type ._llcrypt registered [13080.050952] Key type .llcrypt registered [13080.342117] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13080.367894] alg: No test for adler32 (adler32-zlib) [13081.558675] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13081.786703] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13083.488064] Key type lgssc registered [13084.849848] Lustre: Echo OBD driver; http://www.lustre.org/ [13111.373536] Key type lgssc unregistered [13111.629340] LNet: 231923:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13111.643744] LNetError: 231923:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13111.670438] LNet: Removed LNI 192.168.203.4@tcp [13112.372658] Key type .llcrypt unregistered [13112.377935] Key type ._llcrypt unregistered [13112.789918] Key type ._llcrypt registered [13112.792972] Key type .llcrypt registered [13114.017501] Lustre: DEBUG MARKER: == conf-sanity test 200d: set CPU pattern to exclude only CPU 1 ========================================================== 13:31:12 (1787592672) [13125.182796] Key type .llcrypt unregistered [13125.185928] Key type ._llcrypt unregistered [13126.104674] Key type ._llcrypt registered [13126.112425] Key type .llcrypt registered [13126.410375] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13126.434075] alg: No test for adler32 (adler32-zlib) [13127.492255] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13127.705168] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13129.425437] Key type lgssc registered [13130.839473] Lustre: Echo OBD driver; http://www.lustre.org/ [13148.152223] Key type lgssc unregistered [13148.388809] LNet: 233483:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13148.398342] LNetError: 233483:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13148.417272] LNet: Removed LNI 192.168.203.4@tcp [13148.964638] Key type .llcrypt unregistered [13148.966759] Key type ._llcrypt unregistered [13156.419210] Key type ._llcrypt registered [13156.426762] Key type .llcrypt registered [13156.815606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13156.830897] alg: No test for adler32 (adler32-zlib) [13157.967342] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13158.198446] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13159.904297] Key type lgssc registered [13161.734905] Lustre: Echo OBD driver; http://www.lustre.org/ [13178.937985] Key type lgssc unregistered [13179.190141] LNet: 234801:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13179.197359] LNetError: 234801:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13179.213647] LNet: Removed LNI 192.168.203.4@tcp [13179.752743] Key type .llcrypt unregistered [13179.756573] Key type ._llcrypt unregistered [13186.833305] Key type ._llcrypt registered [13186.835218] Key type .llcrypt registered [13187.223239] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13187.245131] alg: No test for adler32 (adler32-zlib) [13188.328432] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13188.633188] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13190.351667] Key type lgssc registered [13191.576969] Lustre: Echo OBD driver; http://www.lustre.org/ [13205.808830] Key type lgssc unregistered [13206.106551] LNet: 236113:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13206.118710] LNetError: 236113:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13206.140689] LNet: Removed LNI 192.168.203.4@tcp [13206.793210] Key type .llcrypt unregistered [13206.798375] Key type ._llcrypt unregistered [13213.952087] Key type ._llcrypt registered [13213.956096] Key type .llcrypt registered [13214.419042] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13214.435250] alg: No test for adler32 (adler32-zlib) [13215.545225] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13215.816052] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13217.514156] Key type lgssc registered [13218.779845] Lustre: Echo OBD driver; http://www.lustre.org/ [13233.792207] Key type lgssc unregistered [13234.099095] LNet: 237423:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13234.112512] LNetError: 237423:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13234.131828] LNet: Removed LNI 192.168.203.4@tcp [13234.702336] Key type .llcrypt unregistered [13234.706810] Key type ._llcrypt unregistered [13241.510071] Key type ._llcrypt registered [13241.522179] Key type .llcrypt registered [13241.920971] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13241.939784] alg: No test for adler32 (adler32-zlib) [13243.059399] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13243.313706] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13245.023839] Key type lgssc registered [13246.096346] Lustre: Echo OBD driver; http://www.lustre.org/ [13262.576954] Key type lgssc unregistered [13262.825900] LNet: 238735:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13262.834081] LNetError: 238735:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13262.847765] LNet: Removed LNI 192.168.203.4@tcp [13263.430843] Key type .llcrypt unregistered [13263.435675] Key type ._llcrypt unregistered [13270.537626] Key type ._llcrypt registered [13270.538924] Key type .llcrypt registered [13270.794078] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13270.807142] alg: No test for adler32 (adler32-zlib) [13271.943781] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13272.294994] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13273.991254] Key type lgssc registered [13275.470569] Lustre: Echo OBD driver; http://www.lustre.org/ [13293.645163] Key type lgssc unregistered [13293.912978] LNet: 240043:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13293.924149] LNetError: 240043:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13293.944547] LNet: Removed LNI 192.168.203.4@tcp [13294.458776] Key type .llcrypt unregistered [13294.463358] Key type ._llcrypt unregistered [13316.389609] Key type ._llcrypt registered [13316.392132] Key type .llcrypt registered [13317.725704] Lustre: DEBUG MARKER: == conf-sanity test 200e: set CPU pattern using relative core exclusion ========================================================== 13:34:35 (1787592875) [13331.519334] Key type .llcrypt unregistered [13331.531323] Key type ._llcrypt unregistered [13333.253553] Key type ._llcrypt registered [13333.261833] Key type .llcrypt registered [13334.001686] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13334.039669] alg: No test for adler32 (adler32-zlib) [13335.446570] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13335.756680] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13337.519314] Key type lgssc registered [13339.849547] Lustre: Echo OBD driver; http://www.lustre.org/ [13359.296186] Key type lgssc unregistered [13359.577627] LNet: 242374:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13359.592188] LNetError: 242374:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13359.623388] LNet: Removed LNI 192.168.203.4@tcp [13360.317816] Key type .llcrypt unregistered [13360.323837] Key type ._llcrypt unregistered [13368.532907] Key type ._llcrypt registered [13368.536972] Key type .llcrypt registered [13368.778898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13368.793360] alg: No test for adler32 (adler32-zlib) [13370.007673] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13370.330601] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13372.152394] Key type lgssc registered [13373.731853] Lustre: Echo OBD driver; http://www.lustre.org/ [13391.593603] Key type lgssc unregistered [13391.878968] LNet: 243697:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13391.885864] LNetError: 243697:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13391.915515] LNet: Removed LNI 192.168.203.4@tcp [13392.460947] Key type .llcrypt unregistered [13392.467489] Key type ._llcrypt unregistered [13400.303260] Key type ._llcrypt registered [13400.305265] Key type .llcrypt registered [13400.618439] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13400.633514] alg: No test for adler32 (adler32-zlib) [13401.745183] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13402.068296] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13403.832442] Key type lgssc registered [13405.023444] Lustre: Echo OBD driver; http://www.lustre.org/ [13421.592273] Key type lgssc unregistered [13422.021040] LNet: 245010:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13422.041199] LNetError: 245010:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13422.093026] LNet: Removed LNI 192.168.203.4@tcp [13423.180980] Key type .llcrypt unregistered [13423.186289] Key type ._llcrypt unregistered [13434.711151] Key type ._llcrypt registered [13434.715799] Key type .llcrypt registered [13435.388307] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13435.422522] alg: No test for adler32 (adler32-zlib) [13436.726751] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13437.030633] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13438.775924] Key type lgssc registered [13440.668171] Lustre: Echo OBD driver; http://www.lustre.org/ [13470.772596] Key type lgssc unregistered [13471.097251] LNet: 246806:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13471.109659] LNetError: 246806:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13471.149407] LNet: Removed LNI 192.168.203.4@tcp [13471.794700] Key type .llcrypt unregistered [13471.801240] Key type ._llcrypt unregistered [13472.127327] Key type ._llcrypt registered [13472.130246] Key type .llcrypt registered [13473.350690] Lustre: DEBUG MARKER: == conf-sanity test 250: verify lcfg_erase removes filesystem parameters ========================================================== 13:37:11 (1787593031) [13491.810744] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13491.826914] alg: No test for adler32 (adler32-zlib) [13492.974136] Lustre: Lustre: Build Version: 2.17.57_80_g35a8f2d [13493.193534] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13494.895170] Key type lgssc registered [13495.916509] Lustre: Echo OBD driver; http://www.lustre.org/ [13716.581497] Lustre: DEBUG MARKER: == conf-sanity test 802a: simulate readonly device ======= 13:41:14 (1787593274) [13718.018550] Lustre: DEBUG MARKER: SKIP: conf-sanity test_802a ZFS specific test [13780.810383] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 13520 sec ========= 13:42:18 (1787593338) [13782.761536] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:42:20 (1787593340) === [13786.845938] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:42:24 (1787593344) === [13822.878246] Key type lgssc unregistered [13823.112063] LNet: 255866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13823.131885] LNetError: 255866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13823.142228] LNet: Removed LNI 192.168.203.4@tcp [13823.739899] Key type .llcrypt unregistered [13823.742773] Key type ._llcrypt unregistered