[ 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.16.2-1.fc38 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 463648906 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 0x000f5b50-0x000f5b5f] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F5970 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE1BB7 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE1A53 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 001A13 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE1AC7 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE1B57 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE1B8F 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe1a53-0xbffe1ac6] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a52] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe1ac7-0xbffe1b56] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe1b57-0xbffe1b8e] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe1b8f-0xbffe1bb6] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001015] APIC: Switch to symmetric I/O mode setup [ 0.002843] x2apic enabled [ 0.003010] Switched APIC routing to physical x2apic. [ 0.004017] kvm-guest: setup PV IPIs [ 0.007000] ..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.007021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008015] pid_max: default: 32768 minimum: 301 [ 0.009159] LSM: Security Framework initializing [ 0.010081] Yama: becoming mindful. [ 0.011074] SELinux: Initializing. [ 0.012395] *** VALIDATE selinux *** [ 0.021213] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026169] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027208] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028156] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029172] *** VALIDATE tmpfs *** [ 0.031266] *** VALIDATE proc *** [ 0.032330] *** VALIDATE cgroup *** [ 0.033016] *** VALIDATE cgroup2 *** [ 0.034321] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036188] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037018] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039038] Spectre V2 : User space: Vulnerable [ 0.040019] Speculative Store Bypass: Vulnerable [ 0.044663] debug: unmapping init [mem 0xffffffffb7059000-0xffffffffb7060fff] [ 0.046967] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047795] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048036] ... version: 2 [ 0.049017] ... bit width: 48 [ 0.050015] ... generic registers: 4 [ 0.051020] ... value mask: 0000ffffffffffff [ 0.052018] ... max period: 00007fffffffffff [ 0.053020] ... fixed-purpose events: 3 [ 0.054015] ... event mask: 000000070000000f [ 0.056210] rcu: Hierarchical SRCU implementation. [ 0.058762] smp: Bringing up secondary CPUs ... [ 0.059714] x86: Booting SMP configuration: [ 0.060033] .... node #0, CPUs: #1 #2 #3 [ 0.065591] smp: Brought up 1 node, 4 CPUs [ 0.067020] smpboot: Max logical packages: 1 [ 0.068029] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.232162] node 0 deferred pages initialised in 160ms [ 0.237174] devtmpfs: initialized [ 0.238262] x86/mm: Memory block size: 128MB [ 0.239000] gcov: version magic: 0x41383552 [ 0.244033] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.245088] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.247416] pinctrl core: initialized pinctrl subsystem [ 0.248225] [ 0.248748] ************************************************************* [ 0.251019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.253014] ** ** [ 0.255016] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.257013] ** ** [ 0.259017] ** This means that this kernel is built to expose internal ** [ 0.262016] ** IOMMU data structures, which may compromise security on ** [ 0.264017] ** your system. ** [ 0.266015] ** ** [ 0.269017] ** If you see this message and you are not debugging the ** [ 0.271014] ** kernel, report this immediately to your vendor! ** [ 0.273016] ** ** [ 0.275031] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.278017] ************************************************************* [ 0.280922] NET: Registered protocol family 16 [ 0.283481] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.286061] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.288685] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.292476] cpuidle: using governor menu [ 0.295078] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.297489] PCI: Using configuration type 1 for base access [ 0.299122] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.311156] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.312017] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.314037] cryptd: max_cpu_qlen set to 1000 [ 0.315306] ACPI: Added _OSI(Module Device) [ 0.317013] ACPI: Added _OSI(Processor Device) [ 0.319013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.320010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.324451] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.331584] ACPI: Interpreter enabled [ 0.333080] ACPI: PM: (supports S0 S3 S4 S5) [ 0.334016] ACPI: Using IOAPIC for interrupt routing [ 0.336193] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.340462] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.349749] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.352060] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.355036] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.359109] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.364376] acpiphp: Slot [2] registered [ 0.365230] acpiphp: Slot [3] registered [ 0.367108] acpiphp: Slot [4] registered [ 0.369114] acpiphp: Slot [5] registered [ 0.370121] acpiphp: Slot [6] registered [ 0.372158] acpiphp: Slot [7] registered [ 0.374161] acpiphp: Slot [8] registered [ 0.375099] acpiphp: Slot [9] registered [ 0.377126] acpiphp: Slot [10] registered [ 0.379158] acpiphp: Slot [11] registered [ 0.381180] acpiphp: Slot [12] registered [ 0.382178] acpiphp: Slot [13] registered [ 0.384438] acpiphp: Slot [14] registered [ 0.386164] acpiphp: Slot [15] registered [ 0.387116] acpiphp: Slot [16] registered [ 0.388124] acpiphp: Slot [17] registered [ 0.390128] acpiphp: Slot [18] registered [ 0.391153] acpiphp: Slot [19] registered [ 0.393197] acpiphp: Slot [20] registered [ 0.395142] acpiphp: Slot [21] registered [ 0.396113] acpiphp: Slot [22] registered [ 0.398130] acpiphp: Slot [23] registered [ 0.399136] acpiphp: Slot [24] registered [ 0.401156] acpiphp: Slot [25] registered [ 0.403104] acpiphp: Slot [26] registered [ 0.405105] acpiphp: Slot [27] registered [ 0.406105] acpiphp: Slot [28] registered [ 0.408093] acpiphp: Slot [29] registered [ 0.409103] acpiphp: Slot [30] registered [ 0.411132] acpiphp: Slot [31] registered [ 0.412074] PCI host bridge to bus 0000:00 [ 0.414022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.416026] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.418025] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.421030] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.423023] pci_bus 0000:00: root bus resource [mem 0x180000000-0x1ffffffff window] [ 0.425037] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.427200] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.431212] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.435829] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.445020] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.449701] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.453026] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.455021] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.458026] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.460599] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.463760] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.466068] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.469529] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.474013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.484022] pci 0000:00:02.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref] [ 0.492017] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.496644] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.501013] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.506027] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.516018] pci 0000:00:05.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 0.526926] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.532022] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.544024] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.559018] pci 0000:00:06.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref] [ 0.567947] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.571375] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.573343] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.576383] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.578244] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.583232] iommu: Default domain type: Passthrough [ 0.585408] SCSI subsystem initialized [ 0.587155] ACPI: bus type USB registered [ 0.588120] usbcore: registered new interface driver usbfs [ 0.590143] usbcore: registered new interface driver hub [ 0.592097] usbcore: registered new device driver usb [ 0.594134] pps_core: LinuxPPS API ver. 1 registered [ 0.595014] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.598066] PTP clock support registered [ 0.600132] EDAC MC: Ver: 3.0.0 [ 0.602180] PCI: Using ACPI for IRQ routing [ 0.603758] NetLabel: Initializing [ 0.605019] NetLabel: domain hash size = 128 [ 0.607010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.609078] NetLabel: unlabeled traffic allowed by default [ 0.611168] vgaarb: loaded [ 0.613273] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.615016] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.622328] clocksource: Switched to clocksource kvm-clock [ 0.733642] VFS: Disk quotas dquot_6.6.0 [ 0.735093] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.737126] *** VALIDATE ramfs *** [ 0.738388] *** VALIDATE hugetlbfs *** [ 0.740071] pnp: PnP ACPI init [ 0.742303] pnp: PnP ACPI: found 6 devices [ 0.762886] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.766477] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.768821] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.770878] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.773442] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.776084] pci_bus 0000:00: resource 8 [mem 0x180000000-0x1ffffffff window] [ 0.779163] NET: Registered protocol family 2 [ 0.781713] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.786299] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.789771] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.794913] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.798613] TCP: Hash tables configured (established 65536 bind 65536) [ 0.801798] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.804810] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.807700] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.810628] NET: Registered protocol family 1 [ 0.813688] RPC: Registered named UNIX socket transport module. [ 0.816113] RPC: Registered udp transport module. [ 0.817917] RPC: Registered tcp transport module. [ 0.819804] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.822376] NET: Registered protocol family 44 [ 0.824762] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.827153] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.829328] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.831532] PCI: CLS 0 bytes, default 64 [ 0.833838] Unpacking initramfs... [ 2.309371] debug: unmapping init [mem 0xffff88eafcc64000-0xffff88eafffcffff] [ 2.313054] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.315272] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.317972] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.819348] Initialise system trusted keyrings [ 2.820707] Key type blacklist registered [ 2.822486] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.831658] zbud: loaded [ 2.834671] *** VALIDATE nfs *** [ 2.835914] *** VALIDATE nfs4 *** [ 2.837725] pstore: using deflate compression [ 2.841196] Platform Keyring initialized [ 2.951811] NET: Registered protocol family 38 [ 2.953736] Key type asymmetric registered [ 2.955749] Asymmetric key parser 'x509' registered [ 2.957730] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.963572] io scheduler mq-deadline registered [ 2.965109] io scheduler kyber registered [ 2.966730] io scheduler bfq registered [ 2.968531] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.971450] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.974639] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.977368] ACPI: Power Button [PWRF] [ 3.070055] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.160020] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.261378] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.290892] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.326021] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.334687] Non-volatile memory driver v1.3 [ 3.336296] Linux agpgart interface v0.103 [ 3.375397] virtio_blk virtio1: [vda] 133840 512-byte logical blocks (68.5 MB/65.4 MiB) [ 3.379711] vda: detected capacity change from 0 to 68526080 [ 3.396274] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.400174] vdb: detected capacity change from 0 to 1073741824 [ 3.407342] libphy: Fixed MDIO Bus: probed [ 3.413575] usbcore: registered new interface driver usbserial_generic [ 3.416214] usbserial: USB Serial support registered for generic [ 3.418343] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.422857] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.424714] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.427133] mousedev: PS/2 mouse device common for all mice [ 3.429723] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.430253] rtc_cmos 00:05: RTC can wake from S4 [ 3.440200] rtc_cmos 00:05: registered as rtc0 [ 3.442116] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.446459] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.446464] intel_pstate: CPU model not supported [ 3.452915] hid: raw HID events driver (C) Jiri Kosina [ 3.453237] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.454212] usbcore: registered new interface driver usbhid [ 3.459909] usbhid: USB HID core driver [ 3.461412] drop_monitor: Initializing network drop monitor service [ 3.463721] Initializing XFRM netlink socket [ 3.465712] NET: Registered protocol family 10 [ 3.469493] Segment Routing with IPv6 [ 3.471317] NET: Registered protocol family 17 [ 3.473722] mpls_gso: MPLS GSO support [ 3.479854] RAS: Correctable Errors collector initialized. [ 3.481982] AVX version of gcm_enc/dec engaged. [ 3.483634] AES CTR mode by8 optimization enabled [ 3.556737] sched_clock: Marking stable (3556714229, 0)->(4483681493, -926967264) [ 3.560047] registered taskstats version 1 [ 3.561462] Loading compiled-in X.509 certificates [ 3.563594] zswap: loaded using pool lzo/zbud [ 3.586200] Key type big_key registered [ 3.596993] Key type encrypted registered [ 3.598808] ima: No TPM chip found, activating TPM-bypass! [ 3.600977] ima: Allocated hash algorithm: sha1 [ 3.602816] ima: No architecture policies found [ 3.604437] evm: Initialising EVM extended attributes: [ 3.606348] evm: security.selinux [ 3.607663] evm: security.ima [ 3.608692] evm: security.capability [ 3.610045] evm: HMAC attrs: 0x1 [ 3.613492] rtc_cmos 00:05: setting system clock to 2025-11-17 03:40:08 UTC (1763350808) [ 3.619423] debug: unmapping init [mem 0xffffffffb8003000-0xffffffffb81fffff] [ 3.622365] debug: unmapping init [mem 0xffffffffb6d82000-0xffffffffb7058fff] [ 3.635159] Write protecting the kernel read-only data: 28672k [ 3.638314] debug: unmapping init [mem 0xffffffffb5403000-0xffffffffb55fffff] [ 3.641398] debug: unmapping init [mem 0xffffffffb5d14000-0xffffffffb5dfffff] [ 3.672860] 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.680936] systemd[1]: Detected virtualization kvm. [ 3.682729] systemd[1]: Detected architecture x86-64. [ 3.684526] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.710837] systemd[1]: No hostname configured. [ 3.712738] systemd[1]: Set hostname to . [ 3.714763] random: systemd: uninitialized urandom read (16 bytes read) [ 3.717418] systemd[1]: Initializing machine ID from random generator. [ 3.762576] random: ln: uninitialized urandom read (6 bytes read) [ 3.829183] random: systemd: uninitialized urandom read (16 bytes read) [ 3.832352] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.837344] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.840979] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Sockets. Starting Apply Kernel Variables... [ OK ] Reached target Paths. [ OK ] Reached target Timers. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.429450] device-mapper: uevent: version 1.0.3 [ 4.431751] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 5.168642] virtio_net virtio0 ens2: renamed from eth0 [ 5.193216] scsi host0: ata_piix [ 5.198752] scsi host1: ata_piix [ 5.200458] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.203092] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.405208] dracut-initqueue[600]: RTNETLINK answers: File exists [ 10.120479] random: crng init done [ 10.121766] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.406282] 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.582900] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.844567] SELinux: Disabled at runtime. [ 11.909740] 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.921599] systemd[1]: Detected virtualization kvm. [ 11.927272] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.480703] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.485606] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.495894] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.501951] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.504406] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.511757] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.520821] systemd[1]: Reached target rpc_pipefs.target. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-getty.slice. Starting Apply Kernel Variables... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Mounting Kernel Debug File System... [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-sshd\x2dkeygen.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. Starting Create list of required st…ce nodes for the current kernel... Mounting POSIX Message Queue File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Remount Root and Kernel File Systems... [ OK ] Created slice User and Session Slice. [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Huge Pages File System... [ 12.669304] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target Slices. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Journal Service. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. Starting Configure read-only root support... [ OK ] Reached target Swap. 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 /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 13.021165] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.336206] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.363151] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.515304] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.531965] EDAC sbridge: Ver: 1.1.2 [ 14.638481] Key type dns_resolver registered [ 14.962175] NFS: Registering the id_resolver key type [ 14.964211] Key type id_resolver registered [ 14.965710] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started dnf makecache --timer. Starting Restore /run/initramfs on shutdown... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ 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. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg429-client login: [ 29.076032] hrtimer: interrupt took 9019624 ns [ 82.150200] libcfs: loading out-of-tree module taints kernel. [ 82.187225] Key type ._llcrypt registered [ 82.217935] Key type .llcrypt registered [ 82.798467] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 82.809788] alg: No test for adler32 (adler32-zlib) [ 84.379823] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 85.121843] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 86.896177] Key type lgssc registered [ 88.704059] Lustre: Echo OBD driver; http://www.lustre.org/ [ 232.647894] Lustre: Mounted lustre-client [ 236.451492] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 251.353275] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing check_logdir /tmp/testlogs/ [ 254.554689] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing yml_node [ 258.534744] Lustre: lustre-OST0000-osc-ffff88eb49a33800: disconnect after 24s idle [ 258.963171] Lustre: DEBUG MARKER: Client: 2.16.61.41 [ 260.959414] Lustre: DEBUG MARKER: MDS: 2.16.61.41 [ 263.041764] Lustre: DEBUG MARKER: OSS: 2.16.61.41 [ 264.255655] Lustre: DEBUG MARKER: -----============= acceptance-small: sanityn ============----- Sun Nov 16 22:44:28 EST 2025 [ 279.722508] Lustre: DEBUG MARKER: excepting tests: 27 40a [ 281.294345] Lustre: DEBUG MARKER: skipping tests SLOW=no: 33a [ 282.516647] Lustre: DEBUG MARKER: === sanityn: start setup 22:44:46 (1763351086) === [ 283.132552] Lustre: Mounted lustre-client [ 285.967307] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing check_config_client /mnt/lustre [ 303.381894] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 314.141798] Lustre: DEBUG MARKER: === sanityn: finish setup 22:45:17 (1763351117) === [ 316.003276] Lustre: DEBUG MARKER: == sanityn test 0: do_node_vp() and do_facet_vp() do the right thing ========================================================== 22:45:19 (1763351119) [ 322.307622] Lustre: DEBUG MARKER: == sanityn test 1: Check attribute updates on 2 mount points ========================================================== 22:45:26 (1763351126) [ 328.272966] Lustre: DEBUG MARKER: == sanityn test 2a: check cached attribute updates on 2 mtpt's ================================================================== 22:45:31 (1763351131) [ 334.119385] Lustre: DEBUG MARKER: == sanityn test 2b: check cached attribute updates on 2 mtpt's ================================================================== 22:45:37 (1763351137) [ 339.465405] Lustre: DEBUG MARKER: == sanityn test 2c: check cached attribute updates on 2 mtpt's root ============================================================= 22:45:43 (1763351143) [ 344.997893] Lustre: DEBUG MARKER: == sanityn test 2d: check cached attribute updates on 2 mtpt's root ============================================================= 22:45:48 (1763351148) [ 350.375661] Lustre: DEBUG MARKER: == sanityn test 2e: check chmod on root is propagated to others ========================================================== 22:45:54 (1763351154) [ 355.845465] Lustre: DEBUG MARKER: == sanityn test 2f: check attr/owner updates on DNE with 2 mtpt's ========================================================== 22:45:59 (1763351159) [ 361.544284] Lustre: DEBUG MARKER: == sanityn test 2g: check blocks update on sync write ==== 22:46:05 (1763351165) [ 366.661781] Lustre: DEBUG MARKER: == sanityn test 3: symlink on one mtpt, readlink on another ===================================================================== 22:46:10 (1763351170) [ 371.609630] Lustre: DEBUG MARKER: == sanityn test 4: fstat validation on multiple mount points ==================================================================== 22:46:15 (1763351175) [ 377.879383] Lustre: DEBUG MARKER: == sanityn test 5: create a file on one mount, truncate it on the other ========================================================== 22:46:21 (1763351181) [ 382.596451] Lustre: DEBUG MARKER: == sanityn test 6: remove of open file on other node ============================================================================ 22:46:26 (1763351186) [ 387.763860] Lustre: DEBUG MARKER: == sanityn test 7: remove of open directory on other node ======================================================================= 22:46:31 (1763351191) [ 393.334833] Lustre: DEBUG MARKER: == sanityn test 8: remove of open special file on other node ==================================================================== 22:46:37 (1763351197) [ 395.745878] Lustre: lustre-OST0000-osc-ffff88eb52b87800: disconnect after 23s idle [ 395.750586] Lustre: Skipped 1 previous similar message [ 398.671462] Lustre: DEBUG MARKER: == sanityn test 9a: append of file with sub-page size on multiple mounts ========================================================== 22:46:42 (1763351202) [ 405.201184] Lustre: DEBUG MARKER: == sanityn test 9b: append to striped sparse file ======== 22:46:48 (1763351208) [ 410.422383] Lustre: DEBUG MARKER: == sanityn test 10a: write of file with sub-page size on multiple mounts ========================================================== 22:46:54 (1763351214) [ 416.469501] Lustre: DEBUG MARKER: == sanityn test 10b: write of file with sub-page size on multiple mounts ========================================================== 22:47:00 (1763351220) [ 421.374433] Lustre: DEBUG MARKER: == sanityn test 11: execution of file opened for write should return error ============================================================== 22:47:05 (1763351225) [ 426.551561] Lustre: DEBUG MARKER: == sanityn test 12: test lock ordering (link, stat, unlink) ========================================================== 22:47:10 (1763351230) [ 427.050196] Lustre: DEBUG MARKER: start dir: /mnt/lustre/lockdir=144115205289279518 file: /mnt/lustre/lockdir/lockfile=144115205289279517 [ 571.099918] Lustre: DEBUG MARKER: == sanityn test 13: test directory page revocation ======= 22:49:34 (1763351374) [ 577.217912] Lustre: DEBUG MARKER: == sanityn test 14aa: execution of file open for write returns -ETXTBSY ========================================================== 22:49:40 (1763351380) [ 582.226153] Lustre: DEBUG MARKER: == sanityn test 14ab: open(RDWR) of executing file returns -ETXTBSY ========================================================== 22:49:46 (1763351386) [ 587.073764] Lustre: DEBUG MARKER: == sanityn test 14b: truncate of executing file returns -ETXTBSY ================================================================ 22:49:51 (1763351391) [ 592.257691] Lustre: DEBUG MARKER: == sanityn test 14c: open(O_TRUNC) of executing file return -ETXTBSY ============================================================ 22:49:56 (1763351396) [ 597.311483] Lustre: DEBUG MARKER: == sanityn test 14d: chmod of executing file is still possible ================================================================== 22:50:01 (1763351401) [ 598.743897] Lustre: DEBUG MARKER: chmod [ 604.150427] Lustre: DEBUG MARKER: == sanityn test 15: test out-of-space with multiple writers ===================================================================== 22:50:07 (1763351407) [ 1255.723632] Lustre: DEBUG MARKER: == sanityn test 16a: 2500 iterations of dual-mount fsx === 23:00:59 (1763352059) [ 1363.424467] Lustre: lustre-OST0000-osc-ffff88eb52b87800: disconnect after 21s idle [ 1412.907189] Lustre: DEBUG MARKER: == sanityn test 16b: 2500 iterations of dual-mount fsx at small size ========================================================== 23:03:37 (1763352217) [ 1487.136165] Lustre: DEBUG MARKER: == sanityn test 16c: verify data consistency on ldiskfs with cache disabled (b=17397) ========================================================== 23:04:51 (1763352291) [ 1565.616980] Lustre: DEBUG MARKER: == sanityn test 16d: Verify DIO and buffer IO with two clients ========================================================== 23:06:09 (1763352369) [ 1585.869704] Lustre: DEBUG MARKER: == sanityn test 16e: Verify size consistency for O_DIRECT write ========================================================== 23:06:30 (1763352390) [ 1589.688593] Lustre: DEBUG MARKER: == sanityn test 16f: rw sequential consistency vs drop_caches ========================================================== 23:06:33 (1763352393) [ 1590.120755] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.173173] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.205584] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.238533] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.268066] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.301855] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.335510] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.368408] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.413560] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.445838] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.482312] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.516709] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.553188] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.589288] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.626515] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.657403] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.693576] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.736800] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.771359] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.813969] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.846172] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.883953] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.917040] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.955280] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1590.988153] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.020112] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.047928] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.074744] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.111221] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.142232] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.190469] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.221146] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.253770] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.288244] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.319170] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.351183] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.377899] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.410218] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.438549] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.472715] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.506774] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.534919] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.565493] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.594688] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.630731] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.660922] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.696148] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.727277] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.759399] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.797633] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.842819] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.874743] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.916924] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.953289] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1591.983616] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.013377] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.041395] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.073677] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.102396] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.138546] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.167305] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.197296] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.225981] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.260329] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.304184] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.335290] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.365487] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.393773] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.424387] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.451527] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.482781] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.512761] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.543122] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.570456] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.596745] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.624836] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.655247] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.686075] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.714429] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.744363] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.774398] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.802653] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.829875] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.860933] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.889555] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.919290] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.950167] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1592.978925] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.011331] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.042056] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.075076] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.104379] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.133865] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.166990] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.198966] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.224472] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.252942] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.282849] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.315619] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.345612] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.379561] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.410050] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.439964] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.474483] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.506038] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.536926] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.566413] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.599572] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.629097] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.658066] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.687436] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.717127] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.745712] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.782072] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.812676] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.849370] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.882851] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.914907] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.945712] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1593.977061] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.008399] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.044509] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.083731] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.116373] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.145453] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.177085] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.210695] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.242208] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.276288] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.305086] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.336326] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.370834] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.403247] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.437503] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.472892] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.505285] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.537637] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.565400] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.596166] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.633535] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.666305] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.696941] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.731997] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.764820] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.796442] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.827430] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.860468] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.901417] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.938718] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.966475] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1594.998647] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.033914] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.064439] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.096938] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.127895] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.162486] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.197036] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.230970] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.267262] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.299511] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.343152] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.373829] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.406463] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.438698] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.467702] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.500930] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.529178] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.558340] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.591409] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.624775] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.653570] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.680989] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.710721] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.746164] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.776370] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.807818] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.835981] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.867579] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.899859] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.937318] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1595.986761] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.022310] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.055125] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.087073] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.119605] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.155779] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.190356] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.224986] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.258132] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.295124] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.330769] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.364322] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.402670] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.435802] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.478660] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.523192] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.559878] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.593343] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.629377] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.665389] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.702975] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.741079] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.774406] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.807957] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.843327] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.870455] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.900458] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.931654] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1596.967304] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.005863] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.054563] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.095244] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.127476] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.158480] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.194617] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.230707] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.260486] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.292256] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.324119] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.354238] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.384778] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.423158] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.458394] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.491788] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.538533] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.573511] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.617931] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.657747] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.689125] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.723538] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.759876] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.796652] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.831222] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.868603] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.897993] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.926401] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1597.969254] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.003284] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.039315] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.083463] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.130810] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.183964] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.227382] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.274573] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.321591] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.356450] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.391255] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.435416] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.477845] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.516929] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.573172] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.607907] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.649754] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.684672] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.729457] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.774145] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.815269] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.850284] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.893680] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.931248] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.963732] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1598.999460] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.027480] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.068764] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.102352] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.139684] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.177532] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.215579] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.254632] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.287067] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.320473] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.364318] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.401237] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.447265] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.482841] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.517876] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.547349] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.579140] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.619263] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.652741] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.686749] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.718819] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.750730] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.782931] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.815449] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.855777] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.896731] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.928882] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.967356] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1599.997811] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.028106] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.058995] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.098927] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.137494] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.172463] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.214703] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.255657] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.293576] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.337533] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.380354] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.414224] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.452099] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.496716] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.536244] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.577333] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.615137] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.643806] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.676912] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.717310] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.758989] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.799274] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.839903] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.876059] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.913955] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1600.965271] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.016135] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.052844] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.088079] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.121137] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.162576] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.197079] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.233672] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.274288] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.326261] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.370159] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.402113] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.435637] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.468205] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.512926] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.550814] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.596633] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.631604] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.665066] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.695291] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.726987] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.759938] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.797635] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.832658] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.865592] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.903919] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.944575] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1601.984460] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.028413] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.079223] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.128672] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.169336] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.207463] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.242280] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.278488] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.323057] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.366573] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.408158] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.447932] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.482902] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.514091] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.549452] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.592627] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.628994] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.672212] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.715143] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.781516] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.821682] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.871418] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.916380] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1602.964301] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.003841] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.038942] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.092465] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.138482] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.185042] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.219672] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.258277] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.293845] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.336879] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.377873] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.411715] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.459138] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.523922] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.573268] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.624257] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.665409] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.712817] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.762967] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.806811] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.865657] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.909493] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1603.945964] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.006390] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.081714] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.135976] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.180251] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.235842] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.296197] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.341250] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.389357] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.442423] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.493885] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.532715] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.592909] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.663458] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.721037] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.781850] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.835249] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.907836] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1604.968938] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.044790] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.107660] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.167380] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.216943] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.268203] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.323070] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.395485] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.463379] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.507919] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.545856] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.604310] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.667657] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.717829] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.760346] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.821993] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.864975] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.906338] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1605.952501] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.002559] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.052924] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.100507] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.148910] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.204408] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.260739] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.310872] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.381946] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.429178] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.471193] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.541543] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.612974] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.678770] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.724559] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.759633] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.807297] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.858191] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.921290] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1606.964758] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.020108] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.069198] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.118347] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.164507] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.198950] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.244689] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.286798] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.327402] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.378389] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.418854] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.463311] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.506213] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.555709] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.609627] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.663549] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.701198] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.744288] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.785241] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.820254] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.861849] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.909363] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.951104] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1607.997407] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.043954] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.094345] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.130339] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.165861] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.203514] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.251293] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.297307] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.338431] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.378070] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.437490] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.491695] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.529947] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.566408] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.610311] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.654623] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.699881] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.733356] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.770076] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.818592] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.863464] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.906609] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1608.965588] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.028490] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.092185] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.145512] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.179490] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.184332] Lustre: lustre-OST0000-osc-ffff88eb49a33800: disconnect after 22s idle [ 1609.225397] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.266057] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.312737] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.358572] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.399753] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.445879] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.479116] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.514121] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.549631] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.591659] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.641573] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.691258] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1609.732948] rw_seq_cst_vs_d (32403): drop_caches: 3 [ 1613.455545] Lustre: DEBUG MARKER: == sanityn test 16g: mmap rw sequential consistency vs drop_caches ========================================================== 23:06:57 (1763352417) [ 1613.670504] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.004982] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.038979] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.065892] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.106389] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.142028] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.165085] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.190870] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.215365] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.445209] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.476745] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.657424] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.784747] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.812511] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1614.839444] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.200163] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.224342] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.313625] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.350574] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.371676] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.406088] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.431255] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.587934] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.609114] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.645029] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.675074] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.962517] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1615.993900] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.083263] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.116823] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.137409] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.162663] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.186383] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.225434] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.250897] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.277839] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.320457] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.354476] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.389764] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.411291] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.508832] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.662378] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.692092] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.779551] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.882204] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1616.957670] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.221030] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.292369] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.326407] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.477265] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.505064] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.562328] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.593431] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.677581] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.736107] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.763551] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.829926] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.897319] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.924594] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1617.960903] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.045138] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.109875] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.152696] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.193687] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.235513] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.259416] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.339470] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.398732] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.453912] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.481405] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.581272] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.608351] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.732927] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.800661] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.830331] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.859469] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.893223] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.947349] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1618.990043] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.015842] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.106815] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.167305] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.196822] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.251981] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.292758] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.398554] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.471269] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.535911] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.570877] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.673777] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.694982] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.855262] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.882836] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1619.987699] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.037722] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.072263] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.165803] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.319777] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.345405] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.376463] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.635781] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.721658] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.749561] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.781536] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1620.982462] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.158331] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.241678] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.271864] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.584450] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.623278] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.645786] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.885529] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.917208] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.944368] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1621.971501] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.014596] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.037239] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.315707] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.344118] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.368463] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.394854] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.421172] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.450176] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.585064] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.625739] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.645984] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.722887] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.748729] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.842379] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.908343] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.947808] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.974897] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1622.999202] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1623.106773] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1623.338459] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1623.629536] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1623.654329] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1623.939685] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1623.974606] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.117592] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.150981] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.196329] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.236994] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.286264] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.333305] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.397857] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.422081] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.480599] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.603220] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.762449] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.786382] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.813170] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.842382] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.884664] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.911135] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.954942] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1624.977913] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.007381] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.111832] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.261905] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.286535] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.352244] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.428810] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.464564] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.517945] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.547734] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.587311] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.637893] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.942787] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.969710] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1625.997761] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.122633] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.228559] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.263328] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.295940] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.318306] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.349935] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.371633] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.393457] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.422296] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.534520] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.559747] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.598042] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.662480] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.696400] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.750964] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.775168] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1626.883816] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.016217] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.038358] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.075193] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.096916] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.121072] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.183167] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.690528] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.713381] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.749095] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.770448] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.803245] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.828222] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.853651] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.878486] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1627.904559] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.113415] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.137333] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.160880] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.185752] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.209763] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.233681] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.254970] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.276437] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.303781] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.335117] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.354647] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.493740] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.525403] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.546883] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.573594] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.602897] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.625067] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.651298] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.671791] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.743219] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1628.884369] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.059475] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.108225] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.129549] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.157349] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.180323] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.347735] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.553384] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.581729] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.611287] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.639636] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.662585] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1629.664330] Lustre: lustre-OST0001-osc-ffff88eb52b87800: disconnect after 20s idle [ 1629.670182] Lustre: Skipped 1 previous similar message [ 1629.740177] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.057169] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.084838] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.286394] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.318646] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.343345] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.372897] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.433737] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.466411] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.492675] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.522700] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.841566] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.877632] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1630.952664] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.080991] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.107794] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.139198] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.236574] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.340790] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.416529] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.457613] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.501788] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.536376] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1631.564191] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.099676] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.128460] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.247532] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.446230] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.486061] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.513663] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.974706] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1632.997406] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.023763] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.047858] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.234457] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.264321] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.419821] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.449828] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.477208] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1633.513338] rw_seq_cst_vs_d (32989): drop_caches: 3 [ 1637.493764] Lustre: DEBUG MARKER: == sanityn test 16h: mmap read after truncate file ======= 23:07:21 (1763352441) [ 1641.804645] Lustre: DEBUG MARKER: == sanityn test 16i: read after truncate file ============ 23:07:25 (1763352445) [ 1645.661493] Lustre: DEBUG MARKER: == sanityn test 16j: race dio with buffered i/o ========== 23:07:29 (1763352449) [ 1659.753170] Lustre: DEBUG MARKER: == sanityn test 16k: Parallel FSX and drop caches should not panic ========================================================== 23:07:43 (1763352463) [ 1659.963885] bash (35478): drop_caches: 3 [ 1663.051251] bash (35478): drop_caches: 3 [ 1666.118088] bash (35478): drop_caches: 3 [ 1669.266413] bash (35478): drop_caches: 3 [ 1672.430038] bash (35478): drop_caches: 3 [ 1676.277850] Lustre: DEBUG MARKER: == sanityn test 17: resource creation/LVB creation race ========================================================================= 23:08:00 (1763352480) [ 1682.575028] Lustre: DEBUG MARKER: == sanityn test 18: mmap sanity check =========================================================================================== 23:08:06 (1763352486) [ 1696.224210] Lustre: lustre-OST0001-osc-ffff88eb52b87800: disconnect after 20s idle [ 1712.606738] Lustre: DEBUG MARKER: == sanityn test 19: test concurrent uncached read races ========================================================================= 23:08:36 (1763352516) [ 1718.211962] Lustre: DEBUG MARKER: loop 5 [ 1721.019089] Lustre: DEBUG MARKER: loop 10 [ 1723.674535] Lustre: DEBUG MARKER: loop 15 [ 1726.110279] Lustre: DEBUG MARKER: loop 20 [ 1730.172875] Lustre: DEBUG MARKER: == sanityn test 20: test extra readahead page left in cache ============================================================== 23:08:54 (1763352534) [ 1733.465294] Lustre: DEBUG MARKER: == sanityn test 21: Try to remove mountpoint on another dir ============================================================== 23:08:57 (1763352537) [ 1737.453417] Lustre: DEBUG MARKER: == sanityn test 23: others should see updated atime while another read============================================================== 23:09:01 (1763352541) [ 1752.547103] Lustre: lustre-OST0000-osc-ffff88eb49a33800: disconnect after 22s idle [ 1802.695486] Lustre: DEBUG MARKER: == sanityn test 24a: lfs df [-ih] [path] test =================================================================================== 23:10:06 (1763352606) [ 1806.108397] Lustre: DEBUG MARKER: == sanityn test 24b: lfs df should show both filesystems ========================================================================= 23:10:10 (1763352610) [ 1809.344154] Lustre: DEBUG MARKER: == sanityn test 25a: change ACL on one mountpoint be seen on another ============================================================= 23:10:13 (1763352613) [ 1812.724051] Lustre: DEBUG MARKER: == sanityn test 25b: change ACL under remote dir on one mountpoint be seen on another ========================================================== 23:10:16 (1763352616) [ 1816.131225] Lustre: DEBUG MARKER: == sanityn test 26a: allow mtime to get older ============ 23:10:20 (1763352620) [ 1820.023604] Lustre: DEBUG MARKER: == sanityn test 26b: sync mtime between ost and mds ====== 23:10:24 (1763352624) [ 1825.004994] Lustre: DEBUG MARKER: == sanityn test 26c: set-in-past on open file is not lost on close ========================================================== 23:10:29 (1763352629) [ 1829.244793] Lustre: DEBUG MARKER: SKIP: sanityn test_27 skipping excluded test 27 [ 1830.110555] Lustre: DEBUG MARKER: == sanityn test 30: recreate file race =================== 23:10:34 (1763352634) [ 1835.701455] Lustre: DEBUG MARKER: == sanityn test 31a: voluntary cancel / blocking ast race======================================================================== 23:10:39 (1763352639) [ 1835.943543] Lustre: *** cfs_fail_loc=314, val=0*** [ 1836.962835] Lustre: *** cfs_fail_loc=314, val=0*** [ 1836.967544] Lustre: Skipped 2 previous similar messages [ 1840.302974] Lustre: DEBUG MARKER: == sanityn test 31b: voluntary OST cancel / blocking ast race======================================================================== 23:10:44 (1763352644) [ 1846.325087] Lustre: *** cfs_fail_loc=314, val=0*** [ 1849.824344] Lustre: lustre-OST0001-osc-ffff88eb49a33800: disconnect after 23s idle [ 1849.829637] Lustre: Skipped 3 previous similar messages [ 1849.838869] Lustre: lustre-OST0000-osc-ffff88eb52b87800: Connection to lustre-OST0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1849.856525] LustreError: lustre-OST0000-osc-ffff88eb52b87800: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1849.863475] Lustre: lustre-OST0000-osc-ffff88eb52b87800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 1850.353367] Lustre: DEBUG MARKER: == sanityn test 31r: open-rename(replace) race =========== 23:10:54 (1763352654) [ 1850.544918] LustreError: 46960:0:(file.c:761:ll_intent_file_open()) cfs_fail_timeout id 1419 sleeping for 3000ms [ 1853.568141] LustreError: 46960:0:(file.c:761:ll_intent_file_open()) cfs_fail_timeout id 1419 awake [ 1856.796787] Lustre: DEBUG MARKER: == sanityn test 31s: open should not revalidate invalid dentry ========================================================== 23:11:01 (1763352661) [ 1860.679443] Lustre: DEBUG MARKER: == sanityn test 31t: getattr should not revalidate invalid dentry ========================================================== 23:11:04 (1763352664) [ 1864.939021] Lustre: DEBUG MARKER: SKIP: sanityn test_33a skipping SLOW test 33a [ 1865.831443] Lustre: DEBUG MARKER: == sanityn test 33b: COS: cross create/delete, 2 clients, benchmark under remote dir ========================================================== 23:11:09 (1763352669) [ 1866.798987] Lustre: DEBUG MARKER: SKIP: sanityn test_33b Need two or more clients, have 1 [ 1867.677525] Lustre: DEBUG MARKER: == sanityn test 33c: Cancel cross-MDT lock should trigger Sync-on-Lock-Cancel ========================================================== 23:11:11 (1763352671) [ 1870.316931] Lustre: lustre-MDT0000-mdc-ffff88eb49a33800: Connection to lustre-MDT0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1875.434399] LustreError: MGC192.168.204.129@tcp: Connection to MGS (at 192.168.204.129@tcp) was lost; in progress operations using this service will fail [ 1875.448794] Lustre: Evicted from MGS (at 192.168.204.129@tcp) after server handle changed from 0x67c64b76c94e9684 to 0x67c64b76c95abd01 [ 1875.464672] Lustre: MGC192.168.204.129@tcp: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 1879.206236] Lustre: lustre-MDT0000-mdc-ffff88eb49a33800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 1893.285662] Lustre: DEBUG MARKER: == sanityn test 33d: dependent transactions should trigger COS ========================================================== 23:11:37 (1763352697) [ 1916.845832] Lustre: DEBUG MARKER: == sanityn test 33e: independent transactions shouldn't trigger COS ========================================================== 23:12:01 (1763352721) [ 1927.474344] Lustre: DEBUG MARKER: == sanityn test 34: no lock timeout under IO ============= 23:12:11 (1763352731) [ 1977.830787] Lustre: lustre-OST0000-osc-ffff88eb52b87800: Connection to lustre-OST0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1977.845188] Lustre: Skipped 1 previous similar message [ 1977.856186] LustreError: lustre-OST0000-osc-ffff88eb49a33800: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1977.864687] LustreError: lustre-OST0000-osc-ffff88eb52b87800: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1977.865480] Lustre: lustre-OST0000-osc-ffff88eb49a33800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 1977.872818] Lustre: Skipped 2 previous similar messages [ 1992.143563] Lustre: lustre-OST0001-osc-ffff88eb49a33800: Connection to lustre-OST0001 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1992.152121] Lustre: Skipped 1 previous similar message [ 1992.159135] LustreError: lustre-OST0001-osc-ffff88eb49a33800: This client was evicted by lustre-OST0001; in progress operations using this service will fail. [ 1992.165224] Lustre: lustre-OST0001-osc-ffff88eb49a33800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 1998.304365] Lustre: lustre-OST0000-osc-ffff88eb49a33800: disconnect after 21s idle [ 2005.519775] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff88eb49a33800.ost_server_uuid 50 [ 2006.163871] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff88eb49a33800.ost_server_uuid in IDLE state after 0 sec [ 2007.703968] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff88eb49a33800.ost_server_uuid 50 [ 2008.408428] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff88eb49a33800.ost_server_uuid in FULL state after 0 sec [ 2010.662603] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff88eb49a33800.ost_server_uuid 50 [ 2011.397391] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff88eb49a33800.ost_server_uuid in IDLE state after 0 sec [ 2013.435737] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff88eb49a33800.ost_server_uuid 50 [ 2014.210337] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff88eb49a33800.ost_server_uuid in FULL state after 0 sec [ 2019.145558] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff88eb49a33800.ost_server_uuid 50 [ 2019.863372] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff88eb49a33800.ost_server_uuid in IDLE state after 0 sec [ 2021.515201] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff88eb49a33800.ost_server_uuid 50 [ 2022.214853] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff88eb49a33800.ost_server_uuid in IDLE state after 0 sec [ 2023.006086] Lustre: DEBUG MARKER: == sanityn test 35: -EINTR cp_ast vs. bl_ast race does not evict client ========================================================== 23:13:47 (1763352827) [ 2024.442696] Lustre: DEBUG MARKER: Race attempt 0 [ 2026.208666] Lustre: DEBUG MARKER: Wait for 57417 57542 for 60 sec... [ 2089.500442] Lustre: DEBUG MARKER: == sanityn test 36: handle ESTALE/open-unlink correctly == 23:14:53 (1763352893) [ 2095.498880] Lustre: DEBUG MARKER: start test - cycle (0) [ 2115.274590] Lustre: DEBUG MARKER: start test - cycle (1) [ 2134.828278] Lustre: DEBUG MARKER: start test - cycle (2) [ 2150.928352] Lustre: DEBUG MARKER: start test - cycle (3) [ 2171.043825] Lustre: DEBUG MARKER: start test - cycle (4) [ 2186.523497] Lustre: DEBUG MARKER: start test - cycle (5) [ 2206.226368] Lustre: DEBUG MARKER: start test - cycle (6) [ 2222.448366] Lustre: DEBUG MARKER: start test - cycle (7) [ 2241.795085] Lustre: DEBUG MARKER: start test - cycle (8) [ 2257.909904] Lustre: DEBUG MARKER: start test - cycle (9) [ 2273.663087] Lustre: DEBUG MARKER: start test - cycle (10) [ 2297.233292] Lustre: DEBUG MARKER: == sanityn test 37: check i_size is not updated for directory on close (bug 18695) ======================================================================== 23:18:21 (1763353101) [ 2300.384329] Lustre: lustre-OST0000-osc-ffff88eb52b87800: disconnect after 20s idle [ 2300.388224] Lustre: Skipped 2 previous similar messages [ 2336.740777] Lustre: DEBUG MARKER: == sanityn test 39a: file mtime does not change after rename ========================================================== 23:19:00 (1763353140) [ 2339.871217] Lustre: DEBUG MARKER: == sanityn test 39b: file mtime the same on clients with/out lock ========================================================== 23:19:04 (1763353144) [ 2343.969454] Lustre: DEBUG MARKER: == sanityn test 39c: check truncate mtime update ================================================================================ 23:19:08 (1763353148) [ 2348.048182] Lustre: DEBUG MARKER: == sanityn test 39d: sync write should update mtime ====== 23:19:12 (1763353152) [ 2348.229801] Lustre: *** cfs_fail_loc=411, val=0*** [ 2351.061680] Lustre: DEBUG MARKER: SKIP: sanityn test_40a skipping ALWAYS excluded test 40a [ 2351.800767] Lustre: DEBUG MARKER: == sanityn test 40b: pdirops: open|create and others ======================================================================== 23:19:16 (1763353156) [ 2361.546112] Lustre: DEBUG MARKER: == sanityn test 40c: pdirops: link and others ======================================================================== 23:19:25 (1763353165) [ 2370.796276] Lustre: DEBUG MARKER: == sanityn test 40d: pdirops: unlink and others ======================================================================== 23:19:35 (1763353175) [ 2379.472356] Lustre: DEBUG MARKER: == sanityn test 40e: pdirops: rename and others ======================================================================== 23:19:43 (1763353183) [ 2382.304636] Lustre: lustre-OST0000-osc-ffff88eb49a33800: disconnect after 24s idle [ 2382.308212] Lustre: Skipped 1 previous similar message [ 2387.868231] Lustre: DEBUG MARKER: == sanityn test 41a: pdirops: create vs mkdir ======================================================================== 23:19:52 (1763353192) [ 2394.180996] Lustre: DEBUG MARKER: == sanityn test 41b: pdirops: create vs create ======================================================================== 23:19:58 (1763353198) [ 2400.519059] Lustre: DEBUG MARKER: == sanityn test 41c: pdirops: create vs link ======================================================================== 23:20:04 (1763353204) [ 2407.287215] Lustre: DEBUG MARKER: == sanityn test 41d: pdirops: create vs unlink ======================================================================== 23:20:11 (1763353211) [ 2413.747724] Lustre: DEBUG MARKER: == sanityn test 41e: pdirops: create and rename (tgt) ======================================================================== 23:20:18 (1763353218) [ 2420.053416] Lustre: DEBUG MARKER: == sanityn test 41f: pdirops: create and rename (src) ======================================================================== 23:20:24 (1763353224) [ 2426.219416] Lustre: DEBUG MARKER: == sanityn test 41g: pdirops: create vs getattr ======================================================================== 23:20:30 (1763353230) [ 2432.358977] Lustre: DEBUG MARKER: == sanityn test 41h: pdirops: create vs readdir ======================================================================== 23:20:36 (1763353236) [ 2438.588270] Lustre: DEBUG MARKER: == sanityn test 41i: reint_open: create vs create ======== 23:20:42 (1763353242) [ 3058.144209] Lustre: lustre-OST0000-osc-ffff88eb52b87800: disconnect after 21s idle [ 3058.146834] Lustre: Skipped 4 previous similar messages [ 3180.798296] Lustre: DEBUG MARKER: == sanityn test 42a: pdirops: mkdir vs mkdir ======================================================================== 23:33:05 (1763353985) [ 3187.278539] Lustre: DEBUG MARKER: == sanityn test 42b: pdirops: mkdir vs create ======================================================================== 23:33:11 (1763353991) [ 3192.596809] Lustre: DEBUG MARKER: == sanityn test 42c: pdirops: mkdir vs link ======================================================================== 23:33:16 (1763353996) [ 3198.267246] Lustre: DEBUG MARKER: == sanityn test 42d: pdirops: mkdir vs unlink ======================================================================== 23:33:22 (1763354002) [ 3204.078638] Lustre: DEBUG MARKER: == sanityn test 42e: pdirops: mkdir and rename (tgt) ======================================================================== 23:33:28 (1763354008) [ 3209.748446] Lustre: DEBUG MARKER: == sanityn test 42f: pdirops: mkdir and rename (src) ======================================================================== 23:33:34 (1763354014) [ 3215.436418] Lustre: DEBUG MARKER: == sanityn test 42g: pdirops: mkdir vs getattr ======================================================================== 23:33:39 (1763354019) [ 3220.637913] Lustre: DEBUG MARKER: == sanityn test 42h: pdirops: mkdir vs readdir ======================================================================== 23:33:45 (1763354025) [ 3225.492373] Lustre: DEBUG MARKER: == sanityn test 43a: rmdir,mkdir doesn't return -EEXIST ======================================================================== 23:33:49 (1763354029) [ 3249.691282] Lustre: DEBUG MARKER: == sanityn test 43b: pdirops: unlink vs create ======================================================================== 23:34:14 (1763354054) [ 3254.746580] Lustre: DEBUG MARKER: == sanityn test 43c: pdirops: unlink vs link ======================================================================== 23:34:19 (1763354059) [ 3260.002245] Lustre: DEBUG MARKER: == sanityn test 43d: pdirops: unlink vs unlink ======================================================================== 23:34:24 (1763354064) [ 3264.890311] Lustre: DEBUG MARKER: == sanityn test 43e: pdirops: unlink and rename (tgt) ======================================================================== 23:34:29 (1763354069) [ 3269.941692] Lustre: DEBUG MARKER: == sanityn test 43f: pdirops: unlink and rename (src) ======================================================================== 23:34:34 (1763354074) [ 3275.049108] Lustre: DEBUG MARKER: == sanityn test 43g: pdirops: unlink vs getattr ======================================================================== 23:34:39 (1763354079) [ 3280.379472] Lustre: DEBUG MARKER: == sanityn test 43h: pdirops: unlink vs readdir ======================================================================== 23:34:44 (1763354084) [ 3286.008223] Lustre: DEBUG MARKER: == sanityn test 43i: pdirops: unlink vs remote mkdir ===== 23:34:50 (1763354090) [ 3291.244478] Lustre: DEBUG MARKER: == sanityn test 43j: racy mkdir return EEXIST ======================================================================== 23:34:55 (1763354095) [ 3331.119425] Lustre: DEBUG MARKER: == sanityn test 43k: unlink vs create ==================== 23:35:35 (1763354135) [ 3370.464217] Lustre: lustre-OST0001-osc-ffff88eb49a33800: disconnect after 22s idle [ 3370.467408] Lustre: Skipped 5 previous similar messages [ 3758.871696] Lustre: DEBUG MARKER: == sanityn test 44a: pdirops: rename tgt vs mkdir ======================================================================== 23:42:43 (1763354563) [ 3763.773804] Lustre: DEBUG MARKER: == sanityn test 44b: pdirops: rename tgt vs create ======================================================================== 23:42:48 (1763354568) [ 3768.758705] Lustre: DEBUG MARKER: == sanityn test 44c: pdirops: rename tgt vs link ======================================================================== 23:42:53 (1763354573) [ 3773.806215] Lustre: DEBUG MARKER: == sanityn test 44d: pdirops: rename tgt vs unlink ======================================================================== 23:42:58 (1763354578) [ 3778.796325] Lustre: DEBUG MARKER: == sanityn test 44e: pdirops: rename tgt and rename (tgt) ======================================================================== 23:43:03 (1763354583) [ 3783.935779] Lustre: DEBUG MARKER: == sanityn test 44f: pdirops: rename tgt and rename (src) ======================================================================== 23:43:08 (1763354588) [ 3788.961516] Lustre: DEBUG MARKER: == sanityn test 44g: pdirops: rename tgt vs getattr ======================================================================== 23:43:13 (1763354593) [ 3793.904785] Lustre: DEBUG MARKER: == sanityn test 44h: pdirops: rename tgt vs readdir ======================================================================== 23:43:18 (1763354598) [ 3798.815447] Lustre: DEBUG MARKER: == sanityn test 44i: pdirops: rename tgt vs remote mkdir ========================================================== 23:43:23 (1763354603) [ 3803.932498] Lustre: DEBUG MARKER: == sanityn test 45a: rename,mkdir doesn't return -EEXIST ======================================================================== 23:43:28 (1763354608) [ 3844.028944] Lustre: DEBUG MARKER: == sanityn test 45b: pdirops: rename src vs create ======================================================================== 23:44:08 (1763354648) [ 3849.130917] Lustre: DEBUG MARKER: == sanityn test 45c: pdirops: rename src vs link ======================================================================== 23:44:13 (1763354653) [ 3854.530824] Lustre: DEBUG MARKER: == sanityn test 45d: pdirops: rename src vs unlink ======================================================================== 23:44:18 (1763354658) [ 3859.868899] Lustre: DEBUG MARKER: == sanityn test 45e: pdirops: rename src and rename (tgt) ======================================================================== 23:44:24 (1763354664) [ 3864.882713] Lustre: DEBUG MARKER: == sanityn test 45f: pdirops: rename src and rename (src) ======================================================================== 23:44:29 (1763354669) [ 3869.844859] Lustre: DEBUG MARKER: == sanityn test 45g: pdirops: rename src vs getattr ======================================================================== 23:44:34 (1763354674) [ 3874.909303] Lustre: DEBUG MARKER: == sanityn test 45h: pdirops: unlink vs readdir ======================================================================== 23:44:39 (1763354679) [ 3879.431945] Lustre: DEBUG MARKER: == sanityn test 45i: pdirops: rename src vs remote mkdir ========================================================== 23:44:43 (1763354683) [ 3884.454252] Lustre: DEBUG MARKER: == sanityn test 45j: read vs rename ====================== 23:44:48 (1763354688) [ 4138.464397] Lustre: lustre-OST0000-osc-ffff88eb49a33800: disconnect after 22s idle [ 4138.467540] Lustre: Skipped 2 previous similar messages [ 4323.490626] Lustre: DEBUG MARKER: == sanityn test 46a: pdirops: link vs mkdir ======================================================================== 23:52:07 (1763355127) [ 4328.759716] Lustre: DEBUG MARKER: == sanityn test 46b: pdirops: link vs create ======================================================================== 23:52:13 (1763355133) [ 4333.992081] Lustre: DEBUG MARKER: == sanityn test 46c: pdirops: link vs link ======================================================================== 23:52:18 (1763355138) [ 4339.259234] Lustre: DEBUG MARKER: == sanityn test 46d: pdirops: link vs unlink ======================================================================== 23:52:23 (1763355143) [ 4344.654679] Lustre: DEBUG MARKER: == sanityn test 46e: pdirops: link and rename (tgt) ======================================================================== 23:52:29 (1763355149) [ 4350.008470] Lustre: DEBUG MARKER: == sanityn test 46f: pdirops: link and rename (src) ======================================================================== 23:52:34 (1763355154) [ 4355.327043] Lustre: DEBUG MARKER: == sanityn test 46g: pdirops: link vs getattr ======================================================================== 23:52:39 (1763355159) [ 4360.554447] Lustre: DEBUG MARKER: == sanityn test 46h: pdirops: link vs readdir ======================================================================== 23:52:44 (1763355164) [ 4366.036621] Lustre: DEBUG MARKER: == sanityn test 46i: pdirops: link vs remote mkdir ======= 23:52:50 (1763355170) [ 4371.307737] Lustre: DEBUG MARKER: == sanityn test 47a: pdirops: remote mkdir vs mkdir ====== 23:52:55 (1763355175) [ 4376.305131] Lustre: DEBUG MARKER: == sanityn test 47b: pdirops: remote mkdir vs create ===== 23:53:00 (1763355180) [ 4382.575149] Lustre: DEBUG MARKER: == sanityn test 47c: pdirops: remote mkdir vs link ======= 23:53:06 (1763355186) [ 4387.822265] Lustre: DEBUG MARKER: == sanityn test 47d: pdirops: remote mkdir vs unlink ===== 23:53:12 (1763355192) [ 4393.143605] Lustre: DEBUG MARKER: == sanityn test 47e: pdirops: remote mkdir and rename (tgt) ========================================================== 23:53:17 (1763355197) [ 4398.358569] Lustre: DEBUG MARKER: == sanityn test 47f: pdirops: remote mkdir and rename (src) ========================================================== 23:53:22 (1763355202) [ 4403.574936] Lustre: DEBUG MARKER: == sanityn test 47g: pdirops: remote mkdir vs getattr ==== 23:53:27 (1763355207) [ 4409.561774] Lustre: DEBUG MARKER: == sanityn test 50: osc lvb attrs: enqueue vs. CP AST ======================================================================== 23:53:34 (1763355214) [ 4409.642716] LustreError: 6171:0:(ldlm_lockd.c:2078:ldlm_handle_cp_callback()) cfs_fail_timeout id 410 sleeping for 2000ms [ 4411.728092] LustreError: 6171:0:(ldlm_lockd.c:2078:ldlm_handle_cp_callback()) cfs_fail_timeout id 410 awake [ 4416.970977] Lustre: DEBUG MARKER: == sanityn test 51a: layout lock: refresh layout should work ========================================================== 23:53:41 (1763355221) [ 4421.177839] Lustre: DEBUG MARKER: == sanityn test 51b: layout lock: glimpse should be able to restart if layout changed ========================================================== 23:53:45 (1763355225) [ 4421.271818] LustreError: 238707:0:(glimpse.c:206:cl_glimpse_size0()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 4425.328087] LustreError: 238707:0:(glimpse.c:206:cl_glimpse_size0()) cfs_fail_timeout id 1404 awake [ 4425.334361] LustreError: 238707:0:(glimpse.c:206:cl_glimpse_size0()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 4429.392157] LustreError: 238707:0:(glimpse.c:206:cl_glimpse_size0()) cfs_fail_timeout id 1404 awake [ 4429.407349] LustreError: 238713:0:(glimpse.c:206:cl_glimpse_size0()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 4433.464094] LustreError: 238713:0:(glimpse.c:206:cl_glimpse_size0()) cfs_fail_timeout id 1404 awake [ 4435.745260] Lustre: DEBUG MARKER: == sanityn test 51c: layout lock: IT_LAYOUT blocked and correct layout can be returned ========================================================== 23:54:00 (1763355240) [ 4442.446153] Lustre: DEBUG MARKER: == sanityn test 51d: layout lock: losing layout lock should clean up memory map region ========================================================== 23:54:06 (1763355246) [ 4445.628987] Lustre: DEBUG MARKER: == sanityn test 51e: lfs getstripe does not break leases, part 2 ========================================================== 23:54:10 (1763355250) [ 4449.798396] Lustre: DEBUG MARKER: == sanityn test 54: rename locking ======================= 23:54:14 (1763355254) [ 4474.173450] Lustre: DEBUG MARKER: == sanityn test 55a: rename vs unlink target dir ========= 23:54:38 (1763355278) [ 4481.797804] Lustre: DEBUG MARKER: == sanityn test 55b: rename vs unlink source dir ========= 23:54:46 (1763355286) [ 4489.372909] Lustre: DEBUG MARKER: == sanityn test 55c: rename vs unlink orphan target dir == 23:54:53 (1763355293) [ 4502.346651] Lustre: DEBUG MARKER: == sanityn test 55d: rename file vs link ================= 23:55:06 (1763355306) [ 4511.930963] Lustre: DEBUG MARKER: == sanityn test 55e: rename race AB/BA under the same parent dir ========================================================== 23:55:16 (1763355316) [ 4524.892676] Lustre: DEBUG MARKER: == sanityn test 55f: rename: (P1/A -> P2/B) race with (P2/B -> P1/A) ========================================================== 23:55:29 (1763355329) [ 4537.901818] Lustre: DEBUG MARKER: == sanityn test 55g: rename: race with trylock =========== 23:55:42 (1763355342) [ 4552.187558] Lustre: DEBUG MARKER: == sanityn test 56a: test llverdev with single large stripe ========================================================== 23:55:56 (1763355356) [ 4559.491904] Lustre: DEBUG MARKER: == sanityn test 56b: test llverdev and partial verify of wide stripe file ========================================================== 23:56:03 (1763355363) [ 4590.550644] Lustre: DEBUG MARKER: == sanityn test 60: Verify data_version behaviour ======== 23:56:34 (1763355394) [ 4592.967390] Lustre: DEBUG MARKER: == sanityn test 70a: cd directory [ 4596.090979] Lustre: DEBUG MARKER: == sanityn test 70b: remove files after calling rm_entry ========================================================== 23:56:40 (1763355400) [ 4598.615328] Lustre: DEBUG MARKER: == sanityn test 71a: correct file map just after write operation is finished ========================================================== 23:56:43 (1763355403) [ 4600.991552] Lustre: DEBUG MARKER: == sanityn test 71b: check fiemap support for stripecount > 1 ========================================================== 23:56:45 (1763355405) [ 4603.223313] Lustre: DEBUG MARKER: == sanityn test 71c: check FIEMAP_EXTENT_LAST flag with different extents number ========================================================== 23:56:47 (1763355407) [ 4613.831310] Lustre: DEBUG MARKER: == sanityn test 71d: fiemap corruption test with fm_extent_count=0 ========================================================== 23:56:58 (1763355418) [ 4627.502188] Lustre: DEBUG MARKER: == sanityn test 72: getxattr/setxattr cache should be consistent between nodes ========================================================== 23:57:11 (1763355431) [ 4629.542888] Lustre: DEBUG MARKER: == sanityn test 73: getxattr should not cause xattr lock cancellation ========================================================== 23:57:13 (1763355433) [ 4631.719183] Lustre: DEBUG MARKER: == sanityn test 74: flock deadlock: different mounts ======================================================================== 23:57:16 (1763355436) [ 4634.789488] LustreError: lustre-MDT0000-mdc-ffff88eb52b87800: operation ldlm_enqueue to node 192.168.204.129@tcp failed: rc = -35 [ 4634.791944] LustreError: Skipped 1 previous similar message [ 4637.701858] Lustre: DEBUG MARKER: == sanityn test 75: osc: upcall after unuse lock============================================================================= 23:57:22 (1763355442) [ 4637.830547] LustreError: 2417:0:(osc_request.c:3093:osc_enqueue_interpret()) cfs_fail_timeout id 31d sleeping for 2000ms [ 4639.912147] LustreError: 2417:0:(osc_request.c:3093:osc_enqueue_interpret()) cfs_fail_timeout id 31d awake [ 4644.817162] Lustre: DEBUG MARKER: == sanityn test 76: Verify MDT open_files listing ======== 23:57:29 (1763355449) [ 4691.006345] Lustre: DEBUG MARKER: == sanityn test 77a: check FIFO NRS policy =============== 23:58:15 (1763355495) [ 4694.052208] Lustre: DEBUG MARKER: == sanityn test 77b: check CRR-N NRS policy ============== 23:58:18 (1763355498) [ 4698.369611] Lustre: DEBUG MARKER: == sanityn test 77c: check ORR NRS policy ================ 23:58:22 (1763355502) [ 4703.800832] Lustre: DEBUG MARKER: == sanityn test 77d: check TRR nrs policy ================ 23:58:28 (1763355508) [ 4709.292405] Lustre: DEBUG MARKER: == sanityn test 77e: check TBF NID nrs policy ============ 23:58:33 (1763355513) [ 4717.046853] Lustre: DEBUG MARKER: == sanityn test 77f: check TBF JobID nrs policy ========== 23:58:41 (1763355521) [ 4725.049484] Lustre: DEBUG MARKER: == sanityn test 77g: Change TBF type directly ============ 23:58:49 (1763355529) [ 4728.570737] Lustre: DEBUG MARKER: == sanityn test 77h: Wrong policy name should report error, not LBUG ========================================================== 23:58:52 (1763355532) [ 4732.391844] Lustre: DEBUG MARKER: == sanityn test 77i: Change rank of TBF rule ============= 23:58:56 (1763355536) [ 4739.769273] Lustre: DEBUG MARKER: == sanityn test 77j: check TBF-OPCode NRS policy ========= 23:59:04 (1763355544) [ 4768.224168] Lustre: lustre-OST0001-osc-ffff88eb49a33800: disconnect after 23s idle [ 4768.226279] Lustre: Skipped 5 previous similar messages [ 4781.434707] Lustre: DEBUG MARKER: == sanityn test 77ja: check TBF-UID/GID NRS policy ======= 23:59:45 (1763355585) [ 4894.130765] Lustre: DEBUG MARKER: == sanityn test 77jb: check TBF-UID/GID NRS policy on files that don't belong to us ========================================================== 00:01:38 (1763355698) [ 5006.691776] Lustre: DEBUG MARKER: == sanityn test 77k: check TBF policy with UID/GID/JobID/OPCode expression ========================================================== 00:03:31 (1763355811) [ 5273.881332] Lustre: DEBUG MARKER: == sanityn test 77kb: Check different granular TBF type combination: jobid+opcode ========================================================== 00:07:58 (1763356078) [ 5301.196136] Lustre: DEBUG MARKER: == sanityn test 77kc: Check different granular TBF type combination: nid+opcode ========================================================== 00:08:25 (1763356105) [ 5328.287961] Lustre: DEBUG MARKER: == sanityn test 77kd: Check different granular TBF type combination: nid+jobid ========================================================== 00:08:52 (1763356132) [ 5346.342511] Lustre: DEBUG MARKER: == sanityn test 77ke: Check different granular TBF type combination: jobid+opcode ========================================================== 00:09:10 (1763356150) [ 5372.384179] Lustre: lustre-OST0001-osc-ffff88eb49a33800: disconnect after 20s idle [ 5372.386792] Lustre: Skipped 9 previous similar messages [ 5403.525556] Lustre: DEBUG MARKER: == sanityn test 77kf: Check different granular TBF type combination: uid+gid ========================================================== 00:10:07 (1763356207) [ 5456.772396] Lustre: DEBUG MARKER: == sanityn test 77kg: check different granular TBF type combination: uid+opcode ========================================================== 00:11:01 (1763356261) [ 5546.311088] Lustre: DEBUG MARKER: == sanityn test 77kh: Verify that Project ID support for NRS TBF rule ========================================================== 00:12:30 (1763356350) [ 5547.316266] LustreError: 285463:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb49a33800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5547.319430] LustreError: 285463:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 5547.337368] Lustre: Unmounted lustre-client [ 5547.954597] LustreError: 285477:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb52b87800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5547.957794] LustreError: 285477:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 5547.961847] LustreError: 285477:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 5547.963689] LustreError: 285477:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5547.980515] Lustre: Unmounted lustre-client [ 5611.813581] Lustre: Mounted lustre-client [ 5613.323120] Lustre: Mounted lustre-client [ 5614.381789] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 5671.143734] Lustre: DEBUG MARKER: == sanityn test 77ki: Add rule with unsupported TBF type should fail for generic TBF ========================================================== 00:14:35 (1763356475) [ 5679.623531] Lustre: DEBUG MARKER: == sanityn test 77l: check the output of NRS policies for generic TBF ========================================================== 00:14:44 (1763356484) [ 5683.544634] Lustre: DEBUG MARKER: == sanityn test 77m: check NRS Delay slows write RPC processing ========================================================== 00:14:47 (1763356487) [ 5733.939417] Lustre: DEBUG MARKER: == sanityn test 77n: check wildcard support for TBF JobID NRS policy ========================================================== 00:15:38 (1763356538) [ 5781.759152] Lustre: DEBUG MARKER: == sanityn test 77o: Changing rank should not panic ====== 00:16:26 (1763356586) [ 5785.598966] Lustre: DEBUG MARKER: == sanityn test 77q: Parallel TBF rule definitions should not panic ========================================================== 00:16:30 (1763356590) [ 5824.472366] Lustre: DEBUG MARKER: == sanityn test 77p: Check validity of rule names for TBF policies ========================================================== 00:17:08 (1763356628) [ 5836.135139] Lustre: DEBUG MARKER: == sanityn test 77r: Change type of tbf policy at run time ========================================================== 00:17:20 (1763356640) [ 5878.407688] Lustre: DEBUG MARKER: == sanityn test 78: Enable policy and specify tunings right away ========================================================== 00:18:02 (1763356682) [ 5881.530849] Lustre: DEBUG MARKER: == sanityn test 79: xattr: intent error ================== 00:18:05 (1763356685) [ 5894.242747] Lustre: DEBUG MARKER: == sanityn test 80a: migrate directory when some children is being opened ========================================================== 00:18:18 (1763356698) [ 5897.801134] Lustre: DEBUG MARKER: == sanityn test 80b: Accessing directory during migration ========================================================== 00:18:22 (1763356702) [ 5898.088161] LustreError: 307171:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x449:0x0]: rc = -5 [ 5898.091554] LustreError: 307171:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5898.644855] LustreError: 307213:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x459:0x0]: rc = -5 [ 5898.648676] LustreError: 307213:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 6 previous similar messages [ 5898.651941] LustreError: 307213:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5898.655550] LustreError: 307213:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 6 previous similar messages [ 5899.688425] LustreError: 307297:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x477:0x0]: rc = -5 [ 5899.691787] LustreError: 307297:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 15 previous similar messages [ 5899.694544] LustreError: 307297:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5899.696748] LustreError: 307297:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 15 previous similar messages [ 5901.689077] LustreError: 307463:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x77:0x0]: rc = -5 [ 5901.692335] LustreError: 307463:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 31 previous similar messages [ 5901.698885] LustreError: 307009:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5901.702172] LustreError: 307009:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 32 previous similar messages [ 5905.730182] LustreError: 307826:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x107:0x0]: rc = -5 [ 5905.734747] LustreError: 307826:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 73 previous similar messages [ 5905.738191] LustreError: 307826:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5905.741528] LustreError: 307826:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 72 previous similar messages [ 5913.806215] LustreError: 308474:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x1eb:0x0]: rc = -5 [ 5913.809409] LustreError: 308474:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 188 previous similar messages [ 5913.811412] LustreError: 308474:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5913.813162] LustreError: 308474:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 188 previous similar messages [ 5928.305202] LustreError: 309708:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff88eb434df800: inode [0x2000013a1:0x768:0x0] mdc close failed: rc = -2 [ 5929.819808] LustreError: 309837:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x797:0x0]: rc = -5 [ 5929.826067] LustreError: 309837:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 392 previous similar messages [ 5929.829420] LustreError: 309837:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5929.831765] LustreError: 309837:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 392 previous similar messages [ 5937.028465] LustreError: 310496:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff88eb434df800: inode [0x2000013a1:0x848:0x0] mdc close failed: rc = -2 [ 6043.299085] LustreError: 307009:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x8ef:0x0]: rc = -5 [ 6043.303731] LustreError: 307009:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 333 previous similar messages [ 6043.304792] LustreError: lustre-MDT0000-mdc-ffff88eb6016e000: operation mds_getattr_lock to node 192.168.204.129@tcp failed: rc = -107 [ 6043.307562] LustreError: 307009:0:(llite_lib.c:3781:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 6043.309741] Lustre: lustre-MDT0000-mdc-ffff88eb6016e000: Connection to lustre-MDT0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6043.311091] LustreError: lustre-MDT0000-mdc-ffff88eb6016e000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6043.313170] LustreError: 307009:0:(llite_lib.c:3781:ll_prep_inode()) Skipped 333 previous similar messages [ 6043.319288] LustreError: 311011:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff88eb6016e000: inode [0x2000013a1:0x43f:0x0] mdc close failed: rc = -108 [ 6043.339271] LustreError: 311014:0:(file.c:6099:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 6043.353357] Lustre: lustre-MDT0000-mdc-ffff88eb6016e000: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 6045.395318] Lustre: DEBUG MARKER: == sanityn test 81a: rename and stat under striped directory ========================================================== 00:20:49 (1763356849) [ 6047.500483] Lustre: DEBUG MARKER: == sanityn test 81b: rename under striped directory doesn't deadlock ========================================================== 00:20:51 (1763356851) [ 6099.913793] Lustre: DEBUG MARKER: == sanityn test 81c: rename revoke LOOKUP lock for remote object ========================================================== 00:21:44 (1763356904) [ 6100.352114] Lustre: DEBUG MARKER: SKIP: sanityn test_81c needs >= 4 MDTs [ 6100.909431] Lustre: DEBUG MARKER: == sanityn test 81d: parallel rename file cross-dir on same MDT ========================================================== 00:21:45 (1763356905) [ 6145.108182] Lustre: DEBUG MARKER: == sanityn test 82: fsetxattr and fgetxattr on orphan files ========================================================== 00:22:29 (1763356949) [ 6147.624738] Lustre: DEBUG MARKER: == sanityn test 83: access striped directory while it is being created/unlinked ========================================================== 00:22:31 (1763356951) [ 6269.805674] Lustre: DEBUG MARKER: == sanityn test 84: 0-nlink race in lu_object_find() ===== 00:24:34 (1763357074) [ 6277.117306] Lustre: DEBUG MARKER: == sanityn test 85: Lustre API root cache race =========== 00:24:41 (1763357081) [ 6279.762421] Lustre: DEBUG MARKER: == sanityn test 90: open/create and unlink striped directory ========================================================== 00:24:44 (1763357084) [ 6462.903214] Lustre: DEBUG MARKER: == sanityn test 91: chmod and unlink striped directory === 00:27:47 (1763357267) [ 6555.617158] Lustre: lustre-OST0000-osc-ffff88eb6016e000: disconnect after 21s idle [ 6555.619338] Lustre: Skipped 8 previous similar messages [ 6645.732638] Lustre: DEBUG MARKER: == sanityn test 92: create remote directory under orphan directory ========================================================== 00:30:50 (1763357450) [ 6647.680674] Lustre: DEBUG MARKER: == sanityn test 93: alloc_rr should not allocate on same ost ========================================================== 00:30:52 (1763357452) [ 6656.238530] Lustre: DEBUG MARKER: == sanityn test 94: signal vs CP callback race =========== 00:31:00 (1763357460) [ 6656.287236] Lustre: DEBUG MARKER: write [ 6656.305781] LustreError: 291863:0:(ldlm_request.c:1402:ldlm_cli_cancel_req()) cfs_fail_timeout id 312 sleeping for 5000ms [ 6658.312106] Lustre: DEBUG MARKER: kill 369214 [ 6658.313689] LustreError: 369214:0:(ldlm_request.c:1287:ldlm_cli_cancel_local()) cfs_fail_timeout id 329 sleeping for 6000ms [ 6661.408083] LustreError: 291863:0:(ldlm_request.c:1402:ldlm_cli_cancel_req()) cfs_fail_timeout id 312 awake [ 6664.344114] LustreError: 369214:0:(ldlm_request.c:1287:ldlm_cli_cancel_local()) cfs_fail_timeout id 329 awake [ 6666.324417] Lustre: DEBUG MARKER: == sanityn test 95a: Check readpage() on a page that was removed from page cache ========================================================== 00:31:10 (1763357470) [ 6668.476281] LustreError: 369828:0:(rw.c:1968:ll_readpage()) cfs_fail_timeout id 1422 sleeping for 10000ms [ 6678.568156] LustreError: 369828:0:(rw.c:1968:ll_readpage()) cfs_fail_timeout id 1422 awake [ 6680.667986] Lustre: DEBUG MARKER: == sanityn test 95b: Check readpage() on a page that is no longer uptodate ========================================================== 00:31:25 (1763357485) [ 6680.752054] LustreError: 370416:0:(rw.c:2213:ll_readpage()) cfs_fail_timeout id 1424 sleeping for 5000ms [ 6682.832071] LustreError: 370416:0:(rw.c:2213:ll_readpage()) cfs_fail_timeout interrupted [ 6689.252461] Lustre: DEBUG MARKER: == sanityn test 100a: DoM: glimpse RPCs for stat without IO lock (DoM only file) ========================================================== 00:31:33 (1763357493) [ 6689.953940] Lustre: DEBUG MARKER: SKIP: sanityn test_100a Reserved for glimpse-ahead [ 6690.454781] Lustre: DEBUG MARKER: == sanityn test 100b: DoM: no glimpse RPC for stat with IO lock (DoM only file) ========================================================== 00:31:34 (1763357494) [ 6692.729147] Lustre: DEBUG MARKER: == sanityn test 100c: DoM: write vs stat without IO lock (combined file) ========================================================== 00:31:37 (1763357497) [ 6694.690743] Lustre: DEBUG MARKER: == sanityn test 100d: DoM: write+truncate vs stat without IO lock (combined file) ========================================================== 00:31:39 (1763357499) [ 6696.811522] Lustre: DEBUG MARKER: == sanityn test 100e: DoM: read on open and file size ==== 00:31:41 (1763357501) [ 6698.820569] Lustre: DEBUG MARKER: == sanityn test 101a: Discard DoM data on unlink ========= 00:31:43 (1763357503) [ 6700.929657] Lustre: DEBUG MARKER: == sanityn test 101b: Discard DoM data on rename ========= 00:31:45 (1763357505) [ 6703.001326] Lustre: DEBUG MARKER: == sanityn test 101c: Discard DoM data on close-unlink === 00:31:47 (1763357507) [ 6706.044072] Lustre: DEBUG MARKER: == sanityn test 102: Test open by handle of unlinked file ========================================================== 00:31:50 (1763357510) [ 6708.726040] Lustre: DEBUG MARKER: == sanityn test 103: Test size correctness with lockahead ========================================================== 00:31:53 (1763357513) [ 6709.394322] Lustre: *** cfs_fail_loc=415, val=0*** [ 6715.927124] Lustre: DEBUG MARKER: == sanityn test 104: Verify that MDS stores atime/mtime/ctime during close ========================================================== 00:32:00 (1763357520) [ 6734.852230] Lustre: DEBUG MARKER: == sanityn test 105: Glimpse and lock cancel race ======== 00:32:19 (1763357539) [ 6734.940208] LustreError: 287880:0:(osc_lock.c:407:osc_dlm_blocking_ast0()) cfs_fail_timeout id 416 sleeping for 5000ms [ 6734.942425] LustreError: 287880:0:(osc_lock.c:407:osc_dlm_blocking_ast0()) Skipped 3 previous similar messages [ 6740.040070] LustreError: 287188:0:(osc_lock.c:407:osc_dlm_blocking_ast0()) cfs_fail_timeout id 416 awake [ 6740.042207] LustreError: 287188:0:(osc_lock.c:407:osc_dlm_blocking_ast0()) Skipped 3 previous similar messages [ 6750.232046] LustreError: 287880:0:(osc_lock.c:407:osc_dlm_blocking_ast0()) cfs_fail_timeout id 416 awake [ 6750.233853] LustreError: 287880:0:(osc_lock.c:407:osc_dlm_blocking_ast0()) Skipped 3 previous similar messages [ 6757.318420] Lustre: DEBUG MARKER: == sanityn test 106a: Verify the btime via statx() ======= 00:32:41 (1763357561) [ 6759.528419] Lustre: DEBUG MARKER: == sanityn test 106b: Glimpse RPCs test for statx ======== 00:32:44 (1763357564) [ 6761.626653] Lustre: DEBUG MARKER: == sanityn test 106c: Verify statx attributes mask ======= 00:32:46 (1763357566) [ 6763.549449] Lustre: DEBUG MARKER: == sanityn test 107a: Basic grouplock conflict =========== 00:32:48 (1763357568) [ 6767.538180] Lustre: DEBUG MARKER: == sanityn test 107b: Grouplock is added to the head of waiting list ========================================================== 00:32:52 (1763357572) [ 6775.636090] Lustre: DEBUG MARKER: == sanityn test 108a: lseek: parallel updates ============ 00:33:00 (1763357580) [ 6775.763751] LustreError: 381149:0:(osc_request.c:2944:osc_build_rpc()) cfs_fail_timeout id 414 sleeping for 4000ms [ 6775.765819] LustreError: 381149:0:(osc_request.c:2944:osc_build_rpc()) Skipped 6 previous similar messages [ 6779.824073] LustreError: 381149:0:(osc_request.c:2944:osc_build_rpc()) cfs_fail_timeout id 414 awake [ 6779.825938] LustreError: 381149:0:(osc_request.c:2944:osc_build_rpc()) Skipped 2 previous similar messages [ 6781.831100] Lustre: DEBUG MARKER: == sanityn test 109: Race with several mount instances on 1 node ========================================================== 00:33:06 (1763357586) [ 6782.835745] LustreError: 381858:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6016e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6782.840410] LustreError: 381858:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 6782.847966] LustreError: 381858:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6782.849494] LustreError: 381858:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6782.868078] Lustre: Unmounted lustre-client [ 6783.764281] Lustre: DEBUG MARKER: Iteration 1 [ 6783.863122] LustreError: 382041:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6783.863227] LustreError: 382042:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6783.866858] LustreError: 382041:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6783.917554] Lustre: Mounted lustre-client [ 6784.370502] LustreError: 382155:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb60a7f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6784.373508] LustreError: 382155:0:(lov_obd.c:783:lov_cleanup()) Skipped 5 previous similar messages [ 6784.375933] LustreError: 382154:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 6784.377487] LustreError: 382154:0:(obd_class.h:479:obd_check_dev()) Skipped 19 previous similar messages [ 6784.408078] Lustre: Unmounted lustre-client [ 6784.408910] Lustre: Skipped 1 previous similar message [ 6785.247673] Key type lgssc unregistered [ 6785.359322] LNet: 382397:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6785.361168] LNetError: 382397:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6785.371775] LNet: Removed LNI 192.168.204.29@tcp [ 6785.648111] Key type .llcrypt unregistered [ 6785.648993] Key type ._llcrypt unregistered [ 6785.969970] Key type ._llcrypt registered [ 6785.970875] Key type .llcrypt registered [ 6786.139738] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6786.144139] alg: No test for adler32 (adler32-zlib) [ 6787.100392] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6787.351568] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6788.960153] Key type lgssc registered [ 6789.443623] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6793.491888] Lustre: DEBUG MARKER: Iteration 2 [ 6793.606816] LustreError: 383225:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6793.606883] LustreError: 383226:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6793.610318] LustreError: 383225:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6794.670234] Lustre: Mounted lustre-client [ 6795.081041] LustreError: 383340:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb51f70000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6795.084718] LustreError: 383340:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6795.087198] LustreError: 383341:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6795.088865] LustreError: 383341:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6795.123180] Lustre: Unmounted lustre-client [ 6795.124107] Lustre: Skipped 1 previous similar message [ 6795.920615] Key type lgssc unregistered [ 6796.020419] LNet: 383583:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6796.022260] LNetError: 383583:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6796.030642] LNet: Removed LNI 192.168.204.29@tcp [ 6796.226093] Key type .llcrypt unregistered [ 6796.226976] Key type ._llcrypt unregistered [ 6796.449799] Key type ._llcrypt registered [ 6796.450744] Key type .llcrypt registered [ 6796.624742] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6796.630971] alg: No test for adler32 (adler32-zlib) [ 6797.470081] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6797.541680] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6799.120091] Key type lgssc registered [ 6799.433577] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6802.627964] Lustre: DEBUG MARKER: Iteration 3 [ 6802.722126] LustreError: 384411:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6802.722973] LustreError: 384412:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6802.726136] LustreError: 384411:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6803.777823] Lustre: Mounted lustre-client [ 6803.778688] Lustre: Skipped 1 previous similar message [ 6804.220752] LustreError: 384524:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6804.222738] LustreError: 384523:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6804.223502] LustreError: 384524:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6804.270590] Lustre: Unmounted lustre-client [ 6805.119728] Key type lgssc unregistered [ 6805.225292] LNet: 384767:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6805.227162] LNetError: 384767:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6805.238752] LNet: Removed LNI 192.168.204.29@tcp [ 6805.445118] Key type .llcrypt unregistered [ 6805.445987] Key type ._llcrypt unregistered [ 6805.647258] Key type ._llcrypt registered [ 6805.648157] Key type .llcrypt registered [ 6805.849825] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6805.855285] alg: No test for adler32 (adler32-zlib) [ 6806.697861] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6806.775267] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6808.352151] Key type lgssc registered [ 6808.679636] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6811.891262] Lustre: DEBUG MARKER: Iteration 4 [ 6811.984149] LustreError: 385594:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6811.984189] LustreError: 385595:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6811.987622] LustreError: 385594:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6813.048379] Lustre: Mounted lustre-client [ 6813.049293] Lustre: Skipped 1 previous similar message [ 6813.457815] LustreError: 385709:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497e9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6813.462769] LustreError: 385709:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 6813.464715] LustreError: 385709:0:(obd_class.h:479:obd_check_dev()) Skipped 4 previous similar messages [ 6813.491069] Lustre: Unmounted lustre-client [ 6814.346604] Key type lgssc unregistered [ 6814.456505] LNet: 385950:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6814.458543] LNetError: 385950:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6814.466742] LNet: Removed LNI 192.168.204.29@tcp [ 6814.665109] Key type .llcrypt unregistered [ 6814.665992] Key type ._llcrypt unregistered [ 6814.930430] Key type ._llcrypt registered [ 6814.932520] Key type .llcrypt registered [ 6815.107299] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6815.111582] alg: No test for adler32 (adler32-zlib) [ 6815.951485] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6816.036100] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6817.624155] Key type lgssc registered [ 6818.004499] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6821.695132] Lustre: DEBUG MARKER: Iteration 5 [ 6821.782507] LustreError: 386778:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6821.782580] LustreError: 386779:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6821.786418] LustreError: 386778:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6822.843234] Lustre: Mounted lustre-client [ 6822.844173] Lustre: Skipped 1 previous similar message [ 6823.256119] LustreError: 386889:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6ec9c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6823.258455] LustreError: 386890:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6823.259313] LustreError: 386889:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6823.327108] Lustre: Unmounted lustre-client [ 6824.131592] Key type lgssc unregistered [ 6824.232508] LNet: 387132:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6824.235223] LNetError: 387132:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6824.244679] LNet: Removed LNI 192.168.204.29@tcp [ 6824.452089] Key type .llcrypt unregistered [ 6824.452967] Key type ._llcrypt unregistered [ 6824.642399] Key type ._llcrypt registered [ 6824.643225] Key type .llcrypt registered [ 6824.855194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6824.859500] alg: No test for adler32 (adler32-zlib) [ 6825.699907] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6825.771315] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6827.344111] Key type lgssc registered [ 6827.687549] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6830.761143] Lustre: DEBUG MARKER: Iteration 6 [ 6830.860467] LustreError: 387960:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6830.860539] LustreError: 387961:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6830.864045] LustreError: 387960:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6831.910965] Lustre: Mounted lustre-client [ 6831.912438] Lustre: Skipped 1 previous similar message [ 6832.341747] LustreError: 388071:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb523e1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6832.343461] LustreError: 388070:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6832.344458] LustreError: 388071:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6832.399086] Lustre: Unmounted lustre-client [ 6833.268854] Key type lgssc unregistered [ 6833.374484] LNet: 388313:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6833.376374] LNetError: 388313:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6833.384677] LNet: Removed LNI 192.168.204.29@tcp [ 6833.583095] Key type .llcrypt unregistered [ 6833.584039] Key type ._llcrypt unregistered [ 6833.803436] Key type ._llcrypt registered [ 6833.804317] Key type .llcrypt registered [ 6833.979650] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6833.984448] alg: No test for adler32 (adler32-zlib) [ 6834.828781] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6834.902276] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6836.480099] Key type lgssc registered [ 6836.787159] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6839.795375] Lustre: DEBUG MARKER: Iteration 7 [ 6839.887479] LustreError: 389142:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6839.887515] LustreError: 389143:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6839.891063] LustreError: 389142:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6840.945657] Lustre: Mounted lustre-client [ 6841.376550] LustreError: 389254:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb51f70000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6841.380606] LustreError: 389254:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6841.416195] Lustre: Unmounted lustre-client [ 6842.223326] Key type lgssc unregistered [ 6842.328305] LNet: 389495:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6842.330200] LNetError: 389495:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6842.340603] LNet: Removed LNI 192.168.204.29@tcp [ 6842.553092] Key type .llcrypt unregistered [ 6842.553985] Key type ._llcrypt unregistered [ 6842.806884] Key type ._llcrypt registered [ 6842.807813] Key type .llcrypt registered [ 6842.983817] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6842.988412] alg: No test for adler32 (adler32-zlib) [ 6843.832210] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6843.908667] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6845.488098] Key type lgssc registered [ 6845.802208] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6848.741772] Lustre: DEBUG MARKER: Iteration 8 [ 6848.835263] LustreError: 390323:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6848.836061] LustreError: 390324:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6848.838735] LustreError: 390323:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6849.891708] Lustre: Mounted lustre-client [ 6850.332940] LustreError: 390435:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6132d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6850.336536] LustreError: 390435:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6850.336702] LustreError: 390436:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6850.439047] Lustre: Unmounted lustre-client [ 6850.439901] Lustre: Skipped 1 previous similar message [ 6851.245872] Key type lgssc unregistered [ 6851.352457] LNet: 390677:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6851.354378] LNetError: 390677:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6851.361420] LNet: Removed LNI 192.168.204.29@tcp [ 6851.560093] Key type .llcrypt unregistered [ 6851.561036] Key type ._llcrypt unregistered [ 6851.746953] Key type ._llcrypt registered [ 6851.747962] Key type .llcrypt registered [ 6851.963416] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6851.967572] alg: No test for adler32 (adler32-zlib) [ 6852.808556] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6852.879983] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6854.456112] Key type lgssc registered [ 6854.772588] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6857.987531] Lustre: DEBUG MARKER: Iteration 9 [ 6858.080399] LustreError: 391505:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6858.082335] LustreError: 391506:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6858.084094] LustreError: 391505:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6859.129630] Lustre: Mounted lustre-client [ 6859.130631] Lustre: Skipped 1 previous similar message [ 6859.551538] LustreError: 391620:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb5001e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6859.553169] LustreError: 391621:0:(obd_class.h:479:obd_check_dev()) Device 9 not setup [ 6859.554381] LustreError: 391620:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6859.586099] Lustre: Unmounted lustre-client [ 6860.426478] Key type lgssc unregistered [ 6860.537484] LNet: 391863:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6860.539632] LNetError: 391863:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6860.547769] LNet: Removed LNI 192.168.204.29@tcp [ 6860.760097] Key type .llcrypt unregistered [ 6860.761037] Key type ._llcrypt unregistered [ 6861.001434] Key type ._llcrypt registered [ 6861.002445] Key type .llcrypt registered [ 6861.183878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6861.188569] alg: No test for adler32 (adler32-zlib) [ 6862.031652] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6862.106278] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6863.680179] Key type lgssc registered [ 6864.002848] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6867.142575] Lustre: DEBUG MARKER: Iteration 10 [ 6867.238309] LustreError: 392691:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6867.238353] LustreError: 392692:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6867.241835] LustreError: 392691:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6868.310575] Lustre: Mounted lustre-client [ 6868.311429] Lustre: Skipped 1 previous similar message [ 6868.720507] LustreError: 392806:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb435f2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6868.723153] LustreError: 392805:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 6868.724156] LustreError: 392806:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6868.755070] Lustre: Unmounted lustre-client [ 6869.591056] Key type lgssc unregistered [ 6869.704406] LNet: 393048:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6869.706732] LNetError: 393048:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6869.712732] LNet: Removed LNI 192.168.204.29@tcp [ 6869.907087] Key type .llcrypt unregistered [ 6869.908053] Key type ._llcrypt unregistered [ 6870.124896] Key type ._llcrypt registered [ 6870.129722] Key type .llcrypt registered [ 6870.302857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6870.308398] alg: No test for adler32 (adler32-zlib) [ 6871.161552] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6871.250494] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6872.840147] Key type lgssc registered [ 6873.177197] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6876.268504] Lustre: DEBUG MARKER: Iteration 11 [ 6876.363992] LustreError: 393876:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6876.364048] LustreError: 393877:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6876.368401] LustreError: 393876:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6877.421442] Lustre: Mounted lustre-client [ 6877.850236] LustreError: 393989:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb53300800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6877.855556] LustreError: 393989:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6877.856090] LustreError: 393990:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 6877.861984] LustreError: 393990:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6877.919065] Lustre: Unmounted lustre-client [ 6878.770053] Key type lgssc unregistered [ 6878.892565] LNet: 394232:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6878.895473] LNetError: 394232:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6878.905291] LNet: Removed LNI 192.168.204.29@tcp [ 6879.264149] Key type .llcrypt unregistered [ 6879.266445] Key type ._llcrypt unregistered [ 6879.595785] Key type ._llcrypt registered [ 6879.597319] Key type .llcrypt registered [ 6879.822687] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6879.827554] alg: No test for adler32 (adler32-zlib) [ 6880.683889] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6880.762606] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6882.344151] Key type lgssc registered [ 6882.740043] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6886.040781] Lustre: DEBUG MARKER: Iteration 12 [ 6886.151772] LustreError: 395061:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6886.152171] LustreError: 395062:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6886.155483] LustreError: 395061:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6887.229429] Lustre: Mounted lustre-client [ 6887.769790] LustreError: 395175:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb531fb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6887.772835] LustreError: 395175:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6887.773284] LustreError: 395176:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6887.776541] LustreError: 395176:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6887.816829] Lustre: Unmounted lustre-client [ 6888.754280] Key type lgssc unregistered [ 6888.869660] LNet: 395416:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6888.871675] LNetError: 395416:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6888.878452] LNet: Removed LNI 192.168.204.29@tcp [ 6889.095116] Key type .llcrypt unregistered [ 6889.096176] Key type ._llcrypt unregistered [ 6889.295448] Key type ._llcrypt registered [ 6889.297419] Key type .llcrypt registered [ 6889.486456] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6889.505378] alg: No test for adler32 (adler32-zlib) [ 6890.349976] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6890.430174] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6892.009083] Key type lgssc registered [ 6892.341747] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6895.467670] Lustre: DEBUG MARKER: Iteration 13 [ 6895.565711] LustreError: 396243:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6895.565741] LustreError: 396244:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6895.570040] LustreError: 396243:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 6896.621792] Lustre: Mounted lustre-client [ 6896.622797] Lustre: Skipped 1 previous similar message [ 6897.047559] LustreError: 396357:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb435f6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6897.049557] LustreError: 396358:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6897.050951] LustreError: 396357:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6897.056359] LustreError: 396358:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6897.090937] Lustre: Unmounted lustre-client [ 6897.898225] Key type lgssc unregistered [ 6898.000531] LNet: 396602:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6898.002455] LNetError: 396602:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6898.010874] LNet: Removed LNI 192.168.204.29@tcp [ 6898.209094] Key type .llcrypt unregistered [ 6898.210381] Key type ._llcrypt unregistered [ 6898.425102] Key type ._llcrypt registered [ 6898.426650] Key type .llcrypt registered [ 6898.623386] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6898.627793] alg: No test for adler32 (adler32-zlib) [ 6899.471445] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6899.546936] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6901.128126] Key type lgssc registered [ 6901.460651] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6904.843917] Lustre: DEBUG MARKER: Iteration 14 [ 6904.945394] LustreError: 397431:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6904.946090] LustreError: 397432:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6904.949769] LustreError: 397431:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6906.003591] Lustre: Mounted lustre-client [ 6906.417841] LustreError: 397544:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb60057000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6906.420511] LustreError: 397544:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6906.423952] LustreError: 397545:0:(obd_class.h:479:obd_check_dev()) Device 9 not setup [ 6906.425887] LustreError: 397545:0:(obd_class.h:479:obd_check_dev()) Skipped 4 previous similar messages [ 6906.458086] Lustre: Unmounted lustre-client [ 6907.267428] Key type lgssc unregistered [ 6907.370490] LNet: 397786:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6907.372559] LNetError: 397786:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6907.383663] LNet: Removed LNI 192.168.204.29@tcp [ 6907.586096] Key type .llcrypt unregistered [ 6907.586968] Key type ._llcrypt unregistered [ 6907.947663] Key type ._llcrypt registered [ 6907.948586] Key type .llcrypt registered [ 6908.042677] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6908.047075] alg: No test for adler32 (adler32-zlib) [ 6908.889605] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6908.964092] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6910.536130] Key type lgssc registered [ 6910.864347] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6913.896215] Lustre: DEBUG MARKER: Iteration 15 [ 6913.994966] LustreError: 398614:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6913.995069] LustreError: 398615:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6913.998694] LustreError: 398614:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6915.051524] Lustre: Mounted lustre-client [ 6915.483174] LustreError: 398727:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6915.485849] LustreError: 398728:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 6915.486225] LustreError: 398727:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6915.518631] Lustre: Unmounted lustre-client [ 6916.353730] Key type lgssc unregistered [ 6916.468369] LNet: 398970:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6916.470330] LNetError: 398970:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6916.481741] LNet: Removed LNI 192.168.204.29@tcp [ 6916.677106] Key type .llcrypt unregistered [ 6916.677980] Key type ._llcrypt unregistered [ 6916.930467] Key type ._llcrypt registered [ 6916.931567] Key type .llcrypt registered [ 6917.101608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6917.106032] alg: No test for adler32 (adler32-zlib) [ 6917.948107] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6918.022602] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6919.600146] Key type lgssc registered [ 6919.931310] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6923.021139] Lustre: DEBUG MARKER: Iteration 16 [ 6923.111666] LustreError: 399798:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6923.111879] LustreError: 399799:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6923.116984] LustreError: 399798:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6924.173351] Lustre: Mounted lustre-client [ 6924.581196] LustreError: 399915:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497e9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6924.582806] LustreError: 399914:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6924.584043] LustreError: 399915:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6924.587561] LustreError: 399914:0:(obd_class.h:479:obd_check_dev()) Skipped 4 previous similar messages [ 6924.641873] Lustre: Unmounted lustre-client [ 6925.437887] Key type lgssc unregistered [ 6925.543504] LNet: 400156:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6925.545330] LNetError: 400156:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6925.554706] LNet: Removed LNI 192.168.204.29@tcp [ 6925.768085] Key type .llcrypt unregistered [ 6925.768951] Key type ._llcrypt unregistered [ 6925.966558] Key type ._llcrypt registered [ 6925.972055] Key type .llcrypt registered [ 6926.158739] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6926.164582] alg: No test for adler32 (adler32-zlib) [ 6927.006821] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6927.082803] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6928.672100] Key type lgssc registered [ 6928.988533] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6932.057578] Lustre: DEBUG MARKER: Iteration 17 [ 6932.155080] LustreError: 400984:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6932.155118] LustreError: 400985:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6932.158539] LustreError: 400984:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6933.204154] Lustre: Mounted lustre-client [ 6933.629187] LustreError: 401097:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb7e45d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6933.630955] LustreError: 401096:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6933.632408] LustreError: 401097:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6933.636560] LustreError: 401096:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6933.662985] Lustre: Unmounted lustre-client [ 6934.486781] Key type lgssc unregistered [ 6934.596531] LNet: 401340:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6934.598505] LNetError: 401340:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6934.609700] LNet: Removed LNI 192.168.204.29@tcp [ 6934.852188] Key type .llcrypt unregistered [ 6934.854048] Key type ._llcrypt unregistered [ 6935.092765] Key type ._llcrypt registered [ 6935.093827] Key type .llcrypt registered [ 6935.324963] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6935.329601] alg: No test for adler32 (adler32-zlib) [ 6936.191665] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6936.287105] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6937.872153] Key type lgssc registered [ 6938.357122] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6941.630853] Lustre: DEBUG MARKER: Iteration 18 [ 6941.738205] LustreError: 402169:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6941.738267] LustreError: 402170:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6941.742023] LustreError: 402169:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6942.800540] Lustre: Mounted lustre-client [ 6943.222533] LustreError: 402284:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497ee800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6943.224195] LustreError: 402283:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6943.224951] LustreError: 402284:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6943.288394] Lustre: Unmounted lustre-client [ 6944.097715] Key type lgssc unregistered [ 6944.208419] LNet: 402526:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6944.210343] LNetError: 402526:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6944.217800] LNet: Removed LNI 192.168.204.29@tcp [ 6944.434095] Key type .llcrypt unregistered [ 6944.435115] Key type ._llcrypt unregistered [ 6944.648798] Key type ._llcrypt registered [ 6944.649914] Key type .llcrypt registered [ 6944.854592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6944.858874] alg: No test for adler32 (adler32-zlib) [ 6945.719025] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6945.803728] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6947.384137] Key type lgssc registered [ 6947.942553] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6952.133196] Lustre: DEBUG MARKER: Iteration 19 [ 6952.281470] LustreError: 403354:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6952.282634] LustreError: 403355:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6952.285900] LustreError: 403354:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6953.345371] Lustre: Mounted lustre-client [ 6953.760729] LustreError: 403470:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb50b7d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6953.762559] LustreError: 403469:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6953.763661] LustreError: 403470:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6953.805097] Lustre: Unmounted lustre-client [ 6954.900131] Key type lgssc unregistered [ 6955.009430] LNet: 403710:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6955.012417] LNetError: 403710:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6955.020724] LNet: Removed LNI 192.168.204.29@tcp [ 6955.330177] Key type .llcrypt unregistered [ 6955.332738] Key type ._llcrypt unregistered [ 6955.561431] Key type ._llcrypt registered [ 6955.562324] Key type .llcrypt registered [ 6955.748731] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6955.757535] alg: No test for adler32 (adler32-zlib) [ 6956.610203] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6956.685419] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6958.264114] Key type lgssc registered [ 6958.591745] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6961.645110] Lustre: DEBUG MARKER: Iteration 20 [ 6961.738082] LustreError: 404537:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6961.738121] LustreError: 404538:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6961.741875] LustreError: 404537:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 6962.799993] Lustre: Mounted lustre-client [ 6963.231914] LustreError: 404652:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6132a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6963.237077] LustreError: 404652:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6963.239529] LustreError: 404652:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6963.268060] Lustre: Unmounted lustre-client [ 6964.082434] Key type lgssc unregistered [ 6964.190427] LNet: 404896:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6964.192580] LNetError: 404896:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6964.201657] LNet: Removed LNI 192.168.204.29@tcp [ 6964.404093] Key type .llcrypt unregistered [ 6964.405065] Key type ._llcrypt unregistered [ 6964.646918] Key type ._llcrypt registered [ 6964.648165] Key type .llcrypt registered [ 6964.824082] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6964.828769] alg: No test for adler32 (adler32-zlib) [ 6965.672211] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6965.744886] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6967.320113] Key type lgssc registered [ 6967.637070] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6970.634555] Lustre: DEBUG MARKER: Iteration 21 [ 6970.728162] LustreError: 405724:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6970.728187] LustreError: 405725:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6970.732555] LustreError: 405724:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6971.792177] Lustre: Mounted lustre-client [ 6971.793138] Lustre: Skipped 1 previous similar message [ 6972.226880] LustreError: 405839:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb5001e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6972.230245] LustreError: 405839:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 6972.232727] LustreError: 405838:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6972.234586] LustreError: 405838:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6972.290105] Lustre: Unmounted lustre-client [ 6973.211314] Key type lgssc unregistered [ 6973.317493] LNet: 406081:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6973.320250] LNetError: 406081:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6973.326748] LNet: Removed LNI 192.168.204.29@tcp [ 6973.540122] Key type .llcrypt unregistered [ 6973.542338] Key type ._llcrypt unregistered [ 6973.803643] Key type ._llcrypt registered [ 6973.809524] Key type .llcrypt registered [ 6973.987493] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6973.992362] alg: No test for adler32 (adler32-zlib) [ 6974.845651] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6974.924394] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6976.504153] Key type lgssc registered [ 6976.876635] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6980.802846] Lustre: DEBUG MARKER: Iteration 22 [ 6980.932154] LustreError: 406910:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6980.933129] LustreError: 406911:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6980.949904] LustreError: 406910:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 6982.009608] Lustre: Mounted lustre-client [ 6982.528829] LustreError: 407018:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6132f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6982.536639] LustreError: 407018:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 6982.540372] LustreError: 407018:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 6982.577289] Lustre: Unmounted lustre-client [ 6983.737066] Key type lgssc unregistered [ 6983.873684] LNet: 407264:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6983.877570] LNetError: 407264:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6983.887657] LNet: Removed LNI 192.168.204.29@tcp [ 6984.172117] Key type .llcrypt unregistered [ 6984.174127] Key type ._llcrypt unregistered [ 6984.586216] Key type ._llcrypt registered [ 6984.592734] Key type .llcrypt registered [ 6984.688911] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6984.696449] alg: No test for adler32 (adler32-zlib) [ 6985.609087] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6985.716393] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6987.312275] Key type lgssc registered [ 6987.979355] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6992.892531] Lustre: DEBUG MARKER: Iteration 23 [ 6993.047525] LustreError: 408094:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 6993.048160] LustreError: 408095:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 6993.055117] LustreError: 408094:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4996 [ 6994.158443] Lustre: Mounted lustre-client [ 6994.871644] LustreError: 408196:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6994.882721] LustreError: 408196:0:(obd_class.h:479:obd_check_dev()) Device 9 not setup [ 6994.921886] Lustre: Unmounted lustre-client [ 6996.259819] Key type lgssc unregistered [ 6996.401527] LNet: 408447:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6996.425187] LNetError: 408447:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6996.436559] LNet: Removed LNI 192.168.204.29@tcp [ 6996.791245] Key type .llcrypt unregistered [ 6996.792795] Key type ._llcrypt unregistered [ 6997.055376] Key type ._llcrypt registered [ 6997.058270] Key type .llcrypt registered [ 6997.310700] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6997.319274] alg: No test for adler32 (adler32-zlib) [ 6998.240360] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 6998.360178] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 6999.976160] Key type lgssc registered [ 7000.692346] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7005.308756] Lustre: DEBUG MARKER: Iteration 24 [ 7005.402411] LustreError: 409276:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7005.403390] LustreError: 409277:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7005.406688] LustreError: 409276:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7006.461275] Lustre: Mounted lustre-client [ 7006.462908] Lustre: Skipped 1 previous similar message [ 7006.853040] LustreError: 409390:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb60051800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7006.854966] LustreError: 409391:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7006.856521] LustreError: 409390:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7006.911079] Lustre: Unmounted lustre-client [ 7007.764038] Key type lgssc unregistered [ 7007.873459] LNet: 409633:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7007.875790] LNetError: 409633:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7007.883607] LNet: Removed LNI 192.168.204.29@tcp [ 7008.097092] Key type .llcrypt unregistered [ 7008.097919] Key type ._llcrypt unregistered [ 7008.344891] Key type ._llcrypt registered [ 7008.346637] Key type .llcrypt registered [ 7008.512557] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7008.517350] alg: No test for adler32 (adler32-zlib) [ 7009.357202] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7009.426892] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7011.016110] Key type lgssc registered [ 7011.429580] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7014.968776] Lustre: DEBUG MARKER: Iteration 25 [ 7015.073082] LustreError: 410461:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7015.076817] LustreError: 410463:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7015.078746] LustreError: 410461:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 7016.137035] Lustre: Mounted lustre-client [ 7016.601227] LustreError: 410575:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb435f6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7016.603885] LustreError: 410574:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7016.604966] LustreError: 410575:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7016.636051] Lustre: Unmounted lustre-client [ 7017.625265] Key type lgssc unregistered [ 7017.741376] LNet: 410817:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7017.745041] LNetError: 410817:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7017.752698] LNet: Removed LNI 192.168.204.29@tcp [ 7017.989098] Key type .llcrypt unregistered [ 7017.990304] Key type ._llcrypt unregistered [ 7018.261340] Key type ._llcrypt registered [ 7018.262222] Key type .llcrypt registered [ 7018.451359] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7018.456614] alg: No test for adler32 (adler32-zlib) [ 7019.316664] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7019.404570] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7020.992184] Key type lgssc registered [ 7021.367800] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7025.124948] Lustre: DEBUG MARKER: Iteration 26 [ 7025.217206] LustreError: 411647:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7025.217846] LustreError: 411648:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7025.220817] LustreError: 411647:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7026.278197] Lustre: Mounted lustre-client [ 7026.279711] Lustre: Skipped 1 previous similar message [ 7026.741085] LustreError: 411761:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb49360000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7026.744113] LustreError: 411761:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7026.748347] LustreError: 411763:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7026.750366] LustreError: 411763:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 7026.796621] Lustre: Unmounted lustre-client [ 7027.701899] Key type lgssc unregistered [ 7027.817585] LNet: 412005:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7027.819831] LNetError: 412005:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7027.832705] LNet: Removed LNI 192.168.204.29@tcp [ 7028.077118] Key type .llcrypt unregistered [ 7028.078631] Key type ._llcrypt unregistered [ 7028.372288] Key type ._llcrypt registered [ 7028.373381] Key type .llcrypt registered [ 7028.552046] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7028.556643] alg: No test for adler32 (adler32-zlib) [ 7029.410750] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7029.501066] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7031.080151] Key type lgssc registered [ 7031.470052] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7035.099453] Lustre: DEBUG MARKER: Iteration 27 [ 7035.197601] LustreError: 412833:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7035.197633] LustreError: 412834:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7035.202572] LustreError: 412833:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7036.256889] Lustre: Mounted lustre-client [ 7036.258241] Lustre: Skipped 1 previous similar message [ 7036.722523] LustreError: 412947:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7036.728295] LustreError: 412947:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7036.771140] Lustre: Unmounted lustre-client [ 7037.738801] Key type lgssc unregistered [ 7037.869483] LNet: 413190:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7037.871513] LNetError: 413190:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7037.877639] LNet: Removed LNI 192.168.204.29@tcp [ 7038.103100] Key type .llcrypt unregistered [ 7038.104347] Key type ._llcrypt unregistered [ 7038.351611] Key type ._llcrypt registered [ 7038.353359] Key type .llcrypt registered [ 7038.575882] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7038.580553] alg: No test for adler32 (adler32-zlib) [ 7039.450189] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7039.540399] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7041.128164] Key type lgssc registered [ 7041.515091] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7045.267033] Lustre: DEBUG MARKER: Iteration 28 [ 7045.377604] LustreError: 414018:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7045.377651] LustreError: 414019:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7045.385389] LustreError: 414018:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4995 [ 7046.443878] Lustre: Mounted lustre-client [ 7046.445534] Lustre: Skipped 1 previous similar message [ 7046.951324] LustreError: 414133:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb7fd22800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7046.955130] LustreError: 414133:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7046.955205] LustreError: 414134:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7047.030933] Lustre: Unmounted lustre-client [ 7048.035401] Key type lgssc unregistered [ 7048.168549] LNet: 414375:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7048.171213] LNetError: 414375:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7048.177808] LNet: Removed LNI 192.168.204.29@tcp [ 7048.429100] Key type .llcrypt unregistered [ 7048.430711] Key type ._llcrypt unregistered [ 7048.740123] Key type ._llcrypt registered [ 7048.741353] Key type .llcrypt registered [ 7048.956255] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7048.961782] alg: No test for adler32 (adler32-zlib) [ 7049.833679] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7049.922445] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7051.504137] Key type lgssc registered [ 7051.910639] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7055.521551] Lustre: DEBUG MARKER: Iteration 29 [ 7055.630950] LustreError: 415204:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7055.632102] LustreError: 415205:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7055.636793] LustreError: 415204:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4996 [ 7056.694060] Lustre: Mounted lustre-client [ 7056.695072] Lustre: Skipped 1 previous similar message [ 7057.182714] LustreError: 415320:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb43221000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7057.185522] LustreError: 415321:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7057.186320] LustreError: 415320:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7057.236496] Lustre: Unmounted lustre-client [ 7057.237580] Lustre: Skipped 1 previous similar message [ 7058.236508] Key type lgssc unregistered [ 7058.347542] LNet: 415562:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7058.349757] LNetError: 415562:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7058.356659] LNet: Removed LNI 192.168.204.29@tcp [ 7058.614093] Key type .llcrypt unregistered [ 7058.614959] Key type ._llcrypt unregistered [ 7058.927233] Key type ._llcrypt registered [ 7058.930919] Key type .llcrypt registered [ 7059.123698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7059.128696] alg: No test for adler32 (adler32-zlib) [ 7059.996639] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7060.086241] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7061.672172] Key type lgssc registered [ 7062.079034] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7065.860692] Lustre: DEBUG MARKER: Iteration 30 [ 7065.974679] LustreError: 416391:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7065.974707] LustreError: 416392:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7065.979142] LustreError: 416391:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 7067.034896] Lustre: Mounted lustre-client [ 7067.500649] LustreError: 416507:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7067.502703] LustreError: 416508:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7067.505137] LustreError: 416507:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7067.530267] Lustre: Unmounted lustre-client [ 7068.542486] Key type lgssc unregistered [ 7068.666505] LNet: 416751:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7068.668760] LNetError: 416751:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7068.678568] LNet: Removed LNI 192.168.204.29@tcp [ 7068.903111] Key type .llcrypt unregistered [ 7068.904033] Key type ._llcrypt unregistered [ 7069.156533] Key type ._llcrypt registered [ 7069.157886] Key type .llcrypt registered [ 7069.375361] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7069.381529] alg: No test for adler32 (adler32-zlib) [ 7070.242865] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7070.336223] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7071.920114] Key type lgssc registered [ 7072.307963] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7075.817567] Lustre: DEBUG MARKER: Iteration 31 [ 7075.939212] LustreError: 417579:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7075.939236] LustreError: 417580:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7075.942750] LustreError: 417579:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7077.000620] Lustre: Mounted lustre-client [ 7077.001740] Lustre: Skipped 1 previous similar message [ 7077.514656] LustreError: 417692:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb43224800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7077.517592] LustreError: 417693:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7077.519097] LustreError: 417692:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7077.573461] Lustre: Unmounted lustre-client [ 7078.597672] Key type lgssc unregistered [ 7078.717719] LNet: 417934:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7078.719767] LNetError: 417934:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7078.728971] LNet: Removed LNI 192.168.204.29@tcp [ 7079.012398] Key type .llcrypt unregistered [ 7079.014408] Key type ._llcrypt unregistered [ 7079.270765] Key type ._llcrypt registered [ 7079.271896] Key type .llcrypt registered [ 7079.526564] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7079.533828] alg: No test for adler32 (adler32-zlib) [ 7080.395826] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7080.480132] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7082.064170] Key type lgssc registered [ 7082.465301] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7086.277443] Lustre: DEBUG MARKER: Iteration 32 [ 7086.382735] LustreError: 418762:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7086.383088] LustreError: 418763:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7086.386561] LustreError: 418762:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7087.441639] Lustre: Mounted lustre-client [ 7087.443158] Lustre: Skipped 1 previous similar message [ 7087.958117] LustreError: 418876:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb4ad58800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7087.964634] LustreError: 418876:0:(obd_class.h:479:obd_check_dev()) Device 9 not setup [ 7088.003169] Lustre: Unmounted lustre-client [ 7089.079736] Key type lgssc unregistered [ 7089.206730] LNet: 419120:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7089.210286] LNetError: 419120:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7089.217572] LNet: Removed LNI 192.168.204.29@tcp [ 7089.496127] Key type .llcrypt unregistered [ 7089.497957] Key type ._llcrypt unregistered [ 7089.739672] Key type ._llcrypt registered [ 7089.741024] Key type .llcrypt registered [ 7089.959926] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7089.969722] alg: No test for adler32 (adler32-zlib) [ 7090.828977] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7090.914756] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7092.504185] Key type lgssc registered [ 7092.906443] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7096.565497] Lustre: DEBUG MARKER: Iteration 33 [ 7096.704372] LustreError: 419949:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7096.704717] LustreError: 419948:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7096.709820] LustreError: 419949:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7097.768626] Lustre: Mounted lustre-client [ 7098.350740] LustreError: 420063:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7098.355481] LustreError: 420064:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7098.355950] LustreError: 420063:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7098.417124] Lustre: Unmounted lustre-client [ 7099.512899] Key type lgssc unregistered [ 7099.639488] LNet: 420305:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7099.642046] LNetError: 420305:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7099.649653] LNet: Removed LNI 192.168.204.29@tcp [ 7099.917136] Key type .llcrypt unregistered [ 7099.918870] Key type ._llcrypt unregistered [ 7100.197315] Key type ._llcrypt registered [ 7100.198318] Key type .llcrypt registered [ 7100.391399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7100.399063] alg: No test for adler32 (adler32-zlib) [ 7101.266531] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7101.358343] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7102.944179] Key type lgssc registered [ 7103.367405] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7107.265370] Lustre: DEBUG MARKER: Iteration 34 [ 7107.373345] LustreError: 421134:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7107.373360] LustreError: 421135:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7107.378225] LustreError: 421134:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=5000 [ 7108.447276] Lustre: Mounted lustre-client [ 7108.448242] Lustre: Skipped 1 previous similar message [ 7108.936516] LustreError: 421243:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6132a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7108.940357] LustreError: 421243:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7108.942944] LustreError: 421244:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 7108.945282] LustreError: 421244:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 7108.999764] Lustre: Unmounted lustre-client [ 7110.018536] Key type lgssc unregistered [ 7110.139524] LNet: 421487:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7110.141557] LNetError: 421487:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7110.152948] LNet: Removed LNI 192.168.204.29@tcp [ 7110.406095] Key type .llcrypt unregistered [ 7110.407074] Key type ._llcrypt unregistered [ 7110.693230] Key type ._llcrypt registered [ 7110.694313] Key type .llcrypt registered [ 7110.900995] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7110.906715] alg: No test for adler32 (adler32-zlib) [ 7111.778520] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7111.868902] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7113.456217] Key type lgssc registered [ 7113.891878] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7117.747635] Lustre: DEBUG MARKER: Iteration 35 [ 7117.849592] LustreError: 422315:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7117.851503] LustreError: 422316:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7117.856376] LustreError: 422315:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4995 [ 7118.930602] Lustre: Mounted lustre-client [ 7118.931894] Lustre: Skipped 1 previous similar message [ 7119.454129] LustreError: 422428:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb738d2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7119.461799] LustreError: 422428:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7119.512105] Lustre: Unmounted lustre-client [ 7120.546889] Key type lgssc unregistered [ 7120.672524] LNet: 422671:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7120.675202] LNetError: 422671:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7120.681607] LNet: Removed LNI 192.168.204.29@tcp [ 7120.916182] Key type .llcrypt unregistered [ 7120.918801] Key type ._llcrypt unregistered [ 7121.227586] Key type ._llcrypt registered [ 7121.228663] Key type .llcrypt registered [ 7121.379444] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7121.384266] alg: No test for adler32 (adler32-zlib) [ 7122.237307] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7122.327667] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7123.912132] Key type lgssc registered [ 7124.303336] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7127.819147] Lustre: DEBUG MARKER: Iteration 36 [ 7127.926501] LustreError: 423499:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7127.926539] LustreError: 423500:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7127.930578] LustreError: 423499:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7128.989411] Lustre: Mounted lustre-client [ 7129.450151] LustreError: 423615:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb531fc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7129.453719] LustreError: 423615:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7129.454270] LustreError: 423614:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7129.457734] LustreError: 423614:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 7129.496388] Lustre: Unmounted lustre-client [ 7130.533505] Key type lgssc unregistered [ 7130.641568] LNet: 423859:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7130.643855] LNetError: 423859:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7130.650712] LNet: Removed LNI 192.168.204.29@tcp [ 7130.893156] Key type .llcrypt unregistered [ 7130.894244] Key type ._llcrypt unregistered [ 7131.159614] Key type ._llcrypt registered [ 7131.164421] Key type .llcrypt registered [ 7131.372306] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7131.377748] alg: No test for adler32 (adler32-zlib) [ 7132.239441] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7132.332752] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7133.912199] Key type lgssc registered [ 7134.350510] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7138.202950] Lustre: DEBUG MARKER: Iteration 37 [ 7138.296126] LustreError: 424686:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7138.297034] LustreError: 424689:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7138.301630] LustreError: 424686:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4996 [ 7139.362228] Lustre: Mounted lustre-client [ 7139.363813] Lustre: Skipped 1 previous similar message [ 7139.815551] LustreError: 424796:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497e8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7139.818457] LustreError: 424795:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7139.821269] LustreError: 424796:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7139.859060] Lustre: Unmounted lustre-client [ 7140.847193] Key type lgssc unregistered [ 7140.963546] LNet: 425037:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7140.965617] LNetError: 425037:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7140.973771] LNet: Removed LNI 192.168.204.29@tcp [ 7141.204097] Key type .llcrypt unregistered [ 7141.205049] Key type ._llcrypt unregistered [ 7141.427977] Key type ._llcrypt registered [ 7141.428872] Key type .llcrypt registered [ 7141.639873] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7141.644736] alg: No test for adler32 (adler32-zlib) [ 7142.509319] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7142.599300] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7144.184125] Key type lgssc registered [ 7144.571226] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7147.914730] Lustre: DEBUG MARKER: Iteration 38 [ 7148.018721] LustreError: 425865:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7148.018746] LustreError: 425867:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7148.021970] LustreError: 425865:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 7149.070043] Lustre: Mounted lustre-client [ 7149.071738] Lustre: Skipped 1 previous similar message [ 7149.512076] LustreError: 425975:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb53300000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7149.514059] LustreError: 425976:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7149.517770] LustreError: 425975:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7149.577533] Lustre: Unmounted lustre-client [ 7150.494716] Key type lgssc unregistered [ 7150.623454] LNet: 426217:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7150.625635] LNetError: 426217:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7150.635680] LNet: Removed LNI 192.168.204.29@tcp [ 7150.863122] Key type .llcrypt unregistered [ 7150.864850] Key type ._llcrypt unregistered [ 7151.117471] Key type ._llcrypt registered [ 7151.118429] Key type .llcrypt registered [ 7151.296865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7151.301235] alg: No test for adler32 (adler32-zlib) [ 7152.147195] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7152.227054] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7153.808107] Key type lgssc registered [ 7154.194745] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7158.222348] Lustre: DEBUG MARKER: Iteration 39 [ 7158.318612] LustreError: 427046:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7158.319438] LustreError: 427047:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7158.323188] LustreError: 427046:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7159.374604] Lustre: Mounted lustre-client [ 7159.816113] LustreError: 427162:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb531fc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7159.818709] LustreError: 427161:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 7159.819696] LustreError: 427162:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7159.880064] Lustre: Unmounted lustre-client [ 7160.911697] Key type lgssc unregistered [ 7161.024505] LNet: 427405:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7161.026964] LNetError: 427405:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7161.034772] LNet: Removed LNI 192.168.204.29@tcp [ 7161.273124] Key type .llcrypt unregistered [ 7161.274685] Key type ._llcrypt unregistered [ 7161.519116] Key type ._llcrypt registered [ 7161.520469] Key type .llcrypt registered [ 7161.694707] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7161.701060] alg: No test for adler32 (adler32-zlib) [ 7162.552634] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7162.635776] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7164.216184] Key type lgssc registered [ 7164.876897] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7169.352796] Lustre: DEBUG MARKER: Iteration 40 [ 7169.452548] LustreError: 428234:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7169.452588] LustreError: 428235:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7169.456092] LustreError: 428234:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7170.526232] Lustre: Mounted lustre-client [ 7170.527136] Lustre: Skipped 1 previous similar message [ 7170.946937] LustreError: 428347:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6bcbc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7170.949948] LustreError: 428349:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7170.952744] LustreError: 428347:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7171.001160] Lustre: Unmounted lustre-client [ 7172.112832] Key type lgssc unregistered [ 7172.228878] LNet: 428590:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7172.232808] LNetError: 428590:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7172.244850] LNet: Removed LNI 192.168.204.29@tcp [ 7172.476119] Key type .llcrypt unregistered [ 7172.477049] Key type ._llcrypt unregistered [ 7172.766498] Key type ._llcrypt registered [ 7172.767502] Key type .llcrypt registered [ 7172.935253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7172.939814] alg: No test for adler32 (adler32-zlib) [ 7173.803425] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7173.888547] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7175.464169] Key type lgssc registered [ 7175.887108] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7179.861147] Lustre: DEBUG MARKER: Iteration 41 [ 7179.956484] LustreError: 429419:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7179.960247] LustreError: 429421:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7179.962027] LustreError: 429419:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 7181.015550] Lustre: Mounted lustre-client [ 7181.018420] Lustre: Skipped 1 previous similar message [ 7181.459027] LustreError: 429536:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb497c3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7181.461146] LustreError: 429535:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7181.462163] LustreError: 429536:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7181.513072] Lustre: Unmounted lustre-client [ 7181.514347] Lustre: Skipped 1 previous similar message [ 7182.713799] Key type lgssc unregistered [ 7182.859812] LNet: 429779:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7182.865373] LNetError: 429779:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7182.875166] LNet: Removed LNI 192.168.204.29@tcp [ 7183.197159] Key type .llcrypt unregistered [ 7183.198592] Key type ._llcrypt unregistered [ 7183.481681] Key type ._llcrypt registered [ 7183.482673] Key type .llcrypt registered [ 7183.645079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7183.649418] alg: No test for adler32 (adler32-zlib) [ 7184.524111] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7184.610887] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7186.208228] Key type lgssc registered [ 7186.742188] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7190.788589] Lustre: DEBUG MARKER: Iteration 42 [ 7190.919588] LustreError: 430608:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7190.919633] LustreError: 430609:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7190.924191] LustreError: 430608:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7191.975575] Lustre: Mounted lustre-client [ 7192.390281] LustreError: 430718:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb435f0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7192.396917] LustreError: 430718:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 7192.399273] LustreError: 430718:0:(obd_class.h:479:obd_check_dev()) Skipped 4 previous similar messages [ 7192.428670] Lustre: Unmounted lustre-client [ 7192.430047] Lustre: Skipped 1 previous similar message [ 7193.394239] Key type lgssc unregistered [ 7193.507538] LNet: 430962:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7193.509452] LNetError: 430962:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7193.515670] LNet: Removed LNI 192.168.204.29@tcp [ 7193.773160] Key type .llcrypt unregistered [ 7193.775237] Key type ._llcrypt unregistered [ 7194.057976] Key type ._llcrypt registered [ 7194.061050] Key type .llcrypt registered [ 7194.224679] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7194.229067] alg: No test for adler32 (adler32-zlib) [ 7195.080818] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7195.156959] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7196.744128] Key type lgssc registered [ 7197.194749] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7200.524291] Lustre: DEBUG MARKER: Iteration 43 [ 7200.621866] LustreError: 431790:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7200.621892] LustreError: 431791:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7200.625697] LustreError: 431790:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7201.676482] Lustre: Mounted lustre-client [ 7202.090809] LustreError: 431904:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6132a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7202.093862] LustreError: 431903:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7202.094941] LustreError: 431904:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7202.151062] Lustre: Unmounted lustre-client [ 7203.047700] Key type lgssc unregistered [ 7203.157409] LNet: 432144:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7203.160929] LNetError: 432144:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7203.169774] LNet: Removed LNI 192.168.204.29@tcp [ 7203.391160] Key type .llcrypt unregistered [ 7203.393201] Key type ._llcrypt unregistered [ 7203.650486] Key type ._llcrypt registered [ 7203.652238] Key type .llcrypt registered [ 7203.828350] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7203.832964] alg: No test for adler32 (adler32-zlib) [ 7204.680608] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7204.762350] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7206.344143] Key type lgssc registered [ 7206.736458] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7210.383023] Lustre: DEBUG MARKER: Iteration 44 [ 7210.474164] LustreError: 432973:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7210.474203] LustreError: 432974:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7210.477851] LustreError: 432973:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7211.542823] Lustre: Mounted lustre-client [ 7211.544610] Lustre: Skipped 1 previous similar message [ 7211.979132] LustreError: 433089:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6bcbc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7211.981112] LustreError: 433088:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7211.984376] LustreError: 433089:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7212.015995] Lustre: Unmounted lustre-client [ 7212.866401] Key type lgssc unregistered [ 7212.970410] LNet: 433331:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7212.972488] LNetError: 433331:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7212.980764] LNet: Removed LNI 192.168.204.29@tcp [ 7213.197159] Key type .llcrypt unregistered [ 7213.198139] Key type ._llcrypt unregistered [ 7213.400950] Key type ._llcrypt registered [ 7213.401972] Key type .llcrypt registered [ 7213.605929] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7213.611062] alg: No test for adler32 (adler32-zlib) [ 7214.467797] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7214.542851] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7216.120171] Key type lgssc registered [ 7216.493578] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7219.854316] Lustre: DEBUG MARKER: Iteration 45 [ 7219.989375] LustreError: 434159:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7219.989441] LustreError: 434160:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7219.993166] LustreError: 434159:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7221.056314] Lustre: Mounted lustre-client [ 7221.058313] Lustre: Skipped 1 previous similar message [ 7221.478849] LustreError: 434269:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb7b969000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7221.483864] LustreError: 434269:0:(obd_class.h:479:obd_check_dev()) Device 11 not setup [ 7221.485919] LustreError: 434269:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 7221.521191] Lustre: Unmounted lustre-client [ 7222.367973] Key type lgssc unregistered [ 7222.485511] LNet: 434511:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7222.488522] LNetError: 434511:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7222.499651] LNet: Removed LNI 192.168.204.29@tcp [ 7222.711091] Key type .llcrypt unregistered [ 7222.711991] Key type ._llcrypt unregistered [ 7222.941209] Key type ._llcrypt registered [ 7222.942113] Key type .llcrypt registered [ 7223.128429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7223.133088] alg: No test for adler32 (adler32-zlib) [ 7223.988431] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7224.061984] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7225.648131] Key type lgssc registered [ 7226.176887] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7229.417048] Lustre: DEBUG MARKER: Iteration 46 [ 7229.515278] LustreError: 435340:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7229.517547] LustreError: 435342:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7229.519284] LustreError: 435340:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7230.576174] Lustre: Mounted lustre-client [ 7230.577973] Lustre: Skipped 1 previous similar message [ 7230.990668] LustreError: 435454:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb73c86000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7230.993574] LustreError: 435455:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7230.995243] LustreError: 435454:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7231.046094] Lustre: Unmounted lustre-client [ 7232.187848] Key type lgssc unregistered [ 7232.299491] LNet: 435697:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7232.303916] LNetError: 435697:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7232.313769] LNet: Removed LNI 192.168.204.29@tcp [ 7232.521102] Key type .llcrypt unregistered [ 7232.522152] Key type ._llcrypt unregistered [ 7232.758106] Key type ._llcrypt registered [ 7232.760288] Key type .llcrypt registered [ 7232.953156] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7232.957694] alg: No test for adler32 (adler32-zlib) [ 7233.802728] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7233.888604] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7235.464108] Key type lgssc registered [ 7235.805079] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7239.040838] Lustre: DEBUG MARKER: Iteration 47 [ 7239.135934] LustreError: 436525:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7239.136087] LustreError: 436526:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7239.139800] LustreError: 436525:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 7240.193892] Lustre: Mounted lustre-client [ 7240.627465] LustreError: 436636:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb6bcbb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7240.631104] LustreError: 436635:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 7240.633325] LustreError: 436636:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7240.690091] Lustre: Unmounted lustre-client [ 7241.541815] Key type lgssc unregistered [ 7241.644516] LNet: 436877:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7241.648215] LNetError: 436877:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7241.659438] LNet: Removed LNI 192.168.204.29@tcp [ 7241.872111] Key type .llcrypt unregistered [ 7241.872996] Key type ._llcrypt unregistered [ 7242.094518] Key type ._llcrypt registered [ 7242.095547] Key type .llcrypt registered [ 7242.299692] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7242.304101] alg: No test for adler32 (adler32-zlib) [ 7243.166101] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7243.258289] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7244.840135] Key type lgssc registered [ 7245.198032] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7248.443264] Lustre: DEBUG MARKER: Iteration 48 [ 7248.553959] LustreError: 437706:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7248.554112] LustreError: 437707:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7248.557394] LustreError: 437706:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7249.611289] Lustre: Mounted lustre-client [ 7249.612274] Lustre: Skipped 1 previous similar message [ 7250.021412] LustreError: 437818:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb61314800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7250.024356] LustreError: 437818:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7250.026806] LustreError: 437819:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7250.029182] LustreError: 437819:0:(obd_class.h:479:obd_check_dev()) Skipped 2 previous similar messages [ 7250.067059] Lustre: Unmounted lustre-client [ 7250.873457] Key type lgssc unregistered [ 7250.979350] LNet: 438060:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7250.981251] LNetError: 438060:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7250.988471] LNet: Removed LNI 192.168.204.29@tcp [ 7251.198093] Key type .llcrypt unregistered [ 7251.199036] Key type ._llcrypt unregistered [ 7251.434420] Key type ._llcrypt registered [ 7251.435624] Key type .llcrypt registered [ 7251.612409] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7251.617988] alg: No test for adler32 (adler32-zlib) [ 7252.469594] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7252.544195] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7254.120116] Key type lgssc registered [ 7254.484956] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7258.445160] Lustre: DEBUG MARKER: Iteration 49 [ 7258.571104] LustreError: 438888:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7258.572197] LustreError: 438889:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7258.574747] LustreError: 438888:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4999 [ 7259.636473] Lustre: Mounted lustre-client [ 7260.070513] LustreError: 439002:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb73c80000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7260.072188] LustreError: 439003:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7260.073567] LustreError: 439002:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7260.121067] Lustre: Unmounted lustre-client [ 7261.315499] Key type lgssc unregistered [ 7261.453892] LNet: 439245:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7261.457917] LNetError: 439245:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7261.471309] LNet: Removed LNI 192.168.204.29@tcp [ 7261.851167] Key type .llcrypt unregistered [ 7261.853290] Key type ._llcrypt unregistered [ 7262.141951] Key type ._llcrypt registered [ 7262.145798] Key type .llcrypt registered [ 7262.340456] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7262.345193] alg: No test for adler32 (adler32-zlib) [ 7263.220849] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7263.319584] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7264.904270] Key type lgssc registered [ 7265.376409] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7269.604299] Lustre: DEBUG MARKER: Iteration 50 [ 7269.735963] LustreError: 440073:0:(llite_lib.c:1393:ll_fill_super()) cfs_race id 1417 sleeping [ 7269.736091] LustreError: 440075:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 waking [ 7269.739564] LustreError: 440073:0:(llite_lib.c:1393:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 7270.800804] Lustre: Mounted lustre-client [ 7270.803032] Lustre: Skipped 1 previous similar message [ 7271.310769] LustreError: 440182:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb435f6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7271.313315] LustreError: 440183:0:(obd_class.h:479:obd_check_dev()) Device 10 not setup [ 7271.314087] LustreError: 440182:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7271.345704] Lustre: Unmounted lustre-client [ 7272.745370] Key type lgssc unregistered [ 7272.895621] LNet: 440425:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7272.900531] LNetError: 440425:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7272.912213] LNet: Removed LNI 192.168.204.29@tcp [ 7273.308188] Key type .llcrypt unregistered [ 7273.311481] Key type ._llcrypt unregistered [ 7273.714740] Key type ._llcrypt registered [ 7273.715638] Key type .llcrypt registered [ 7273.953542] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7273.959197] alg: No test for adler32 (adler32-zlib) [ 7274.867469] Lustre: Lustre: Build Version: 2.16.61_41_g6a6a76f [ 7274.959626] LNet: Added LNI 192.168.204.29@tcp [8/256/0/180] [ 7276.560266] Key type lgssc registered [ 7277.173398] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7282.570833] Lustre: Mounted lustre-client [ 7285.816770] Lustre: DEBUG MARKER: == sanityn test 110: do not grant another lock on resend ========================================================== 00:41:30 (1763358090) [ 7302.624207] Lustre: 441780:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358091/real 1763358091] req@ffff88eb80a69500 x1849014961055616/t0(0) o36->lustre-MDT0000-mdc-ffff88eb73c82800@192.168.204.129@tcp:12/10 lens 496/440 e 0 to 1 dl 1763358107 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7302.644513] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection to lustre-MDT0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7302.664090] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7319.008284] Lustre: 441780:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358107/real 1763358107] req@ffff88eb80a69500 x1849014961055616/t0(0) o36->lustre-MDT0000-mdc-ffff88eb73c82800@192.168.204.129@tcp:12/10 lens 496/440 e 0 to 1 dl 1763358123 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7319.023596] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection to lustre-MDT0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7319.041160] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7334.368195] Lustre: 441780:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358123/real 1763358123] req@ffff88eb80a69500 x1849014961055616/t0(0) o36->lustre-MDT0000-mdc-ffff88eb73c82800@192.168.204.129@tcp:12/10 lens 496/440 e 0 to 1 dl 1763358139 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7334.374744] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection to lustre-MDT0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7334.381867] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7350.752149] Lustre: 441780:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358139/real 1763358139] req@ffff88eb80a69500 x1849014961055616/t0(0) o36->lustre-MDT0000-mdc-ffff88eb73c82800@192.168.204.129@tcp:12/10 lens 496/440 e 0 to 1 dl 1763358155 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7350.758378] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection to lustre-MDT0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7350.767617] Lustre: lustre-MDT0000-mdc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7351.290929] Lustre: DEBUG MARKER: == sanityn test 111: A racy rename/link an open file should not cause fs corruption ========================================================== 00:42:35 (1763358155) [ 7357.475834] Lustre: DEBUG MARKER: == sanityn test 112: update max-inherit in default LMV === 00:42:41 (1763358161) [ 7361.664458] Lustre: DEBUG MARKER: == sanityn test 113: check servers of specified fs ======= 00:42:46 (1763358166) [ 7364.021179] Lustre: DEBUG MARKER: == sanityn test 114: implicit default LMV inherit ======== 00:42:48 (1763358168) [ 7371.269834] Lustre: DEBUG MARKER: == sanityn test 115: ldiskfs doesn't check direntry for uniqueness ========================================================== 00:42:55 (1763358175) [ 7384.275699] Lustre: DEBUG MARKER: == sanityn test 116: DNE: Set default LMV layout from a remote client ========================================================== 00:43:08 (1763358188) [ 7386.859928] Lustre: DEBUG MARKER: == sanityn test 200: service remains healthy while able to process request ========================================================== 00:43:11 (1763358191) [ 7405.536135] Lustre: 440618:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358194/real 1763358194] req@ffff88eb610a2680 x1849014962086016/t0(0) o4->lustre-OST0000-osc-ffff88eb73c82800@192.168.204.129@tcp:6/4 lens 4584/448 e 0 to 1 dl 1763358210 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 7405.546900] Lustre: lustre-OST0000-osc-ffff88eb73c82800: Connection to lustre-OST0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7405.554562] Lustre: lustre-OST0000-osc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7421.920124] Lustre: 440617:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358210/real 1763358210] req@ffff88eb610a3800 x1849014962086784/t0(0) o4->lustre-OST0000-osc-ffff88eb73c82800@192.168.204.129@tcp:6/4 lens 4584/448 e 0 to 1 dl 1763358226 ref 2 fl Rpc:XQr/602/ffffffff rc -11/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 7421.920169] Lustre: lustre-OST0000-osc-ffff88eb73c82800: Connection to lustre-OST0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7421.925897] Lustre: 440617:0:(client.c:2478:ptlrpc_expire_one_request()) Skipped 4 previous similar messages [ 7421.933636] Lustre: lustre-OST0000-osc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7453.664171] Lustre: 440616:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1763358242/real 1763358242] req@ffff88eb5136aa00 x1849014962085248/t0(0) o4->lustre-OST0000-osc-ffff88eb73c82800@192.168.204.129@tcp:6/4 lens 4584/448 e 0 to 1 dl 1763358258 ref 2 fl Rpc:XQr/602/ffffffff rc -11/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 7453.669875] Lustre: 440616:0:(client.c:2478:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 7453.671514] Lustre: lustre-OST0000-osc-ffff88eb73c82800: Connection to lustre-OST0000 (at 192.168.204.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7453.674941] Lustre: Skipped 1 previous similar message [ 7453.683244] Lustre: lustre-OST0000-osc-ffff88eb73c82800: Connection restored to 192.168.204.129@tcp (at 192.168.204.129@tcp) [ 7453.685495] Lustre: Skipped 1 previous similar message [ 7477.480151] Lustre: DEBUG MARKER: oleg429-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff88eb50b7e800.ost_server_uuid 50 [ 7478.007734] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff88eb50b7e800.ost_server_uuid in IDLE state after 0 sec [ 7478.637230] Lustre: DEBUG MARKER: cleanup: ====================================================== [ 7479.479692] Lustre: DEBUG MARKER: == sanityn test complete, duration 7214 sec ============== 00:44:43 (1763358283) [ 7480.106575] Lustre: DEBUG MARKER: === sanityn: start cleanup 00:44:44 (1763358284) === [ 7578.352897] LustreError: 448023:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb50b7e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7578.356171] LustreError: 448023:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 7578.374078] Lustre: Unmounted lustre-client [ 7580.184969] Lustre: DEBUG MARKER: === sanityn: finish cleanup 00:46:24 (1763358384) === [ 7580.561327] LustreError: 448327:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88eb73c82800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7580.564591] LustreError: 448327:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 7580.570104] LustreError: 448327:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7580.571668] LustreError: 448327:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 7580.598407] Lustre: Unmounted lustre-client [ 7624.133813] Key type lgssc unregistered [ 7624.263625] LNet: 449011:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7624.267203] LNetError: 449011:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7624.277894] LNet: Removed LNI 192.168.204.29@tcp [ 7624.601107] Key type .llcrypt unregistered [ 7624.602581] Key type ._llcrypt unregistered