[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-10.fc44 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 388308551 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001008] APIC: Switch to symmetric I/O mode setup [ 0.002279] x2apic enabled [ 0.003004] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.006647] ..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.007019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008005] pid_max: default: 32768 minimum: 301 [ 0.009105] LSM: Security Framework initializing [ 0.010025] Yama: becoming mindful. [ 0.011019] SELinux: Initializing. [ 0.012037] *** VALIDATE selinux *** [ 0.019182] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024091] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025108] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026071] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028018] *** VALIDATE tmpfs *** [ 0.029017] *** VALIDATE proc *** [ 0.029809] *** VALIDATE cgroup *** [ 0.030004] *** VALIDATE cgroup2 *** [ 0.031192] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.032094] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.033002] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.034029] Spectre V2 : User space: Vulnerable [ 0.035003] Speculative Store Bypass: Vulnerable [ 0.037568] debug: unmapping init [mem 0xffffffff91e59000-0xffffffff91e60fff] [ 0.038911] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.039495] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.040009] ... version: 2 [ 0.040741] ... bit width: 48 [ 0.041005] ... generic registers: 4 [ 0.041826] ... value mask: 0000ffffffffffff [ 0.042005] ... max period: 00007fffffffffff [ 0.043005] ... fixed-purpose events: 3 [ 0.043782] ... event mask: 000000070000000f [ 0.045125] rcu: Hierarchical SRCU implementation. [ 0.047264] smp: Bringing up secondary CPUs ... [ 0.048373] x86: Booting SMP configuration: [ 0.049018] .... node #0, CPUs: #1 #2 #3 [ 0.052187] smp: Brought up 1 node, 4 CPUs [ 0.053820] smpboot: Max logical packages: 1 [ 0.054008] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.179864] node 0 deferred pages initialised in 125ms [ 0.183109] devtmpfs: initialized [ 0.184152] x86/mm: Memory block size: 128MB [ 0.186158] gcov: version magic: 0x41383552 [ 0.187519] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.190047] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.191267] pinctrl core: initialized pinctrl subsystem [ 0.193080] [ 0.193433] ************************************************************* [ 0.194005] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.196007] ** ** [ 0.197005] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.199006] ** ** [ 0.200006] ** This means that this kernel is built to expose internal ** [ 0.201006] ** IOMMU data structures, which may compromise security on ** [ 0.203006] ** your system. ** [ 0.204006] ** ** [ 0.206006] ** If you see this message and you are not debugging the ** [ 0.207005] ** kernel, report this immediately to your vendor! ** [ 0.208006] ** ** [ 0.210006] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.211005] ************************************************************* [ 0.213653] NET: Registered protocol family 16 [ 0.214342] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.216030] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.218028] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.221042] cpuidle: using governor menu [ 0.222522] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.224403] PCI: Using configuration type 1 for base access [ 0.226109] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.232090] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.234021] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.236055] cryptd: max_cpu_qlen set to 1000 [ 0.238267] ACPI: Added _OSI(Module Device) [ 0.240011] ACPI: Added _OSI(Processor Device) [ 0.241009] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.243010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.246000] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.252444] ACPI: Interpreter enabled [ 0.254046] ACPI: PM: (supports S0 S3 S4 S5) [ 0.255009] ACPI: Using IOAPIC for interrupt routing [ 0.257064] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.261370] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.271000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.274024] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.277013] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.280062] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.285225] acpiphp: Slot [2] registered [ 0.287068] acpiphp: Slot [5] registered [ 0.288055] acpiphp: Slot [6] registered [ 0.289076] acpiphp: Slot [3] registered [ 0.290056] acpiphp: Slot [4] registered [ 0.291020] acpiphp: Slot [7] registered [ 0.291977] acpiphp: Slot [8] registered [ 0.294059] acpiphp: Slot [9] registered [ 0.295079] acpiphp: Slot [10] registered [ 0.297076] acpiphp: Slot [11] registered [ 0.298054] acpiphp: Slot [12] registered [ 0.300078] acpiphp: Slot [13] registered [ 0.301119] acpiphp: Slot [14] registered [ 0.302094] acpiphp: Slot [15] registered [ 0.304088] acpiphp: Slot [16] registered [ 0.305085] acpiphp: Slot [17] registered [ 0.307070] acpiphp: Slot [18] registered [ 0.308100] acpiphp: Slot [19] registered [ 0.310072] acpiphp: Slot [20] registered [ 0.311068] acpiphp: Slot [21] registered [ 0.312077] acpiphp: Slot [22] registered [ 0.314068] acpiphp: Slot [23] registered [ 0.315068] acpiphp: Slot [24] registered [ 0.317068] acpiphp: Slot [25] registered [ 0.318106] acpiphp: Slot [26] registered [ 0.320070] acpiphp: Slot [27] registered [ 0.321075] acpiphp: Slot [28] registered [ 0.323070] acpiphp: Slot [29] registered [ 0.324099] acpiphp: Slot [30] registered [ 0.326095] acpiphp: Slot [31] registered [ 0.328090] PCI host bridge to bus 0000:00 [ 0.329016] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.332029] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.334022] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.337019] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.339022] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.342018] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.344190] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.347084] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.350219] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.358014] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.362080] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.365014] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.368012] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.370009] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.372622] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.375771] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.378034] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.382485] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.386930] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.394662] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.397918] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.401602] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.404790] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.408752] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.419024] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.425323] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.428710] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.432010] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.441026] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.447324] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.449213] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.451237] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.453191] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.454106] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.457180] iommu: Default domain type: Passthrough [ 0.458367] SCSI subsystem initialized [ 0.460092] ACPI: bus type USB registered [ 0.461072] usbcore: registered new interface driver usbfs [ 0.463034] usbcore: registered new interface driver hub [ 0.464035] usbcore: registered new device driver usb [ 0.465145] pps_core: LinuxPPS API ver. 1 registered [ 0.466008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.468023] PTP clock support registered [ 0.470085] EDAC MC: Ver: 3.0.0 [ 0.471355] PCI: Using ACPI for IRQ routing [ 0.472755] NetLabel: Initializing [ 0.473008] NetLabel: domain hash size = 128 [ 0.474007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.475080] NetLabel: unlabeled traffic allowed by default [ 0.476101] vgaarb: loaded [ 0.477286] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.478008] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.483232] clocksource: Switched to clocksource kvm-clock [ 0.565866] VFS: Disk quotas dquot_6.6.0 [ 0.566892] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.568442] *** VALIDATE ramfs *** [ 0.569226] *** VALIDATE hugetlbfs *** [ 0.570256] pnp: PnP ACPI init [ 0.571843] pnp: PnP ACPI: found 6 devices [ 0.584544] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.586911] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.588270] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.589604] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.591008] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.592471] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.594475] NET: Registered protocol family 2 [ 0.597148] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.601541] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.603860] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.607746] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.610159] TCP: Hash tables configured (established 65536 bind 65536) [ 0.612301] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.614375] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.616322] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.618374] NET: Registered protocol family 1 [ 0.620274] RPC: Registered named UNIX socket transport module. [ 0.621917] RPC: Registered udp transport module. [ 0.623226] RPC: Registered tcp transport module. [ 0.624386] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.625891] NET: Registered protocol family 44 [ 0.627105] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.628655] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.630145] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.631728] PCI: CLS 0 bytes, default 64 [ 0.632931] Unpacking initramfs... [ 2.093171] debug: unmapping init [mem 0xffff8dfdbcc64000-0xffff8dfdbffcffff] [ 2.097070] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.098971] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.101548] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.573530] Initialise system trusted keyrings [ 2.575505] Key type blacklist registered [ 2.576980] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.585091] zbud: loaded [ 2.587528] *** VALIDATE nfs *** [ 2.588451] *** VALIDATE nfs4 *** [ 2.589789] pstore: using deflate compression [ 2.591909] Platform Keyring initialized [ 2.669855] NET: Registered protocol family 38 [ 2.671090] Key type asymmetric registered [ 2.671930] Asymmetric key parser 'x509' registered [ 2.673078] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.675068] io scheduler mq-deadline registered [ 2.676530] io scheduler kyber registered [ 2.677965] io scheduler bfq registered [ 2.679495] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.681977] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.685453] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.687975] ACPI: Power Button [PWRF] [ 2.693755] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.700673] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.711498] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.738480] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.766222] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.771376] Non-volatile memory driver v1.3 [ 2.772946] Linux agpgart interface v0.103 [ 2.802194] virtio_blk virtio1: [vda] 145176 512-byte logical blocks (74.3 MB/70.9 MiB) [ 2.804914] vda: detected capacity change from 0 to 74330112 [ 2.818921] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.820694] vdb: detected capacity change from 0 to 1073741824 [ 2.827934] libphy: Fixed MDIO Bus: probed [ 2.831707] usbcore: registered new interface driver usbserial_generic [ 2.834295] usbserial: USB Serial support registered for generic [ 2.836903] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.840385] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.841977] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.844478] mousedev: PS/2 mouse device common for all mice [ 2.847573] rtc_cmos 00:05: RTC can wake from S4 [ 2.849414] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.854182] rtc_cmos 00:05: registered as rtc0 [ 2.856171] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.857236] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.860871] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.863317] intel_pstate: CPU model not supported [ 2.868341] hid: raw HID events driver (C) Jiri Kosina [ 2.869926] usbcore: registered new interface driver usbhid [ 2.871264] usbhid: USB HID core driver [ 2.872317] drop_monitor: Initializing network drop monitor service [ 2.873985] Initializing XFRM netlink socket [ 2.875476] NET: Registered protocol family 10 [ 2.877555] Segment Routing with IPv6 [ 2.878916] NET: Registered protocol family 17 [ 2.880757] mpls_gso: MPLS GSO support [ 2.885913] RAS: Correctable Errors collector initialized. [ 2.887294] AVX version of gcm_enc/dec engaged. [ 2.888172] AES CTR mode by8 optimization enabled [ 2.943217] sched_clock: Marking stable (2943177894, 0)->(3639237158, -696059264) [ 2.946112] registered taskstats version 1 [ 2.947742] Loading compiled-in X.509 certificates [ 2.949635] zswap: loaded using pool lzo/zbud [ 2.969576] Key type big_key registered [ 2.980168] Key type encrypted registered [ 2.981865] ima: No TPM chip found, activating TPM-bypass! [ 2.983354] ima: Allocated hash algorithm: sha1 [ 2.984524] ima: No architecture policies found [ 2.985858] evm: Initialising EVM extended attributes: [ 2.987325] evm: security.selinux [ 2.988194] evm: security.ima [ 2.988922] evm: security.capability [ 2.990127] evm: HMAC attrs: 0x1 [ 2.992076] rtc_cmos 00:05: setting system clock to 2026-07-01 17:40:47 UTC (1782927647) [ 2.997681] debug: unmapping init [mem 0xffffffff92e03000-0xffffffff92ffffff] [ 2.999867] debug: unmapping init [mem 0xffffffff91b82000-0xffffffff91e58fff] [ 3.008049] Write protecting the kernel read-only data: 28672k [ 3.011173] debug: unmapping init [mem 0xffffffff90203000-0xffffffff903fffff] [ 3.013734] debug: unmapping init [mem 0xffffffff90b14000-0xffffffff90bfffff] [ 3.040365] 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.045766] systemd[1]: Detected virtualization kvm. [ 3.047582] systemd[1]: Detected architecture x86-64. [ 3.048767] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.075515] systemd[1]: No hostname configured. [ 3.076576] systemd[1]: Set hostname to . [ 3.078070] random: systemd: uninitialized urandom read (16 bytes read) [ 3.079677] systemd[1]: Initializing machine ID from random generator. [ 3.113731] random: ln: uninitialized urandom read (6 bytes read) [ 3.201983] random: systemd: uninitialized urandom read (16 bytes read) [ 3.203850] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.207441] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.209916] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Swap. [ OK ] Reached target Timers. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. Starting Journal Service... Starting Setup Virtual Console... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Apply Kernel Variables... [ OK ] Reached target Sockets. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.862189] device-mapper: uevent: version 1.0.3 [ 3.865742] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.657857] virtio_net virtio0 ens2: renamed from eth0 [ 4.851404] scsi host0: ata_piix [ 4.883231] scsi host1: ata_piix [ 4.885082] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.888395] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.506597] random: crng init done [ 9.512029] random: 7 urandom warning(s) missed due to ratelimiting [ 9.602700] dracut-initqueue[585]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.955953] 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 Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 12.308593] printk: systemd: 26 output lines suppressed due to ratelimiting [ 12.769816] SELinux: Disabled at runtime. [ 12.847249] 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) [ 12.859689] systemd[1]: Detected virtualization kvm. [ 12.861615] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 13.449924] systemd[1]: initrd-switch-root.service: Succeeded. [ 13.451862] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 13.454741] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 13.457077] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 13.459115] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 13.463627] systemd[1]: Starting Journal Service... Starting Journal Service... [ 13.471192] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. Activating swap /dev/disk/by-label/SWAP... Starting Remount Root and Kernel File Systems... [ OK ] Listening on udev Control Socket. Mounting Kernel Debug File System... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-getty.slice. Mounting Huge Pages File System... [ OK ] Created slice User and Session Slice. [ OK [0[ 13.545809] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS m] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Reached target Slices. Starting Apply Kernel Variables... [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Journal Service. [ 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 Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 14.188785] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 14.858755] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 14.897294] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 15.072353] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 15.099120] EDAC sbridge: Ver: 1.1.2 [ 16.555970] Key type dns_resolver registered [ 16.975581] NFS: Registering the id_resolver key type [ 16.979061] Key type id_resolver registered [ 16.980332] 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 Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. Starting Login Service... Starting Network Manager... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. Starting Restore /run/initramfs on shutdown... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ 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 Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. [ OK ] Started Authorization Manager. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg314-client login: [ 44.745696] libcfs: loading out-of-tree module taints kernel. [ 44.815524] Key type ._llcrypt registered [ 44.817755] Key type .llcrypt registered [ 44.994275] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 45.000908] alg: No test for adler32 (adler32-zlib) [ 45.988151] Lustre: Lustre: Build Version: 2.17.54_83_g6b808a3 [ 46.275698] LNet: Added LNI 192.168.203.14@tcp [8/256/0/180] [ 47.887152] Key type lgssc registered [ 48.441045] Lustre: Echo OBD driver; http://www.lustre.org/ [ 106.413997] Lustre: Mounted lustre-client [ 108.698236] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 115.049629] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing check_logdir /tmp/testlogs/ [ 116.431268] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing yml_node [ 117.840903] Lustre: DEBUG MARKER: Client: 2.17.54.83 [ 118.675774] Lustre: DEBUG MARKER: MDS: 2.17.54.83 [ 119.525781] Lustre: DEBUG MARKER: OSS: 2.17.54.83 [ 120.042595] Lustre: DEBUG MARKER: -----============= acceptance-small: sanityn ============----- Wed Jul 1 13:42:44 EDT 2026 [ 125.239966] Lustre: DEBUG MARKER: excepting tests: 27 40a [ 125.767541] Lustre: DEBUG MARKER: skipping tests SLOW=no: 33a [ 126.252831] Lustre: DEBUG MARKER: === sanityn: start setup 13:42:50 (1782927770) === [ 126.445525] Lustre: Mounted lustre-client [ 128.272030] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing check_config_client /mnt/lustre [ 131.551197] Lustre: lustre-OST0000-osc-ffff8dfe07e99800: disconnect after 24s idle [ 134.526696] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 138.536396] Lustre: DEBUG MARKER: === sanityn: finish setup 13:43:02 (1782927782) === [ 139.215417] Lustre: DEBUG MARKER: == sanityn test 0: do_node_vp() and do_facet_vp() do the right thing ========================================================== 13:43:03 (1782927783) [ 141.795169] Lustre: DEBUG MARKER: == sanityn test 1: Check attribute updates on 2 mount points ========================================================== 13:43:05 (1782927785) [ 143.912681] Lustre: DEBUG MARKER: == sanityn test 2a: check cached attribute updates on 2 mtpt's ================================================================== 13:43:07 (1782927787) [ 145.846297] Lustre: DEBUG MARKER: == sanityn test 2b: check cached attribute updates on 2 mtpt's ================================================================== 13:43:09 (1782927789) [ 147.700961] Lustre: DEBUG MARKER: == sanityn test 2c: check cached attribute updates on 2 mtpt's root ============================================================= 13:43:11 (1782927791) [ 149.606698] Lustre: DEBUG MARKER: == sanityn test 2d: check cached attribute updates on 2 mtpt's root ============================================================= 13:43:13 (1782927793) [ 151.583349] Lustre: DEBUG MARKER: == sanityn test 2e: check chmod on root is propagated to others ========================================================== 13:43:15 (1782927795) [ 153.690385] Lustre: DEBUG MARKER: == sanityn test 2f: check attr/owner updates on DNE with 2 mtpt's ========================================================== 13:43:17 (1782927797) [ 155.908097] Lustre: DEBUG MARKER: == sanityn test 2g: check blocks update on sync write ==== 13:43:19 (1782927799) [ 158.113460] Lustre: DEBUG MARKER: == sanityn test 3: symlink on one mtpt, readlink on another ===================================================================== 13:43:22 (1782927802) [ 160.197432] Lustre: DEBUG MARKER: == sanityn test 4: fstat validation on multiple mount points ==================================================================== 13:43:24 (1782927804) [ 163.192640] Lustre: DEBUG MARKER: == sanityn test 5: create a file on one mount, truncate it on the other ========================================================== 13:43:27 (1782927807) [ 165.214511] Lustre: DEBUG MARKER: == sanityn test 6: remove of open file on other node ============================================================================ 13:43:29 (1782927809) [ 167.135725] Lustre: DEBUG MARKER: == sanityn test 7: remove of open directory on other node ======================================================================= 13:43:31 (1782927811) [ 169.174916] Lustre: DEBUG MARKER: == sanityn test 8: remove of open special file on other node ==================================================================== 13:43:33 (1782927813) [ 171.135317] Lustre: DEBUG MARKER: == sanityn test 9a: append of file with sub-page size on multiple mounts ========================================================== 13:43:35 (1782927815) [ 173.352299] Lustre: DEBUG MARKER: == sanityn test 9b: append to striped sparse file ======== 13:43:37 (1782927817) [ 175.431626] Lustre: DEBUG MARKER: == sanityn test 10a: write of file with sub-page size on multiple mounts ========================================================== 13:43:39 (1782927819) [ 177.744187] Lustre: DEBUG MARKER: == sanityn test 10b: write of file with sub-page size on multiple mounts ========================================================== 13:43:41 (1782927821) [ 180.067113] Lustre: DEBUG MARKER: == sanityn test 11: execution of file opened for write should return error ============================================================== 13:43:44 (1782927824) [ 182.374655] Lustre: DEBUG MARKER: == sanityn test 12: test lock ordering (link, stat, unlink) ========================================================== 13:43:46 (1782927826) [ 182.542314] Lustre: DEBUG MARKER: start dir: /mnt/lustre/lockdir=144115205289279518 file: /mnt/lustre/lockdir/lockfile=144115205289279517 [ 317.902323] Lustre: DEBUG MARKER: == sanityn test 13: test directory page revocation ======= 13:46:01 (1782927961) [ 320.062812] Lustre: DEBUG MARKER: == sanityn test 14aa: execution of file open for write returns -ETXTBSY ========================================================== 13:46:04 (1782927964) [ 322.212207] Lustre: DEBUG MARKER: == sanityn test 14ab: open(RDWR) of executing file returns -ETXTBSY ========================================================== 13:46:06 (1782927966) [ 324.275861] Lustre: DEBUG MARKER: == sanityn test 14b: truncate of executing file returns -ETXTBSY ================================================================ 13:46:08 (1782927968) [ 326.427735] Lustre: DEBUG MARKER: == sanityn test 14c: open(O_TRUNC) of executing file return -ETXTBSY ============================================================ 13:46:10 (1782927970) [ 328.544763] Lustre: DEBUG MARKER: == sanityn test 14d: chmod of executing file is still possible ================================================================== 13:46:12 (1782927972) [ 329.114733] Lustre: DEBUG MARKER: chmod [ 331.181333] Lustre: DEBUG MARKER: == sanityn test 15: test out-of-space with multiple writers ===================================================================== 13:46:15 (1782927975) [ 858.406966] Lustre: DEBUG MARKER: == sanityn test 16a: 2500 iterations of dual-mount fsx === 13:55:02 (1782928502) [ 897.958458] Lustre: DEBUG MARKER: == sanityn test 16b: 2500 iterations of dual-mount fsx at small size ========================================================== 13:55:42 (1782928542) [ 918.071125] Lustre: DEBUG MARKER: == sanityn test 16c: verify data consistency on ldiskfs with cache disabled (b=17397) ========================================================== 13:56:02 (1782928562) [ 951.771926] Lustre: DEBUG MARKER: == sanityn test 16d: Verify DIO and buffer IO with two clients ========================================================== 13:56:35 (1782928595) [ 962.681332] Lustre: DEBUG MARKER: == sanityn test 16e: Verify size consistency for O_DIRECT write ========================================================== 13:56:46 (1782928606) [ 964.983651] Lustre: DEBUG MARKER: == sanityn test 16f: rw sequential consistency vs drop_caches ========================================================== 13:56:49 (1782928609) [ 965.494565] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.520639] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.542457] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.567085] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.589307] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.610345] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.632261] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.652059] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.673458] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.692824] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.712128] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.736987] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.760752] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.781695] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.802203] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.822762] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.842166] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.866152] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.885423] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.908120] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.931223] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.951357] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.971033] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 965.993416] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.012035] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.032241] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.054661] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.079117] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.102280] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.124038] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.143189] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.166457] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.188206] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.208671] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.231574] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.254487] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.279284] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.301770] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.322338] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.341726] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.365494] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.385678] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.408187] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.432491] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.454204] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.475300] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.497952] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.520323] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.542554] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.566418] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.587759] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.608384] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.630930] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.654928] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.676431] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.697285] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.717375] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.736492] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.757189] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.779408] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.800384] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.824439] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.845151] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.869648] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.896090] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.918541] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.940501] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.964167] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 966.987605] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.010529] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.030567] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.052764] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.074143] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.094925] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.116768] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.142501] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.164988] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.186123] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.205678] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.224773] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.245812] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.266455] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.288068] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.308533] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.329275] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.350980] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.374040] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.393391] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.413036] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.435367] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.464435] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.484540] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.503981] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.528396] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.550046] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.569757] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.590896] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.613275] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.634031] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.655679] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.679773] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.703296] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.725082] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.749021] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.772881] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.793445] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.815527] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.834834] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.855295] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.876833] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.898026] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.919483] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.940047] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.960760] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 967.982060] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.005474] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.026723] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.046358] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.065662] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.089055] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.108781] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.128939] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.147896] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.166901] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.188062] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.210380] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.230250] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.251161] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.271458] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.289753] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.309890] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.327712] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.347559] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.370250] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.391546] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.412670] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.432674] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.456934] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.477821] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.497090] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.517146] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.537644] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.558134] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.578786] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.601175] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.620694] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.640285] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.659204] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.678192] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.697978] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.719285] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.739076] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.759902] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.782952] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.802386] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.827359] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.853846] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.877957] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.898713] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.918873] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.939590] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.959057] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 968.979547] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.001559] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.021739] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.041556] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.066536] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.088285] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.109660] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.130847] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.151532] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.170666] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.197202] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.217154] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.238059] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.262292] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.282744] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.305213] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.327864] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.351442] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.375259] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.398311] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.423937] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.447225] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.468642] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.487782] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.511763] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.532426] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.559612] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.579764] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.599702] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.620694] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.643757] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.664761] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.685800] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.709691] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.729926] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.748573] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.772463] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.794256] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.818353] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.837678] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.863988] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.891097] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.912422] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.934957] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.957110] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 969.982303] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.004745] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.028675] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.050385] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.070461] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.092578] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.119264] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.146224] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.167748] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.189689] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.217712] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.246600] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.274398] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.296919] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.322643] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.349054] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.369388] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.394979] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.415811] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.438439] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.458987] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.478945] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.498723] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.518927] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.540661] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.561559] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.579702] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.598735] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.618246] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.636653] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.659368] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.682446] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.704083] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.727384] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.749327] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.770565] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.795703] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.816856] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.841797] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.863255] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.888745] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.909934] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.930997] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.953059] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.973531] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 970.993377] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.013924] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.035217] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.055085] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.076440] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.094634] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.115021] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.134586] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.155204] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.176185] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.198133] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.221819] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.247763] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.272928] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.295876] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.319114] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.340567] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.363228] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.386865] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.407856] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.428119] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.446896] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.466361] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.485985] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.504963] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.524920] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.544849] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.566421] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.591675] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.612976] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.636858] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.656769] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.681089] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.704390] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.724453] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.745844] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.766646] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.786089] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.805858] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.825327] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.845896] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.867287] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.889261] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.912448] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.934234] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.955111] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.975441] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 971.995773] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.015974] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.035201] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.056499] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.078667] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.102394] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.124371] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.144744] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.165310] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.186898] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.209267] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.227908] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.247392] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.270094] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.290601] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.309950] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.331198] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.351092] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.371600] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.391718] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.411553] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.435748] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.456675] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.479884] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.502813] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.524753] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.543975] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.562964] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.588379] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.607395] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.627296] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.651322] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.672305] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.694085] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.713934] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.734648] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.754521] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.774873] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.796098] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.816588] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.837037] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.858191] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.879098] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.899545] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.924750] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.945542] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.968978] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 972.990504] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.012235] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.037283] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.057241] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.076300] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.101061] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.121714] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.144906] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.166120] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.186760] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.208945] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.233442] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.255347] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.278909] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.301616] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.324375] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.348497] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.372297] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.399360] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.422572] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.445937] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.467731] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.495431] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.522392] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.544574] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.571848] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.600058] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.621617] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.644806] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.665804] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.692633] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.714681] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.744612] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.773026] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.799115] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.822859] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.851048] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.875205] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.898386] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.917492] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.937779] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.959566] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 973.979875] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.000652] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.023254] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.042803] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.062856] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.086210] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.111100] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.130193] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.153726] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.175261] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.195955] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.216569] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.238810] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.258085] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.279219] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.299029] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.320217] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.339556] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.360152] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.383908] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.406052] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.431085] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.452677] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.472556] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.498000] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.520831] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.544626] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.566517] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.590853] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.614087] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.634020] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.655394] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.678269] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.701614] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.724836] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.745844] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.766584] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.785639] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.806765] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.826753] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.848587] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.870925] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.894075] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.916153] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.937750] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.957447] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 974.977540] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.001388] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.028855] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.050914] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.077294] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.099990] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.124022] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.144928] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.170859] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.192916] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.216250] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.235836] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.255869] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.276609] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.298186] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.320925] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.343253] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.367349] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.392026] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.413125] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.437907] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.460385] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.481517] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.507560] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.530079] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.551178] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.574734] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.597734] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.621230] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.641744] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.665220] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.692939] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.719133] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.744479] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.768274] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.790179] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.814095] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.837251] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.864941] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.887425] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.912732] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.936038] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.961036] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 975.984983] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.006802] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.029173] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.045507] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.066048] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.083509] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.100832] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.119634] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.137848] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.157181] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.180532] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.196780] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.216661] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.233823] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.249963] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.266248] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.291988] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.327243] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.358138] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.387857] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.415493] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.441780] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.468046] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.489376] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.507417] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.525862] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.546316] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.566735] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.585981] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.604253] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.634626] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.654567] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.678657] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.699342] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.717974] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.737950] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.756360] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.775560] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.793903] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.813405] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.831993] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.852717] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.871710] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.889641] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.908330] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.928463] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.949346] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.967532] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 976.985573] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.005183] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.022338] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.040531] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.059195] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.077459] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.095735] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.113748] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.132129] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.150163] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.168650] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.186259] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.206055] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.224247] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.241442] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.258487] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.275372] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.291997] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.308620] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.328957] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.348603] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.367948] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.388436] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.406492] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.423781] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.442495] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.462861] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.480162] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.500323] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.517170] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.534200] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.551391] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.568607] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.585876] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.601838] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.618890] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.636402] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.653601] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.669780] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.686417] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.703968] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.721978] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.743285] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.761505] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.778698] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.795673] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.812434] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.833879] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.852729] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.869404] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.886647] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.902469] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.919077] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.935819] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.952538] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.969534] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 977.986598] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.003910] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.020952] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.037584] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.054345] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.072089] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.089995] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.107601] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.132094] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.151623] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.174260] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.197625] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.221053] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.242225] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.262887] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.282918] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.303130] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.319985] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.338275] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.356379] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.375089] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.392805] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.409261] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.428611] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.444930] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.462311] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.478959] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.497121] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.517958] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.538691] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.559399] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.579318] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.597087] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.614984] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.633708] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.652870] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.671100] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.689134] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.708280] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.729798] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.751414] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.772576] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.792181] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.812652] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.831973] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.854648] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.874577] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.893844] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.911610] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.929947] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.949683] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.967400] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 978.987508] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.009735] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.030210] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.050134] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.067567] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.088932] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.109674] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.128905] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.148070] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.168808] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.187684] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.209398] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.229535] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.249787] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.271978] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.296127] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.323961] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.344577] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.370631] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.390198] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.407360] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.423788] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.441277] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.459540] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.478767] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.497371] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.515026] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.536142] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.555257] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.575934] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.599395] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.619685] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.637228] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.656793] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.674890] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.697868] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.726801] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.750880] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.774707] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.794115] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.815389] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.835377] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.855646] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.874559] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.898391] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.920896] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.938959] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.956017] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.973739] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 979.993874] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.015201] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.032736] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.047845] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.063415] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.082433] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.101222] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.120091] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.137873] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.154507] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.173721] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.193564] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.213572] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.238683] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.259559] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.278632] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.297064] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.315286] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.334242] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.351568] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.372795] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.396505] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.415532] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.433329] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.451885] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.469128] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.490150] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.511664] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.531099] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.547924] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.565978] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.583918] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.601881] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.619756] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.640497] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.659709] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.678902] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.697718] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.718310] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.736517] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.755941] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.774371] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.792560] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.814722] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.834752] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.852476] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.870533] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.889990] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.909280] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.927987] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.947400] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.966601] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 980.985314] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.002264] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.019932] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.039087] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.057188] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.076534] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.094634] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.113401] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.132545] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.150438] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.172648] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.205433] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.231018] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.260707] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.279224] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.302696] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.327675] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.356102] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.383620] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.409479] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.438632] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.462679] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.493351] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.521882] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.550367] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.578717] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.598174] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.618939] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.637683] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.662843] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.681960] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.702957] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.725474] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.745524] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.764630] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.786363] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.805350] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.826859] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.853675] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.883478] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.911730] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.942169] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.969139] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 981.993094] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.016864] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.044285] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.066875] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.089521] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.120540] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.143517] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.164598] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.195947] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.221735] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.243039] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.268616] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.289688] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.310698] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.330735] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.352501] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.372912] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.399104] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.419258] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.438711] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.458841] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.479641] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.502118] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.523175] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.542379] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.560896] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.580668] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.602390] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.625489] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.649797] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.672863] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.696238] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.718710] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.742892] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.763586] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.783857] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.802610] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.822797] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.844328] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.865971] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.887466] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.908225] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.929028] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.950837] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.976315] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 982.997385] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.019428] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.040384] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.062195] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.082448] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.102509] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.125468] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.146621] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.169413] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.190426] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.215540] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.240803] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.266172] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.295052] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.319396] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.343867] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.367091] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.390248] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.412722] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.434707] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.455223] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.478796] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.504153] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.525365] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.546851] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.568888] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.593332] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.616232] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.640593] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.663988] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.685623] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.708252] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.733075] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.753770] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.775683] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.796729] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.819641] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.843669] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.866812] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.889263] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.911447] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.931954] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.953118] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.973870] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 983.993905] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.015153] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.035736] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.055991] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.076909] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.096670] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.116676] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.141067] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.162042] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.182992] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.204039] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.224263] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.245595] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.269257] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.293357] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.312792] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.335660] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.358373] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.379662] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.402066] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.422228] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.442592] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.464105] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.486186] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.511975] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.534079] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.554662] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.576091] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.599135] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.621856] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.641991] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.660864] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.684436] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.704738] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.726258] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.747150] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.767135] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.787885] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.811939] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.835793] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.858910] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.882933] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.907357] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.931068] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.951275] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.971707] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 984.995272] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 985.020647] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 985.039657] rw_seq_cst_vs_d (32494): drop_caches: 3 [ 986.592178] Lustre: lustre-OST0000-osc-ffff8dfe097ee800: disconnect after 24s idle [ 986.593974] Lustre: Skipped 1 previous similar message [ 987.484501] Lustre: DEBUG MARKER: == sanityn test 16g: mmap rw sequential consistency vs drop_caches ========================================================== 13:57:11 (1782928631) [ 987.583661] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.648696] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.666070] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.705255] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.722942] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.741732] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.759624] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.775367] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.871621] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.907703] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.950985] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.972296] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 987.989681] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.023780] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.041386] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.057987] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.074652] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.092554] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.112047] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.560043] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.581598] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.596263] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.656513] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.713804] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.747194] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.763741] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.797481] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.812268] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.829992] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.851993] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.925971] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.939966] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.956394] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.970300] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 988.986373] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.002743] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.018934] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.035101] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.050866] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.064544] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.080427] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.101941] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.121776] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.243332] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.280994] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.297302] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.314954] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.331257] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.346726] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.361869] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.380888] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.437345] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.461690] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.478909] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.495694] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.509743] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.523952] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.538737] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.553626] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.570353] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.587553] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.610864] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.637124] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.659296] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.682307] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.704774] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.725760] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.741208] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.756714] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.771714] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.804862] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.819903] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.840023] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.864212] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.880650] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.896385] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.913112] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.936346] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.957171] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 989.995079] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.013395] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.034028] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.055325] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.137201] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.164222] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.181952] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.203351] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.223627] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.242433] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.260461] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.282169] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.297883] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.314727] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.337429] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.357711] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.375099] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.393042] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.409221] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.428581] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.445373] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.460593] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.475660] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.490514] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.508892] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.566776] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.775980] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.798795] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.821486] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.839191] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.856858] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.971898] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 990.992176] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.013654] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.030343] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.182783] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.199898] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.217974] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.236738] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.251543] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.269509] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.287114] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.304112] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.320549] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.336604] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.351381] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.545390] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.562876] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.729404] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.745720] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.769875] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.790059] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.804899] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.820519] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.837902] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.860539] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.880075] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.897963] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.913045] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.932795] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.947973] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.965227] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.979980] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 991.995517] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.014968] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.030098] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.047387] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.060876] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.075802] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.090148] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.112616] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.135228] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.156375] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.178661] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.242308] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.262774] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.380402] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.399798] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.415993] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.438634] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.472641] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.529452] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.544196] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.565483] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.682738] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.701423] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.720444] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.737892] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.752744] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.768870] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.813380] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.920088] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.938565] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.955926] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.977390] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 992.997272] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.011515] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.029323] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.046116] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.066922] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.189279] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.227273] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.243608] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.287581] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.344891] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.361277] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.381955] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.399231] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.416813] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.434920] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.473815] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.511923] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.528986] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.550786] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.577051] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.599719] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.617557] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.650127] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.663346] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.683469] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.698666] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.714450] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.789358] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.805064] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.822269] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.848423] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.924907] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.941992] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.959555] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.975785] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 993.992528] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.010817] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.027374] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.063129] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.079872] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.176362] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.190341] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.204838] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.269388] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.288719] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.304319] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.318341] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.333046] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.346968] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.363897] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.380256] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.456863] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.479048] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.516553] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.531475] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.546888] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.569636] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.631956] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.667417] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.704697] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.721122] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.741841] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.756702] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.818414] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.843770] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.908470] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.923562] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.939514] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 994.956686] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.311284] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.325902] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.345187] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.365503] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.386742] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.402088] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.487178] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.502197] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.517766] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.539489] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.555288] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.572171] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.588522] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.604920] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.622334] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.639465] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.655461] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.670587] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.708421] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.724193] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.741778] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.758757] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.777508] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.826121] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.841129] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.860348] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.885157] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.909502] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.955874] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.972430] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 995.987601] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.003369] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.019295] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.035908] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.051692] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.068205] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.084477] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.100507] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.121161] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.161279] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.179619] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.201471] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.219377] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.374274] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.391523] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.408066] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.423738] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.442454] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.713255] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.738377] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.756351] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.775944] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.798848] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.817342] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.850100] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.884514] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.917328] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.946267] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 996.973644] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.167722] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.189702] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.479781] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.494091] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.510921] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.528984] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.550991] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.573888] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.595633] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.655268] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.671554] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.694764] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.731252] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.748204] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.762831] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.893728] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.911610] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.939853] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 997.984481] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.006075] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.022883] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.042417] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.058431] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.075466] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.093681] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.110133] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.129197] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.429106] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.498130] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.519161] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.537368] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.554796] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.571268] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.585357] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.602544] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.625834] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.643056] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.663124] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.720533] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.737451] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.871129] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.886603] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.907150] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 998.933815] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.051115] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.097414] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.116713] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.132445] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.152249] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.354746] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.480935] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.497209] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.514213] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.530548] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.549640] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.570750] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.592492] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.610092] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.752912] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.769279] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.835402] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.850750] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.866283] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.881530] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.900724] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.979570] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 999.994512] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.010494] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.109204] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.128267] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.148914] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.169099] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.184161] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.199397] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.219811] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.240355] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.341420] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.364642] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.399668] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.415301] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.430550] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.446204] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.461301] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.474428] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.519866] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.579057] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.638218] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.652356] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.667237] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.681661] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.696673] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.711386] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.745794] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.760335] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.775055] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.790425] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.824791] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.839515] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.854372] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.870161] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.884950] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.899359] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.914134] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1000.932859] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.082532] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.101338] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.121404] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.137118] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.153963] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.176300] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.191796] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.206917] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.227843] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.250192] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.271360] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.287066] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.302163] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.380834] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.396570] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.412644] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.429780] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.447435] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.576799] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.596164] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.611676] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.627751] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.642205] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.657399] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.675962] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.696940] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.712678] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.734206] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.749115] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.763826] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.778763] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.796762] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.813754] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.839365] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.880182] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1001.979246] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.001692] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.018864] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.035630] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.052442] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.069224] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.090979] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.107708] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.123785] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.145920] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.167175] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.184417] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.209721] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.228808] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.248103] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.269601] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.398537] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.421959] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.439443] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.507632] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.522670] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.752025] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.768077] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.887611] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.911173] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.930208] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.950412] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.966191] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1002.983311] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.017215] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.036870] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.052924] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.069073] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.085693] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.103974] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.167698] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.189709] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.206042] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.270600] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.292985] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.314142] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.329134] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.344404] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.462569] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.477229] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.492551] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.529993] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.550506] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.564831] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.580363] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.595209] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.635467] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.657663] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.672335] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.688711] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.704314] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.720455] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.738545] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.756434] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.834405] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.856654] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.879503] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.916148] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.933593] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.949895] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1003.973654] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.243233] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.260470] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.282405] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.326927] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.351076] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.373828] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.393989] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.473927] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.523600] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.591221] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.615869] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.638208] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.660428] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.698391] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.719330] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.737323] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.817054] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.839241] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.860801] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.898326] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.917504] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.934090] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.950454] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.964218] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.980129] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1004.997114] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.017656] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.038697] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.059092] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.074142] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.089182] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.102508] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.121103] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.137793] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.176485] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.196016] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.210358] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.224479] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.240151] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.259930] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.279157] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.293622] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.313095] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.361246] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.376627] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.398278] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.421759] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.477726] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.492894] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.510204] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.525116] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.540243] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.557160] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.578538] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.599859] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.655084] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.669878] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.685266] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.799689] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.814140] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.828520] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.843392] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.860367] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.876420] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.893553] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.936029] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.953348] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.967918] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.981818] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1005.998745] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.014133] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.114872] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.130238] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.145016] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.197553] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.212753] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.230286] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.382227] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.405669] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.427505] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.445460] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.468339] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.493501] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.591886] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.764732] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.782546] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.838991] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.877378] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.936360] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1006.993695] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.016873] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.057280] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.117314] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.144589] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.280910] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.316659] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.345461] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.423045] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.463042] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1007.520297] rw_seq_cst_vs_d (33074): drop_caches: 3 [ 1009.958879] Lustre: DEBUG MARKER: == sanityn test 16h: mmap read after truncate file ======= 13:57:33 (1782928653) [ 1012.166756] Lustre: DEBUG MARKER: == sanityn test 16i: read after truncate file ============ 13:57:36 (1782928656) [ 1014.429443] Lustre: DEBUG MARKER: == sanityn test 16j: race dio with buffered i/o ========== 13:57:38 (1782928658) [ 1022.734197] Lustre: DEBUG MARKER: == sanityn test 16k: Parallel FSX and drop caches should not panic ========================================================== 13:57:46 (1782928666) [ 1022.939448] bash (35555): drop_caches: 3 [ 1026.073680] bash (35555): drop_caches: 3 [ 1029.189894] bash (35555): drop_caches: 3 [ 1032.318951] bash (35555): drop_caches: 3 [ 1035.894471] Lustre: DEBUG MARKER: == sanityn test 17: resource creation/LVB creation race ========================================================================= 13:57:59 (1782928679) [ 1040.460833] Lustre: DEBUG MARKER: == sanityn test 18: mmap sanity check =========================================================================================== 13:58:04 (1782928684) [ 1052.009432] Lustre: DEBUG MARKER: == sanityn test 19: test concurrent uncached read races ========================================================================= 13:58:16 (1782928696) [ 1054.944226] Lustre: DEBUG MARKER: loop 5 [ 1056.705240] Lustre: DEBUG MARKER: loop 10 [ 1058.524938] Lustre: DEBUG MARKER: loop 15 [ 1060.304587] Lustre: DEBUG MARKER: loop 20 [ 1063.037303] Lustre: DEBUG MARKER: == sanityn test 20: test extra readahead page left in cache ============================================================== 13:58:27 (1782928707) [ 1065.196080] Lustre: DEBUG MARKER: == sanityn test 21: Try to remove mountpoint on another dir ============================================================== 13:58:29 (1782928709) [ 1067.288075] Lustre: DEBUG MARKER: == sanityn test 23: others should see updated atime while another read============================================================== 13:58:31 (1782928711) [ 1083.871193] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 21s idle [ 1088.991246] Lustre: lustre-OST0000-osc-ffff8dfe07e99800: disconnect after 21s idle [ 1088.993435] Lustre: Skipped 2 previous similar messages [ 1130.884959] Lustre: DEBUG MARKER: == sanityn test 24a: lfs df [-ih] [path] test =================================================================================== 13:59:34 (1782928774) [ 1133.010303] Lustre: DEBUG MARKER: == sanityn test 24b: lfs df should show both filesystems ========================================================================= 13:59:37 (1782928777) [ 1135.136993] Lustre: DEBUG MARKER: == sanityn test 25a: change ACL on one mountpoint be seen on another ============================================================= 13:59:39 (1782928779) [ 1137.395621] Lustre: DEBUG MARKER: == sanityn test 25b: change ACL under remote dir on one mountpoint be seen on another ========================================================== 13:59:41 (1782928781) [ 1139.627214] Lustre: DEBUG MARKER: == sanityn test 26a: allow mtime to get older ============ 13:59:43 (1782928783) [ 1142.878103] Lustre: DEBUG MARKER: == sanityn test 26b: sync mtime between ost and mds ====== 13:59:46 (1782928786) [ 1147.029752] Lustre: DEBUG MARKER: == sanityn test 26c: set-in-past on open file is not lost on close ========================================================== 13:59:51 (1782928791) [ 1150.226064] Lustre: DEBUG MARKER: SKIP: sanityn test_27 skipping excluded test 27 [ 1150.734656] Lustre: DEBUG MARKER: == sanityn test 30: recreate file race =================== 13:59:54 (1782928794) [ 1154.803389] Lustre: DEBUG MARKER: == sanityn test 31a: voluntary cancel / blocking ast race======================================================================== 13:59:58 (1782928798) [ 1154.925189] Lustre: *** cfs_fail_loc=314, val=0*** [ 1155.935231] Lustre: *** cfs_fail_loc=314, val=0*** [ 1155.936563] Lustre: Skipped 2 previous similar messages [ 1157.905275] Lustre: DEBUG MARKER: == sanityn test 31b: voluntary OST cancel / blocking ast race======================================================================== 14:00:01 (1782928801) [ 1162.998275] Lustre: *** cfs_fail_loc=314, val=0*** [ 1162.999532] Lustre: Skipped 1 previous similar message [ 1163.024033] LustreError: lustre-OST0000-osc-ffff8dfe097ee800: operation ldlm_enqueue to node 192.168.203.114@tcp failed: rc = -107 [ 1163.027054] Lustre: lustre-OST0000-osc-ffff8dfe097ee800: Connection to lustre-OST0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1163.032449] LustreError: lustre-OST0000-osc-ffff8dfe097ee800: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1163.036938] Lustre: 2392:0:(llite_lib.c:4202:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.114@tcp:/lustre/fid: [0x240000403:0x2:0x0]// may get corrupted (rc -108) [ 1163.043730] LustreError: 46536:0:(ldlm_resource.c:1207:ldlm_resource_complain()) lustre-OST0000-osc-ffff8dfe097ee800: namespace resource [0x280000401:0x37:0x0].0x0 (ffff8dfe07e4dd00) refcount nonzero (1) after lock cleanup; forcing cleanup. [ 1163.050908] Lustre: lustre-OST0000-osc-ffff8dfe097ee800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 1165.306151] Lustre: DEBUG MARKER: == sanityn test 31r: open-rename(replace) race =========== 14:00:09 (1782928809) [ 1165.395723] LustreError: 47126:0:(file.c:818:ll_intent_file_open()) cfs_fail_timeout id 1419 sleeping for 3000ms [ 1168.415184] LustreError: 47126:0:(file.c:818:ll_intent_file_open()) cfs_fail_timeout id 1419 awake [ 1170.517358] Lustre: DEBUG MARKER: == sanityn test 31s: open should not revalidate invalid dentry ========================================================== 14:00:14 (1782928814) [ 1173.079556] Lustre: DEBUG MARKER: == sanityn test 31t: getattr should not revalidate invalid dentry ========================================================== 14:00:17 (1782928817) [ 1176.100277] Lustre: DEBUG MARKER: == sanityn test 32b: lockless i/o ======================== 14:00:20 (1782928820) [ 1176.643128] Lustre: DEBUG MARKER: SKIP: sanityn test_32b max_nolock_bytes is removed >= 2.17.53 [ 1177.175801] Lustre: DEBUG MARKER: == sanityn test 32c: contention detection ================ 14:00:21 (1782928821) [ 1188.213730] Lustre: DEBUG MARKER: SKIP: sanityn test_33a skipping SLOW test 33a [ 1188.743433] Lustre: DEBUG MARKER: == sanityn test 33b: COS: cross create/delete, 2 clients, benchmark under remote dir ========================================================== 14:00:32 (1782928832) [ 1189.280218] Lustre: DEBUG MARKER: SKIP: sanityn test_33b Need two or more clients, have 1 [ 1189.804504] Lustre: DEBUG MARKER: == sanityn test 33c: Cancel cross-MDT lock should trigger Sync-on-Lock-Cancel ========================================================== 14:00:33 (1782928833) [ 1191.393006] Lustre: lustre-MDT0000-mdc-ffff8dfe07e99800: Connection to lustre-MDT0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1196.513349] LustreError: MGC192.168.203.114@tcp: Connection to MGS (at 192.168.203.114@tcp) was lost; in progress operations using this service will fail [ 1196.520711] Lustre: Evicted from MGS (at 192.168.203.114@tcp) after server handle changed from 0xe54938e46d3d79ca to 0xe54938e46d671abe [ 1196.529297] Lustre: MGC192.168.203.114@tcp: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 1198.889872] Lustre: lustre-MDT0000-mdc-ffff8dfe097ee800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 1206.752169] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 23s idle [ 1210.422346] Lustre: DEBUG MARKER: == sanityn test 33d: dependent transactions should trigger COS ========================================================== 14:00:54 (1782928854) [ 1211.871206] Lustre: lustre-OST0000-osc-ffff8dfe07e99800: disconnect after 22s idle [ 1227.232188] Lustre: lustre-OST0001-osc-ffff8dfe097ee800: disconnect after 23s idle [ 1228.298923] Lustre: DEBUG MARKER: == sanityn test 33e: independent transactions shouldn't trigger COS ========================================================== 14:01:12 (1782928872) [ 1233.639111] Lustre: DEBUG MARKER: == sanityn test 34: no lock timeout under IO ============= 14:01:17 (1782928877) [ 1257.951381] Lustre: lustre-OST0000-osc-ffff8dfe07e99800: disconnect after 24s idle [ 1282.493323] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: Connection to lustre-OST0001 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1282.498829] Lustre: Skipped 1 previous similar message [ 1282.502581] LustreError: lustre-OST0001-osc-ffff8dfe097ee800: This client was evicted by lustre-OST0001; in progress operations using this service will fail. [ 1282.507295] LustreError: lustre-OST0001-osc-ffff8dfe07e99800: This client was evicted by lustre-OST0001; in progress operations using this service will fail. [ 1282.507574] Lustre: lustre-OST0001-osc-ffff8dfe097ee800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 1282.514591] Lustre: Skipped 2 previous similar messages [ 1298.913070] Lustre: lustre-OST0000-osc-ffff8dfe07e99800: Connection to lustre-OST0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1298.918294] Lustre: Skipped 1 previous similar message [ 1298.921116] LustreError: lustre-OST0000-osc-ffff8dfe07e99800: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1298.926443] Lustre: lustre-OST0000-osc-ffff8dfe07e99800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 1304.031225] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 21s idle [ 1304.034080] Lustre: Skipped 1 previous similar message [ 1309.525203] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff8dfe07e99800.ost_server_uuid 50 [ 1310.012571] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff8dfe07e99800.ost_server_uuid in FULL state after 0 sec [ 1311.843952] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8dfe07e99800.ost_server_uuid 50 [ 1312.383272] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8dfe07e99800.ost_server_uuid in IDLE state after 0 sec [ 1314.537644] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff8dfe07e99800.ost_server_uuid 50 [ 1315.011566] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff8dfe07e99800.ost_server_uuid in FULL state after 0 sec [ 1316.820545] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8dfe07e99800.ost_server_uuid 50 [ 1317.323370] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8dfe07e99800.ost_server_uuid in IDLE state after 0 sec [ 1321.031914] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff8dfe07e99800.ost_server_uuid 50 [ 1321.560890] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff8dfe07e99800.ost_server_uuid in IDLE state after 0 sec [ 1323.469574] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8dfe07e99800.ost_server_uuid 50 [ 1323.994723] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8dfe07e99800.ost_server_uuid in IDLE state after 0 sec [ 1324.579752] Lustre: DEBUG MARKER: == sanityn test 35: -EINTR cp_ast vs. bl_ast race does not evict client ========================================================== 14:02:48 (1782928968) [ 1325.467895] Lustre: DEBUG MARKER: Race attempt 0 [ 1327.102387] Lustre: DEBUG MARKER: Wait for 59716 59851 for 60 sec... [ 1389.401865] Lustre: DEBUG MARKER: == sanityn test 36: handle ESTALE/open-unlink correctly == 14:03:53 (1782929033) [ 1394.677991] Lustre: DEBUG MARKER: start test - cycle (0) [ 1410.708874] Lustre: DEBUG MARKER: start test - cycle (1) [ 1425.382246] Lustre: DEBUG MARKER: start test - cycle (2) [ 1439.844986] Lustre: DEBUG MARKER: start test - cycle (3) [ 1454.355873] Lustre: DEBUG MARKER: start test - cycle (4) [ 1470.677572] Lustre: DEBUG MARKER: start test - cycle (5) [ 1485.166362] Lustre: DEBUG MARKER: start test - cycle (6) [ 1501.193574] Lustre: DEBUG MARKER: start test - cycle (7) [ 1515.952717] Lustre: DEBUG MARKER: start test - cycle (8) [ 1531.740375] Lustre: DEBUG MARKER: start test - cycle (9) [ 1547.689170] Lustre: DEBUG MARKER: start test - cycle (10) [ 1564.753046] Lustre: DEBUG MARKER: == sanityn test 37: check i_size is not updated for directory on close (bug 18695) ======================================================================== 14:06:48 (1782929208) [ 1575.391133] Lustre: lustre-OST0001-osc-ffff8dfe097ee800: disconnect after 23s idle [ 1575.393158] Lustre: Skipped 2 previous similar messages [ 1579.187599] Lustre: DEBUG MARKER: == sanityn test 39a: file mtime does not change after rename ========================================================== 14:07:03 (1782929223) [ 1581.647908] Lustre: DEBUG MARKER: == sanityn test 39b: file mtime the same on clients with/out lock ========================================================== 14:07:05 (1782929225) [ 1584.912920] Lustre: DEBUG MARKER: == sanityn test 39c: check truncate mtime update ================================================================================ 14:07:08 (1782929228) [ 1588.188862] Lustre: DEBUG MARKER: == sanityn test 39d: sync write should update mtime ====== 14:07:12 (1782929232) [ 1588.267070] Lustre: *** cfs_fail_loc=411, val=0*** [ 1590.341474] Lustre: DEBUG MARKER: SKIP: sanityn test_40a skipping ALWAYS excluded test 40a [ 1590.925648] Lustre: DEBUG MARKER: == sanityn test 40b: pdirops: open|create and others ======================================================================== 14:07:14 (1782929234) [ 1599.523578] Lustre: DEBUG MARKER: == sanityn test 40c: pdirops: link and others ======================================================================== 14:07:23 (1782929243) [ 1607.726127] Lustre: DEBUG MARKER: == sanityn test 40d: pdirops: unlink and others ======================================================================== 14:07:31 (1782929251) [ 1615.712627] Lustre: DEBUG MARKER: == sanityn test 40e: pdirops: rename and others ======================================================================== 14:07:39 (1782929259) [ 1623.326189] Lustre: DEBUG MARKER: == sanityn test 41a: pdirops: create vs mkdir ======================================================================== 14:07:47 (1782929267) [ 1628.676193] Lustre: DEBUG MARKER: == sanityn test 41b: pdirops: create vs create ======================================================================== 14:07:52 (1782929272) [ 1634.117267] Lustre: DEBUG MARKER: == sanityn test 41c: pdirops: create vs link ======================================================================== 14:07:58 (1782929278) [ 1639.271631] Lustre: DEBUG MARKER: == sanityn test 41d: pdirops: create vs unlink ======================================================================== 14:08:03 (1782929283) [ 1644.556490] Lustre: DEBUG MARKER: == sanityn test 41e: pdirops: create and rename (tgt) ======================================================================== 14:08:08 (1782929288) [ 1649.868201] Lustre: DEBUG MARKER: == sanityn test 41f: pdirops: create and rename (src) ======================================================================== 14:08:13 (1782929293) [ 1655.144139] Lustre: DEBUG MARKER: == sanityn test 41g: pdirops: create vs getattr ======================================================================== 14:08:19 (1782929299) [ 1660.503381] Lustre: DEBUG MARKER: == sanityn test 41h: pdirops: create vs readdir ======================================================================== 14:08:24 (1782929304) [ 1665.630729] Lustre: DEBUG MARKER: == sanityn test 41i: reint_open: create vs create ======== 14:08:29 (1782929309) [ 2287.071197] Lustre: lustre-OST0000-osc-ffff8dfe097ee800: disconnect after 22s idle [ 2287.074860] Lustre: Skipped 4 previous similar messages [ 2407.022824] Lustre: DEBUG MARKER: == sanityn test 42a: pdirops: mkdir vs mkdir ======================================================================== 14:20:50 (1782930050) [ 2412.938636] Lustre: DEBUG MARKER: == sanityn test 42b: pdirops: mkdir vs create ======================================================================== 14:20:56 (1782930056) [ 2418.593458] Lustre: DEBUG MARKER: == sanityn test 42c: pdirops: mkdir vs link ======================================================================== 14:21:02 (1782930062) [ 2424.177761] Lustre: DEBUG MARKER: == sanityn test 42d: pdirops: mkdir vs unlink ======================================================================== 14:21:08 (1782930068) [ 2429.514359] Lustre: DEBUG MARKER: == sanityn test 42e: pdirops: mkdir and rename (tgt) ======================================================================== 14:21:13 (1782930073) [ 2435.262077] Lustre: DEBUG MARKER: == sanityn test 42f: pdirops: mkdir and rename (src) ======================================================================== 14:21:19 (1782930079) [ 2440.972454] Lustre: DEBUG MARKER: == sanityn test 42g: pdirops: mkdir vs getattr ======================================================================== 14:21:24 (1782930084) [ 2446.734088] Lustre: DEBUG MARKER: == sanityn test 42h: pdirops: mkdir vs readdir ======================================================================== 14:21:30 (1782930090) [ 2452.314776] Lustre: DEBUG MARKER: == sanityn test 43a: rmdir,mkdir doesn't return -EEXIST ======================================================================== 14:21:36 (1782930096) [ 2482.417312] Lustre: DEBUG MARKER: == sanityn test 43b: pdirops: unlink vs create ======================================================================== 14:22:06 (1782930126) [ 2487.983816] Lustre: DEBUG MARKER: == sanityn test 43c: pdirops: unlink vs link ======================================================================== 14:22:11 (1782930131) [ 2493.473036] Lustre: DEBUG MARKER: == sanityn test 43d: pdirops: unlink vs unlink ======================================================================== 14:22:17 (1782930137) [ 2499.039474] Lustre: DEBUG MARKER: == sanityn test 43e: pdirops: unlink and rename (tgt) ======================================================================== 14:22:23 (1782930143) [ 2504.490565] Lustre: DEBUG MARKER: == sanityn test 43f: pdirops: unlink and rename (src) ======================================================================== 14:22:28 (1782930148) [ 2509.812251] Lustre: DEBUG MARKER: == sanityn test 43g: pdirops: unlink vs getattr ======================================================================== 14:22:33 (1782930153) [ 2515.380817] Lustre: DEBUG MARKER: == sanityn test 43h: pdirops: unlink vs readdir ======================================================================== 14:22:39 (1782930159) [ 2520.791726] Lustre: DEBUG MARKER: == sanityn test 43i: pdirops: unlink vs remote mkdir ===== 14:22:44 (1782930164) [ 2526.128752] Lustre: DEBUG MARKER: == sanityn test 43j: racy mkdir return EEXIST ======================================================================== 14:22:50 (1782930170) [ 2548.191218] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 24s idle [ 2548.193828] Lustre: Skipped 4 previous similar messages [ 2567.914154] Lustre: DEBUG MARKER: == sanityn test 43k: unlink vs create ==================== 14:23:31 (1782930211) [ 3016.914288] Lustre: DEBUG MARKER: == sanityn test 44a: pdirops: rename tgt vs mkdir ======================================================================== 14:31:00 (1782930660) [ 3022.178145] Lustre: DEBUG MARKER: == sanityn test 44b: pdirops: rename tgt vs create ======================================================================== 14:31:06 (1782930666) [ 3027.318770] Lustre: DEBUG MARKER: == sanityn test 44c: pdirops: rename tgt vs link ======================================================================== 14:31:11 (1782930671) [ 3032.362465] Lustre: DEBUG MARKER: == sanityn test 44d: pdirops: rename tgt vs unlink ======================================================================== 14:31:16 (1782930676) [ 3037.431255] Lustre: DEBUG MARKER: == sanityn test 44e: pdirops: rename tgt and rename (tgt) ======================================================================== 14:31:21 (1782930681) [ 3042.313637] Lustre: DEBUG MARKER: == sanityn test 44f: pdirops: rename tgt and rename (src) ======================================================================== 14:31:26 (1782930686) [ 3047.358896] Lustre: DEBUG MARKER: == sanityn test 44g: pdirops: rename tgt vs getattr ======================================================================== 14:31:31 (1782930691) [ 3052.701195] Lustre: DEBUG MARKER: == sanityn test 44h: pdirops: rename tgt vs readdir ======================================================================== 14:31:36 (1782930696) [ 3058.076535] Lustre: DEBUG MARKER: == sanityn test 44i: pdirops: rename tgt vs remote mkdir ========================================================== 14:31:42 (1782930702) [ 3063.434109] Lustre: DEBUG MARKER: == sanityn test 45a: rename,mkdir doesn't return -EEXIST ======================================================================== 14:31:47 (1782930707) [ 3080.671230] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 24s idle [ 3080.673570] Lustre: Skipped 3 previous similar messages [ 3096.914907] Lustre: DEBUG MARKER: == sanityn test 45b: pdirops: rename src vs create ======================================================================== 14:32:20 (1782930740) [ 3101.850384] Lustre: DEBUG MARKER: == sanityn test 45c: pdirops: rename src vs link ======================================================================== 14:32:25 (1782930745) [ 3106.769884] Lustre: DEBUG MARKER: == sanityn test 45d: pdirops: rename src vs unlink ======================================================================== 14:32:30 (1782930750) [ 3111.856761] Lustre: DEBUG MARKER: == sanityn test 45e: pdirops: rename src and rename (tgt) ======================================================================== 14:32:35 (1782930755) [ 3116.921719] Lustre: DEBUG MARKER: == sanityn test 45f: pdirops: rename src and rename (src) ======================================================================== 14:32:40 (1782930760) [ 3122.157590] Lustre: DEBUG MARKER: == sanityn test 45g: pdirops: rename src vs getattr ======================================================================== 14:32:46 (1782930766) [ 3127.302660] Lustre: DEBUG MARKER: == sanityn test 45h: pdirops: unlink vs readdir ======================================================================== 14:32:51 (1782930771) [ 3132.008639] Lustre: DEBUG MARKER: == sanityn test 45i: pdirops: rename src vs remote mkdir ========================================================== 14:32:56 (1782930776) [ 3137.027518] Lustre: DEBUG MARKER: == sanityn test 45j: read vs rename ====================== 14:33:01 (1782930781) [ 3580.432608] Lustre: DEBUG MARKER: == sanityn test 46a: pdirops: link vs mkdir ======================================================================== 14:40:24 (1782931224) [ 3585.536429] Lustre: DEBUG MARKER: == sanityn test 46b: pdirops: link vs create ======================================================================== 14:40:29 (1782931229) [ 3591.094370] Lustre: DEBUG MARKER: == sanityn test 46c: pdirops: link vs link ======================================================================== 14:40:35 (1782931235) [ 3596.136706] Lustre: DEBUG MARKER: == sanityn test 46d: pdirops: link vs unlink ======================================================================== 14:40:40 (1782931240) [ 3601.507982] Lustre: DEBUG MARKER: == sanityn test 46e: pdirops: link and rename (tgt) ======================================================================== 14:40:45 (1782931245) [ 3607.225474] Lustre: DEBUG MARKER: == sanityn test 46f: pdirops: link and rename (src) ======================================================================== 14:40:51 (1782931251) [ 3612.323846] Lustre: DEBUG MARKER: == sanityn test 46g: pdirops: link vs getattr ======================================================================== 14:40:56 (1782931256) [ 3617.653172] Lustre: DEBUG MARKER: == sanityn test 46h: pdirops: link vs readdir ======================================================================== 14:41:01 (1782931261) [ 3622.944732] Lustre: DEBUG MARKER: == sanityn test 46i: pdirops: link vs remote mkdir ======= 14:41:06 (1782931266) [ 3628.672679] Lustre: DEBUG MARKER: == sanityn test 47a: pdirops: remote mkdir vs mkdir ====== 14:41:12 (1782931272) [ 3634.148082] Lustre: DEBUG MARKER: == sanityn test 47b: pdirops: remote mkdir vs create ===== 14:41:18 (1782931278) [ 3640.930493] Lustre: DEBUG MARKER: == sanityn test 47c: pdirops: remote mkdir vs link ======= 14:41:24 (1782931284) [ 3646.102281] Lustre: DEBUG MARKER: == sanityn test 47d: pdirops: remote mkdir vs unlink ===== 14:41:30 (1782931290) [ 3651.250715] Lustre: DEBUG MARKER: == sanityn test 47e: pdirops: remote mkdir and rename (tgt) ========================================================== 14:41:35 (1782931295) [ 3656.474971] Lustre: DEBUG MARKER: == sanityn test 47f: pdirops: remote mkdir and rename (src) ========================================================== 14:41:40 (1782931300) [ 3661.597756] Lustre: DEBUG MARKER: == sanityn test 47g: pdirops: remote mkdir vs getattr ==== 14:41:45 (1782931305) [ 3668.002878] Lustre: DEBUG MARKER: == sanityn test 50: osc lvb attrs: enqueue vs. CP AST ======================================================================== 14:41:52 (1782931312) [ 3668.075056] LustreError: 29483:0:(ldlm_lockd.c:2079:ldlm_handle_cp_callback()) cfs_fail_timeout id 410 sleeping for 2000ms [ 3670.159153] LustreError: 29483:0:(ldlm_lockd.c:2079:ldlm_handle_cp_callback()) cfs_fail_timeout id 410 awake [ 3675.105603] Lustre: DEBUG MARKER: == sanityn test 51a: layout lock: refresh layout should work ========================================================== 14:41:59 (1782931319) [ 3679.201274] Lustre: DEBUG MARKER: == sanityn test 51b: layout lock: glimpse should be able to restart if layout changed ========================================================== 14:42:03 (1782931323) [ 3679.293116] LustreError: 241554:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 3683.351112] LustreError: 241554:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 awake [ 3683.362554] LustreError: 241554:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 3687.423141] LustreError: 241554:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 awake [ 3687.439876] LustreError: 241561:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 3691.495114] LustreError: 241561:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 awake [ 3694.265110] Lustre: DEBUG MARKER: == sanityn test 51c: layout lock: IT_LAYOUT blocked and correct layout can be returned ========================================================== 14:42:18 (1782931338) [ 3701.156870] Lustre: DEBUG MARKER: == sanityn test 51d: layout lock: losing layout lock should clean up memory map region ========================================================== 14:42:25 (1782931345) [ 3704.493886] Lustre: DEBUG MARKER: == sanityn test 51e: lfs getstripe does not break leases, part 2 ========================================================== 14:42:28 (1782931348) [ 3708.799401] Lustre: DEBUG MARKER: == sanityn test 54: rename locking ======================= 14:42:32 (1782931352) [ 3715.551191] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 22s idle [ 3715.553802] Lustre: Skipped 1 previous similar message [ 3733.117585] Lustre: DEBUG MARKER: == sanityn test 55a: rename vs unlink target dir ========= 14:42:57 (1782931377) [ 3740.694215] Lustre: DEBUG MARKER: == sanityn test 55b: rename vs unlink source dir ========= 14:43:04 (1782931384) [ 3748.148546] Lustre: DEBUG MARKER: == sanityn test 55c: rename vs unlink orphan target dir == 14:43:12 (1782931392) [ 3760.945861] Lustre: DEBUG MARKER: == sanityn test 55d: rename file vs link ================= 14:43:24 (1782931404) [ 3770.477566] Lustre: DEBUG MARKER: == sanityn test 55e: rename race AB/BA under the same parent dir ========================================================== 14:43:34 (1782931414) [ 3783.682217] Lustre: DEBUG MARKER: == sanityn test 55f: rename: (P1/A -> P2/B) race with (P2/B -> P1/A) ========================================================== 14:43:47 (1782931427) [ 3796.582017] Lustre: DEBUG MARKER: == sanityn test 55g: rename: race with trylock =========== 14:44:00 (1782931440) [ 3810.743045] Lustre: DEBUG MARKER: == sanityn test 56a: test llverdev with single large stripe ========================================================== 14:44:14 (1782931454) [ 3818.021300] Lustre: DEBUG MARKER: == sanityn test 56b: test llverdev and partial verify of wide stripe file ========================================================== 14:44:22 (1782931462) [ 3847.841621] Lustre: DEBUG MARKER: == sanityn test 60: Verify data_version behaviour ======== 14:44:51 (1782931491) [ 3850.119975] Lustre: DEBUG MARKER: == sanityn test 70a: cd directory [ 3852.370860] Lustre: DEBUG MARKER: == sanityn test 70b: remove files after calling rm_entry ========================================================== 14:44:56 (1782931496) [ 3854.972799] Lustre: DEBUG MARKER: == sanityn test 71a: correct file map just after write operation is finished ========================================================== 14:44:59 (1782931499) [ 3857.163428] Lustre: DEBUG MARKER: == sanityn test 71b: check fiemap support for stripecount > 1 ========================================================== 14:45:01 (1782931501) [ 3859.219352] Lustre: DEBUG MARKER: == sanityn test 71c: check FIEMAP_EXTENT_LAST flag with different extents number ========================================================== 14:45:03 (1782931503) [ 3869.565062] Lustre: DEBUG MARKER: == sanityn test 71d: fiemap corruption test with fm_extent_count=0 ========================================================== 14:45:13 (1782931513) [ 3883.820071] Lustre: DEBUG MARKER: == sanityn test 72: getxattr/setxattr cache should be consistent between nodes ========================================================== 14:45:27 (1782931527) [ 3885.865624] Lustre: DEBUG MARKER: == sanityn test 73: getxattr should not cause xattr lock cancellation ========================================================== 14:45:29 (1782931529) [ 3888.054351] Lustre: DEBUG MARKER: == sanityn test 74: flock deadlock: different mounts ======================================================================== 14:45:32 (1782931532) [ 3891.146850] LustreError: lustre-MDT0000-mdc-ffff8dfe097ee800: operation ldlm_enqueue to node 192.168.203.114@tcp failed: rc = -35 [ 3891.149756] LustreError: Skipped 1 previous similar message [ 3894.079290] Lustre: DEBUG MARKER: == sanityn test 75: osc: upcall after unuse lock============================================================================= 14:45:38 (1782931538) [ 3894.220863] LustreError: 2393:0:(osc_request.c:3138:osc_enqueue_interpret()) cfs_fail_timeout id 31d sleeping for 2000ms [ 3896.311079] LustreError: 2393:0:(osc_request.c:3138:osc_enqueue_interpret()) cfs_fail_timeout id 31d awake [ 3901.224395] Lustre: DEBUG MARKER: == sanityn test 76: Verify MDT open_files listing ======== 14:45:45 (1782931545) [ 3949.936555] Lustre: DEBUG MARKER: == sanityn test 77a: check FIFO NRS policy =============== 14:46:34 (1782931594) [ 3952.552505] Lustre: DEBUG MARKER: == sanityn test 77b: check CRR-N NRS policy ============== 14:46:36 (1782931596) [ 3956.527676] Lustre: DEBUG MARKER: == sanityn test 77c: check ORR NRS policy ================ 14:46:40 (1782931600) [ 3961.019604] Lustre: DEBUG MARKER: == sanityn test 77d: check TRR nrs policy ================ 14:46:45 (1782931605) [ 3965.785876] Lustre: DEBUG MARKER: == sanityn test 77e: check TBF NID nrs policy ============ 14:46:49 (1782931609) [ 3973.691858] Lustre: DEBUG MARKER: == sanityn test 77f: check TBF JobID nrs policy ========== 14:46:57 (1782931617) [ 3981.237680] Lustre: DEBUG MARKER: == sanityn test 77g: Change TBF type directly ============ 14:47:05 (1782931625) [ 3984.881174] Lustre: DEBUG MARKER: == sanityn test 77h: Wrong policy name should report error, not LBUG ========================================================== 14:47:08 (1782931628) [ 3988.817940] Lustre: DEBUG MARKER: == sanityn test 77i: Change rank of TBF rule ============= 14:47:12 (1782931632) [ 3996.315946] Lustre: DEBUG MARKER: == sanityn test 77j: check TBF-OPCode NRS policy ========= 14:47:20 (1782931640) [ 4036.564042] Lustre: DEBUG MARKER: == sanityn test 77ja: check TBF-UID/GID NRS policy ======= 14:48:00 (1782931680) [ 4151.246272] Lustre: DEBUG MARKER: == sanityn test 77jb: check TBF-UID/GID NRS policy on files that don't belong to us ========================================================== 14:49:55 (1782931795) [ 4268.325741] Lustre: DEBUG MARKER: == sanityn test 77k: check TBF policy with UID/GID/JobID/OPCode expression ========================================================== 14:51:52 (1782931912) [ 4360.671286] Lustre: lustre-OST0001-osc-ffff8dfe07e99800: disconnect after 20s idle [ 4360.673346] Lustre: Skipped 9 previous similar messages [ 4540.018365] Lustre: DEBUG MARKER: == sanityn test 77kb: Check different granular TBF type combination: jobid+opcode ========================================================== 14:56:24 (1782932184) [ 4566.888773] Lustre: DEBUG MARKER: == sanityn test 77kc: Check different granular TBF type combination: nid+opcode ========================================================== 14:56:50 (1782932210) [ 4596.332807] Lustre: DEBUG MARKER: == sanityn test 77kd: Check different granular TBF type combination: nid+jobid ========================================================== 14:57:20 (1782932240) [ 4622.761785] Lustre: DEBUG MARKER: == sanityn test 77ke: Check different granular TBF type combination: jobid+opcode ========================================================== 14:57:46 (1782932266) [ 4682.683377] Lustre: DEBUG MARKER: == sanityn test 77kf: Check different granular TBF type combination: uid+gid ========================================================== 14:58:46 (1782932326) [ 4734.845870] Lustre: DEBUG MARKER: == sanityn test 77kg: check different granular TBF type combination: uid+opcode ========================================================== 14:59:38 (1782932378) [ 4827.714839] Lustre: DEBUG MARKER: == sanityn test 77kh: Verify that Project ID support for NRS TBF rule ========================================================== 15:01:11 (1782932471) [ 4828.789771] Lustre: Unmounted lustre-client [ 4829.906358] Lustre: Unmounted lustre-client [ 4887.831587] Lustre: Mounted lustre-client [ 4889.356535] Lustre: Mounted lustre-client [ 4890.381469] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4950.273259] Lustre: DEBUG MARKER: == sanityn test 77ki: Add rule with unsupported TBF type should fail for generic TBF ========================================================== 15:03:14 (1782932594) [ 4958.036790] Lustre: DEBUG MARKER: == sanityn test 77kj: Verify nodemap support for NRS TBF rule ========================================================== 15:03:22 (1782932602) [ 5032.927146] Lustre: lustre-OST0001-osc-ffff8dfe3ccf8800: disconnect after 23s idle [ 5032.929663] Lustre: Skipped 10 previous similar messages [ 5039.980661] Lustre: DEBUG MARKER: == sanityn test 77l: check the output of NRS policies for generic TBF ========================================================== 15:04:44 (1782932684) [ 5043.272569] Lustre: DEBUG MARKER: == sanityn test 77m: check NRS Delay slows write RPC processing ========================================================== 15:04:47 (1782932687) [ 5094.062911] Lustre: DEBUG MARKER: == sanityn test 77n: check wildcard support for TBF JobID NRS policy ========================================================== 15:05:38 (1782932738) [ 5134.409160] Lustre: DEBUG MARKER: == sanityn test 77o: Changing rank should not panic ====== 15:06:18 (1782932778) [ 5138.261322] Lustre: DEBUG MARKER: == sanityn test 77q: Parallel TBF rule definitions should not panic ========================================================== 15:06:22 (1782932782) [ 5177.059068] Lustre: DEBUG MARKER: == sanityn test 77p: Check validity of rule names for TBF policies ========================================================== 15:07:01 (1782932821) [ 5189.362463] Lustre: DEBUG MARKER: == sanityn test 77r: Change type of tbf policy at run time ========================================================== 15:07:13 (1782932833) [ 5231.400135] Lustre: DEBUG MARKER: == sanityn test 77s: Check TBF LRU shrinker ============== 15:07:55 (1782932875) [ 5243.886123] Lustre: DEBUG MARKER: == sanityn test 78: Enable policy and specify tunings right away ========================================================== 15:08:07 (1782932887) [ 5246.882361] Lustre: DEBUG MARKER: == sanityn test 79: xattr: intent error ================== 15:08:10 (1782932890) [ 5259.760862] Lustre: DEBUG MARKER: == sanityn test 80a: migrate directory when some children is being opened ========================================================== 15:08:23 (1782932903) [ 5263.476740] Lustre: DEBUG MARKER: == sanityn test 80b: Accessing directory during migration ========================================================== 15:08:27 (1782932907) [ 5263.837096] LustreError: 315168:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x29:0x0]: rc = -5 [ 5263.840742] LustreError: 315168:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5264.388740] LustreError: 315214:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x79f:0x0]: rc = -5 [ 5264.392870] LustreError: 315214:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 7 previous similar messages [ 5264.396490] LustreError: 315214:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5264.399010] LustreError: 315214:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 7 previous similar messages [ 5265.484598] LustreError: 315301:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x7c1:0x0]: rc = -5 [ 5265.488321] LustreError: 315301:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 15 previous similar messages [ 5265.490833] LustreError: 315301:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5265.493620] LustreError: 315301:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 15 previous similar messages [ 5267.565665] LustreError: 315475:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x809:0x0]: rc = -5 [ 5267.571366] LustreError: 315475:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 33 previous similar messages [ 5267.576098] LustreError: 315475:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5267.580746] LustreError: 315475:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 33 previous similar messages [ 5271.572583] LustreError: 315795:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x896:0x0]: rc = -5 [ 5271.575735] LustreError: 315795:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 77 previous similar messages [ 5271.577892] LustreError: 315795:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5271.580338] LustreError: 315795:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 77 previous similar messages [ 5279.643658] LustreError: 316436:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x1ab:0x0]: rc = -5 [ 5279.646814] LustreError: 316436:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 188 previous similar messages [ 5279.649884] LustreError: 316436:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5279.652591] LustreError: 316436:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 188 previous similar messages [ 5295.646102] LustreError: 317791:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0xb1c:0x0]: rc = -5 [ 5295.652613] LustreError: 317791:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 395 previous similar messages [ 5295.656486] LustreError: 317791:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5295.660902] LustreError: 317791:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 395 previous similar messages [ 5410.097052] LustreError: 318935:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x523:0x0]: rc = -5 [ 5410.101630] LustreError: 318935:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 330 previous similar messages [ 5410.104854] LustreError: 318935:0:(llite_lib.c:3753:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5410.107612] LustreError: 318935:0:(llite_lib.c:3753:ll_prep_inode()) Skipped 330 previous similar messages [ 5410.111414] LustreError: lustre-MDT0001-mdc-ffff8dfe3ccf8800: operation mds_getattr_lock to node 192.168.203.114@tcp failed: rc = -107 [ 5410.115582] Lustre: lustre-MDT0001-mdc-ffff8dfe3ccf8800: Connection to lustre-MDT0001 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5410.125106] LustreError: lustre-MDT0001-mdc-ffff8dfe3ccf8800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5410.152077] Lustre: lustre-MDT0001-mdc-ffff8dfe3ccf8800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 5422.554620] Lustre: DEBUG MARKER: == sanityn test 81a: rename and stat under striped directory ========================================================== 15:11:06 (1782933066) [ 5424.873770] Lustre: DEBUG MARKER: == sanityn test 81b: rename under striped directory doesn't deadlock ========================================================== 15:11:08 (1782933068) [ 5471.396704] Lustre: DEBUG MARKER: == sanityn test 81c: rename revoke LOOKUP lock for remote object ========================================================== 15:11:55 (1782933115) [ 5471.875661] Lustre: DEBUG MARKER: SKIP: sanityn test_81c needs >= 4 MDTs [ 5472.415091] Lustre: DEBUG MARKER: == sanityn test 81d: parallel rename file cross-dir on same MDT ========================================================== 15:11:56 (1782933116) [ 5514.096966] Lustre: DEBUG MARKER: == sanityn test 82: fsetxattr and fgetxattr on orphan files ========================================================== 15:12:38 (1782933158) [ 5516.352744] Lustre: DEBUG MARKER: == sanityn test 83: access striped directory while it is being created/unlinked ========================================================== 15:12:40 (1782933160) [ 5638.914171] Lustre: DEBUG MARKER: == sanityn test 84: 0-nlink race in lu_object_find() ===== 15:14:42 (1782933282) [ 5646.547782] Lustre: DEBUG MARKER: == sanityn test 85: Lustre API root cache race =========== 15:14:50 (1782933290) [ 5649.576332] Lustre: DEBUG MARKER: == sanityn test 90: open/create and unlink striped directory ========================================================== 15:14:53 (1782933293) [ 5831.781571] Lustre: DEBUG MARKER: == sanityn test 91: chmod and unlink striped directory === 15:17:55 (1782933475) [ 5887.967165] Lustre: lustre-OST0000-osc-ffff8dfe3ccf8800: disconnect after 23s idle [ 5887.969716] Lustre: Skipped 8 previous similar messages [ 6014.702615] Lustre: DEBUG MARKER: == sanityn test 92: create remote directory under orphan directory ========================================================== 15:20:58 (1782933658) [ 6017.483743] Lustre: DEBUG MARKER: == sanityn test 93: alloc_rr should not allocate on same ost ========================================================== 15:21:01 (1782933661) [ 6026.838414] Lustre: DEBUG MARKER: == sanityn test 94: signal vs CP callback race =========== 15:21:10 (1782933670) [ 6027.000359] Lustre: DEBUG MARKER: write [ 6027.015824] LustreError: 291320:0:(ldlm_request.c:1533:ldlm_cli_cancel_req()) cfs_fail_timeout id 312 sleeping for 5000ms [ 6029.021488] Lustre: DEBUG MARKER: kill 377991 [ 6029.026156] LustreError: 377991:0:(ldlm_request.c:1393:ldlm_cli_cancel_local()) cfs_fail_timeout id 329 sleeping for 6000ms [ 6032.111142] LustreError: 291320:0:(ldlm_request.c:1533:ldlm_cli_cancel_req()) cfs_fail_timeout id 312 awake [ 6035.063182] LustreError: 377991:0:(ldlm_request.c:1393:ldlm_cli_cancel_local()) cfs_fail_timeout id 329 awake [ 6038.158484] Lustre: DEBUG MARKER: == sanityn test 95a: Check readpage() on a page that was removed from page cache ========================================================== 15:21:21 (1782933681) [ 6040.416651] LustreError: 378604:0:(rw.c:1865:ll_readpage()) cfs_fail_timeout id 1422 sleeping for 10000ms [ 6050.511151] LustreError: 378604:0:(rw.c:1865:ll_readpage()) cfs_fail_timeout id 1422 awake [ 6053.400094] Lustre: DEBUG MARKER: == sanityn test 95b: Check readpage() on a page that is no longer uptodate ========================================================== 15:21:37 (1782933697) [ 6053.488287] LustreError: 379192:0:(rw.c:2112:ll_readpage()) cfs_fail_timeout id 1424 sleeping for 5000ms [ 6055.575131] LustreError: 379192:0:(rw.c:2112:ll_readpage()) cfs_fail_timeout interrupted [ 6061.591144] Lustre: DEBUG MARKER: == sanityn test 100a: DoM: glimpse RPCs for stat without IO lock (DoM only file) ========================================================== 15:21:45 (1782933705) [ 6062.151918] Lustre: DEBUG MARKER: SKIP: sanityn test_100a Reserved for glimpse-ahead [ 6062.773841] Lustre: DEBUG MARKER: == sanityn test 100b: DoM: no glimpse RPC for stat with IO lock (DoM only file) ========================================================== 15:21:46 (1782933706) [ 6065.856661] Lustre: DEBUG MARKER: == sanityn test 100c: DoM: write vs stat without IO lock (combined file) ========================================================== 15:21:49 (1782933709) [ 6068.268944] Lustre: DEBUG MARKER: == sanityn test 100d: DoM: write+truncate vs stat without IO lock (combined file) ========================================================== 15:21:52 (1782933712) [ 6070.634753] Lustre: DEBUG MARKER: == sanityn test 100e: DoM: read on open and file size ==== 15:21:54 (1782933714) [ 6072.878115] Lustre: DEBUG MARKER: == sanityn test 101a: Discard DoM data on unlink ========= 15:21:56 (1782933716) [ 6074.821370] Lustre: DEBUG MARKER: == sanityn test 101b: Discard DoM data on rename ========= 15:21:58 (1782933718) [ 6076.786345] Lustre: DEBUG MARKER: == sanityn test 101c: Discard DoM data on close-unlink === 15:22:00 (1782933720) [ 6079.739210] Lustre: DEBUG MARKER: == sanityn test 102: Test open by handle of unlinked file ========================================================== 15:22:03 (1782933723) [ 6082.202271] Lustre: DEBUG MARKER: == sanityn test 103: Test size correctness with lockahead ========================================================== 15:22:06 (1782933726) [ 6082.816774] Lustre: *** cfs_fail_loc=415, val=0*** [ 6089.364968] Lustre: DEBUG MARKER: == sanityn test 104: Verify that MDS stores atime/mtime/ctime during close ========================================================== 15:22:13 (1782933733) [ 6108.734125] Lustre: DEBUG MARKER: == sanityn test 105: Glimpse and lock cancel race ======== 15:22:32 (1782933752) [ 6108.832228] LustreError: 291320:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) cfs_fail_timeout id 416 sleeping for 5000ms [ 6108.834769] LustreError: 291320:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) Skipped 3 previous similar messages [ 6113.927096] LustreError: 290802:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) cfs_fail_timeout id 416 awake [ 6113.929577] LustreError: 290802:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) Skipped 2 previous similar messages [ 6124.127114] LustreError: 290802:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) cfs_fail_timeout id 416 awake [ 6124.129464] LustreError: 290802:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) Skipped 3 previous similar messages [ 6131.517503] Lustre: DEBUG MARKER: == sanityn test 106a: Verify the btime via statx() ======= 15:22:55 (1782933775) [ 6134.243774] Lustre: DEBUG MARKER: == sanityn test 106b: Glimpse RPCs test for statx ======== 15:22:58 (1782933778) [ 6136.698755] Lustre: DEBUG MARKER: == sanityn test 106c: Verify statx attributes mask ======= 15:23:00 (1782933780) [ 6139.004460] Lustre: DEBUG MARKER: == sanityn test 107a: Basic grouplock conflict =========== 15:23:03 (1782933783) [ 6143.257883] Lustre: DEBUG MARKER: == sanityn test 107b: Grouplock is added to the head of waiting list ========================================================== 15:23:07 (1782933787) [ 6151.519812] Lustre: DEBUG MARKER: == sanityn test 108a: lseek: parallel updates ============ 15:23:15 (1782933795) [ 6151.649889] LustreError: 389925:0:(osc_request.c:2989:osc_build_rpc()) cfs_fail_timeout id 414 sleeping for 4000ms [ 6151.652321] LustreError: 389925:0:(osc_request.c:2989:osc_build_rpc()) Skipped 6 previous similar messages [ 6155.711172] LustreError: 389925:0:(osc_request.c:2989:osc_build_rpc()) cfs_fail_timeout id 414 awake [ 6155.713678] LustreError: 389925:0:(osc_request.c:2989:osc_build_rpc()) Skipped 3 previous similar messages [ 6157.879944] Lustre: DEBUG MARKER: == sanityn test 109: Race with several mount instances on 1 node ========================================================== 15:23:21 (1782933801) [ 6159.267044] Lustre: Unmounted lustre-client [ 6159.920074] Lustre: Unmounted lustre-client [ 6160.390304] Lustre: DEBUG MARKER: Iteration 0 [ 6160.497305] LustreError: 390818:0:(llite_lib.c:1389:ll_fill_super()) cfs_race id 1417 sleeping [ 6160.497343] LustreError: 390817:0:(llite_lib.c:1389:ll_fill_super()) cfs_fail_race id 1417 waking [ 6160.504291] LustreError: 390818:0:(llite_lib.c:1389:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 6160.548629] Lustre: Mounted lustre-client [ 6161.084205] Lustre: Unmounted lustre-client [ 6162.046560] Key type lgssc unregistered [ 6162.167809] LNet: 391159:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6162.171657] LNetError: 391159:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6162.182944] LNet: Removed LNI 192.168.203.14@tcp [ 6162.492111] Key type .llcrypt unregistered [ 6162.493289] Key type ._llcrypt unregistered [ 6162.834640] Key type ._llcrypt registered [ 6162.836217] Key type .llcrypt registered [ 6163.046907] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6163.052932] alg: No test for adler32 (adler32-zlib) [ 6164.019621] Lustre: Lustre: Build Version: 2.17.54_83_g6b808a3 [ 6164.281844] LNet: Added LNI 192.168.203.14@tcp [8/256/0/180] [ 6165.887126] Key type lgssc registered [ 6166.415104] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6170.573623] Lustre: DEBUG MARKER: Iteration 1 [ 6170.676634] LustreError: 391991:0:(llite_lib.c:1389:ll_fill_super()) cfs_race id 1417 sleeping [ 6170.677833] LustreError: 391992:0:(llite_lib.c:1389:ll_fill_super()) cfs_fail_race id 1417 waking [ 6170.680637] LustreError: 391991:0:(llite_lib.c:1389:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4998 [ 6171.716251] Lustre: Mounted lustre-client [ 6171.718304] Lustre: Skipped 1 previous similar message [ 6172.220385] Lustre: Unmounted lustre-client [ 6173.170723] Key type lgssc unregistered [ 6173.290461] LNet: 392330:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6173.292953] LNetError: 392330:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6173.301735] LNet: Removed LNI 192.168.203.14@tcp [ 6173.537104] Key type .llcrypt unregistered [ 6173.538300] Key type ._llcrypt unregistered [ 6173.828408] Key type ._llcrypt registered [ 6173.829553] Key type .llcrypt registered [ 6173.998016] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6174.003369] alg: No test for adler32 (adler32-zlib) [ 6174.860895] Lustre: Lustre: Build Version: 2.17.54_83_g6b808a3 [ 6174.952326] LNet: Added LNI 192.168.203.14@tcp [8/256/0/180] [ 6176.535138] Key type lgssc registered [ 6176.922699] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6180.552087] Lustre: DEBUG MARKER: Iteration 2 [ 6180.655155] LustreError: 393164:0:(llite_lib.c:1389:ll_fill_super()) cfs_race id 1417 sleeping [ 6180.657374] LustreError: 393165:0:(llite_lib.c:1389:ll_fill_super()) cfs_fail_race id 1417 waking [ 6180.660584] LustreError: 393164:0:(llite_lib.c:1389:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4997 [ 6181.706796] Lustre: Mounted lustre-client [ 6181.708383] Lustre: Skipped 1 previous similar message [ 6182.197135] Lustre: Unmounted lustre-client [ 6183.147579] Key type lgssc unregistered [ 6183.274529] LNet: 393505:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6183.277569] LNetError: 393505:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6183.291712] LNet: Removed LNI 192.168.203.14@tcp [ 6183.541093] Key type .llcrypt unregistered [ 6183.542333] Key type ._llcrypt unregistered [ 6183.812173] Key type ._llcrypt registered [ 6183.813609] Key type .llcrypt registered [ 6184.014443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6184.019805] alg: No test for adler32 (adler32-zlib) [ 6184.876720] Lustre: Lustre: Build Version: 2.17.54_83_g6b808a3 [ 6184.962076] LNet: Added LNI 192.168.203.14@tcp [8/256/0/180] [ 6186.567139] Key type lgssc registered [ 6186.950669] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6191.095279] Lustre: Mounted lustre-client [ 6193.746217] Lustre: DEBUG MARKER: == sanityn test 110: do not grant another lock on resend ========================================================== 15:23:57 (1782933837) [ 6209.503186] Lustre: 394846:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933838/real 1782933838] req@ffff8dfe2a7f2a00 x1869541622687616/t0(0) o36->lustre-MDT0000-mdc-ffff8dfe0b9aa800@192.168.203.114@tcp:12/10 lens 496/440 e 0 to 1 dl 1782933854 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 6209.528384] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection to lustre-MDT0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6209.547773] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6225.887169] Lustre: 394846:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933854/real 1782933854] req@ffff8dfe2a7f2a00 x1869541622687616/t0(0) o36->lustre-MDT0000-mdc-ffff8dfe0b9aa800@192.168.203.114@tcp:12/10 lens 496/440 e 0 to 1 dl 1782933870 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 6225.901366] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection to lustre-MDT0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6225.912732] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6242.271239] Lustre: 394846:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933870/real 1782933870] req@ffff8dfe2a7f2a00 x1869541622687616/t0(0) o36->lustre-MDT0000-mdc-ffff8dfe0b9aa800@192.168.203.114@tcp:12/10 lens 496/440 e 0 to 1 dl 1782933886 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 6242.300639] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection to lustre-MDT0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6242.321651] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6257.631091] Lustre: 394846:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933886/real 1782933886] req@ffff8dfe2a7f2a00 x1869541622687616/t0(0) o36->lustre-MDT0000-mdc-ffff8dfe0b9aa800@192.168.203.114@tcp:12/10 lens 496/440 e 0 to 1 dl 1782933902 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 6257.639601] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection to lustre-MDT0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6257.651758] Lustre: lustre-MDT0000-mdc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6258.413802] Lustre: DEBUG MARKER: == sanityn test 111: A racy rename/link an open file should not cause fs corruption ========================================================== 15:25:02 (1782933902) [ 6264.130700] Lustre: DEBUG MARKER: == sanityn test 112: update max-inherit in default LMV === 15:25:08 (1782933908) [ 6268.278529] Lustre: DEBUG MARKER: == sanityn test 113: check servers of specified fs ======= 15:25:12 (1782933912) [ 6271.045593] Lustre: DEBUG MARKER: == sanityn test 114: implicit default LMV inherit ======== 15:25:14 (1782933914) [ 6280.026952] Lustre: DEBUG MARKER: == sanityn test 115: ldiskfs doesn't check direntry for uniqueness ========================================================== 15:25:23 (1782933923) [ 6294.187055] Lustre: DEBUG MARKER: == sanityn test 116: DNE: Set default LMV layout from a remote client ========================================================== 15:25:38 (1782933938) [ 6296.660135] Lustre: DEBUG MARKER: == sanityn test 121: trunc append race =================== 15:25:40 (1782933940) [ 6296.767087] LustreError: 399617:0:(lcommon_cl.c:99:cl_setattr_ost()) cfs_fail_timeout id 1436 sleeping for 2000ms [ 6298.847115] LustreError: 399617:0:(lcommon_cl.c:99:cl_setattr_ost()) cfs_fail_timeout id 1436 awake [ 6301.157913] Lustre: DEBUG MARKER: == sanityn test 200: service remains healthy while able to process request ========================================================== 15:25:45 (1782933945) [ 6318.559161] Lustre: 393698:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933947/real 1782933947] req@ffff8dfe26fed880 x1869541623724928/t0(0) o4->lustre-OST0000-osc-ffff8dfe0b9aa800@192.168.203.114@tcp:6/4 lens 4584/448 e 0 to 1 dl 1782933963 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 6318.577101] Lustre: lustre-OST0000-osc-ffff8dfe0b9aa800: Connection to lustre-OST0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6318.595281] Lustre: lustre-OST0000-osc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6334.943171] Lustre: 393700:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933963/real 1782933963] req@ffff8dfe1877d500 x1869541623725696/t0(0) o4->lustre-OST0000-osc-ffff8dfe0b9aa800@192.168.203.114@tcp:6/4 lens 4584/448 e 0 to 1 dl 1782933979 ref 2 fl Rpc:XQr/602/ffffffff rc -11/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 6334.943225] Lustre: lustre-OST0000-osc-ffff8dfe0b9aa800: Connection to lustre-OST0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6334.951434] Lustre: 393700:0:(client.c:2489:ptlrpc_expire_one_request()) Skipped 5 previous similar messages [ 6334.959859] Lustre: lustre-OST0000-osc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6351.327148] Lustre: 393701:0:(client.c:2489:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1782933979/real 1782933979] req@ffff8dfe3b5a4000 x1869541623724416/t0(0) o4->lustre-OST0000-osc-ffff8dfe0b9aa800@192.168.203.114@tcp:6/4 lens 4584/448 e 0 to 1 dl 1782933995 ref 2 fl Rpc:XQr/602/ffffffff rc -11/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 6351.327229] Lustre: lustre-OST0000-osc-ffff8dfe0b9aa800: Connection to lustre-OST0000 (at 192.168.203.114@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6351.345150] Lustre: 393701:0:(client.c:2489:ptlrpc_expire_one_request()) Skipped 4 previous similar messages [ 6351.367122] Lustre: lustre-OST0000-osc-ffff8dfe0b9aa800: Connection restored to 192.168.203.114@tcp (at 192.168.203.114@tcp) [ 6391.101594] Lustre: DEBUG MARKER: oleg314-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff8dfe0b49e800.ost_server_uuid 50 [ 6391.679557] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff8dfe0b49e800.ost_server_uuid in IDLE state after 0 sec [ 6392.218102] Lustre: DEBUG MARKER: cleanup: ====================================================== [ 6392.861516] Lustre: DEBUG MARKER: == sanityn test complete, duration 6272 sec ============== 15:27:16 (1782934036) [ 6393.522617] Lustre: DEBUG MARKER: === sanityn: start cleanup 15:27:17 (1782934037) === [ 6460.959695] Lustre: Unmounted lustre-client [ 6462.159079] Lustre: DEBUG MARKER: === sanityn: finish cleanup 15:28:26 (1782934106) === [ 6462.467593] Lustre: Unmounted lustre-client [ 6497.610240] Key type lgssc unregistered [ 6497.728494] LNet: 402673:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6497.733681] LNetError: 402673:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6497.744772] LNet: Removed LNI 192.168.203.14@tcp [ 6497.997100] Key type .llcrypt unregistered [ 6497.998098] Key type ._llcrypt unregistered