[ 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 390707113 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.001009] APIC: Switch to symmetric I/O mode setup [ 0.002342] x2apic enabled [ 0.003007] Switched APIC routing to physical x2apic. [ 0.004009] kvm-guest: setup PV IPIs [ 0.006704] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008025] pid_max: default: 32768 minimum: 301 [ 0.009124] LSM: Security Framework initializing [ 0.010032] Yama: becoming mindful. [ 0.011027] SELinux: Initializing. [ 0.012087] *** VALIDATE selinux *** [ 0.019065] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.023548] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025094] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026106] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027124] *** VALIDATE tmpfs *** [ 0.028421] *** VALIDATE proc *** [ 0.029193] *** VALIDATE cgroup *** [ 0.030006] *** VALIDATE cgroup2 *** [ 0.031228] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.032121] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.033004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.034020] Spectre V2 : User space: Vulnerable [ 0.035006] Speculative Store Bypass: Vulnerable [ 0.038039] debug: unmapping init [mem 0xffffffff9dc59000-0xffffffff9dc60fff] [ 0.040943] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.041624] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.042017] ... version: 2 [ 0.043006] ... bit width: 48 [ 0.043994] ... generic registers: 4 [ 0.044007] ... value mask: 0000ffffffffffff [ 0.045008] ... max period: 00007fffffffffff [ 0.046006] ... fixed-purpose events: 3 [ 0.047005] ... event mask: 000000070000000f [ 0.049183] rcu: Hierarchical SRCU implementation. [ 0.051200] smp: Bringing up secondary CPUs ... [ 0.052467] x86: Booting SMP configuration: [ 0.053015] .... node #0, CPUs: #1 #2 #3 [ 0.057012] smp: Brought up 1 node, 4 CPUs [ 0.058993] smpboot: Max logical packages: 1 [ 0.059010] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.126210] node 0 deferred pages initialised in 66ms [ 0.130091] devtmpfs: initialized [ 0.131283] x86/mm: Memory block size: 128MB [ 0.134841] gcov: version magic: 0x41383552 [ 0.139324] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.140061] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.141227] pinctrl core: initialized pinctrl subsystem [ 0.142000] [ 0.143005] ************************************************************* [ 0.144006] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.146008] ** ** [ 0.148006] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.150005] ** ** [ 0.152006] ** This means that this kernel is built to expose internal ** [ 0.153005] ** IOMMU data structures, which may compromise security on ** [ 0.155005] ** your system. ** [ 0.156007] ** ** [ 0.159008] ** If you see this message and you are not debugging the ** [ 0.161009] ** kernel, report this immediately to your vendor! ** [ 0.164009] ** ** [ 0.166007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.168008] ************************************************************* [ 0.169708] NET: Registered protocol family 16 [ 0.171329] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.173039] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.175044] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.178318] cpuidle: using governor menu [ 0.180000] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.183771] PCI: Using configuration type 1 for base access [ 0.185127] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.195181] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.198016] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.203080] cryptd: max_cpu_qlen set to 1000 [ 0.209121] ACPI: Added _OSI(Module Device) [ 0.210013] ACPI: Added _OSI(Processor Device) [ 0.212010] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.213009] ACPI: Added _OSI(Processor Aggregator Device) [ 0.217308] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.222549] ACPI: Interpreter enabled [ 0.224045] ACPI: PM: (supports S0 S3 S4 S5) [ 0.225009] ACPI: Using IOAPIC for interrupt routing [ 0.229235] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.233845] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.249283] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.251052] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.255017] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.259130] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.263302] acpiphp: Slot [2] registered [ 0.264103] acpiphp: Slot [5] registered [ 0.266157] acpiphp: Slot [6] registered [ 0.268145] acpiphp: Slot [3] registered [ 0.269000] acpiphp: Slot [4] registered [ 0.269000] acpiphp: Slot [7] registered [ 0.270056] acpiphp: Slot [8] registered [ 0.271105] acpiphp: Slot [9] registered [ 0.272094] acpiphp: Slot [10] registered [ 0.274066] acpiphp: Slot [11] registered [ 0.275080] acpiphp: Slot [12] registered [ 0.277138] acpiphp: Slot [13] registered [ 0.278126] acpiphp: Slot [14] registered [ 0.280174] acpiphp: Slot [15] registered [ 0.281087] acpiphp: Slot [16] registered [ 0.282073] acpiphp: Slot [17] registered [ 0.284101] acpiphp: Slot [18] registered [ 0.285089] acpiphp: Slot [19] registered [ 0.286058] acpiphp: Slot [20] registered [ 0.288066] acpiphp: Slot [21] registered [ 0.289092] acpiphp: Slot [22] registered [ 0.291129] acpiphp: Slot [23] registered [ 0.292460] acpiphp: Slot [24] registered [ 0.296127] acpiphp: Slot [25] registered [ 0.297077] acpiphp: Slot [26] registered [ 0.299068] acpiphp: Slot [27] registered [ 0.300105] acpiphp: Slot [28] registered [ 0.301114] acpiphp: Slot [29] registered [ 0.302077] acpiphp: Slot [30] registered [ 0.304125] acpiphp: Slot [31] registered [ 0.306171] PCI host bridge to bus 0000:00 [ 0.309054] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.312021] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.316026] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.321037] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.325038] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.328029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.330139] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.332273] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.336022] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.344141] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.347909] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.350020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.351012] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.354016] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.357500] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.359722] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.362044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.365852] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.369013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.389019] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.395018] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.400992] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.407020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.416029] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.428013] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.438113] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.444019] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.449018] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.464025] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.479156] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.482763] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.486467] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.488393] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.491269] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.495238] iommu: Default domain type: Passthrough [ 0.496000] SCSI subsystem initialized [ 0.496000] ACPI: bus type USB registered [ 0.498100] usbcore: registered new interface driver usbfs [ 0.499100] usbcore: registered new interface driver hub [ 0.501076] usbcore: registered new device driver usb [ 0.503195] pps_core: LinuxPPS API ver. 1 registered [ 0.506022] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.511142] PTP clock support registered [ 0.513248] EDAC MC: Ver: 3.0.0 [ 0.514263] PCI: Using ACPI for IRQ routing [ 0.517288] NetLabel: Initializing [ 0.518012] NetLabel: domain hash size = 128 [ 0.519016] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.520123] NetLabel: unlabeled traffic allowed by default [ 0.522162] vgaarb: loaded [ 0.523324] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.527034] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.533266] clocksource: Switched to clocksource kvm-clock [ 0.643411] VFS: Disk quotas dquot_6.6.0 [ 0.648595] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.651619] *** VALIDATE ramfs *** [ 0.653210] *** VALIDATE hugetlbfs *** [ 0.655996] pnp: PnP ACPI init [ 0.659526] pnp: PnP ACPI: found 6 devices [ 0.698908] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.703515] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.705741] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.708971] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.711888] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.714933] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.718699] NET: Registered protocol family 2 [ 0.722662] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.730102] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.733498] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.739300] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.742547] TCP: Hash tables configured (established 65536 bind 65536) [ 0.744963] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.747700] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.750225] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.752592] NET: Registered protocol family 1 [ 0.754226] RPC: Registered named UNIX socket transport module. [ 0.755566] RPC: Registered udp transport module. [ 0.756941] RPC: Registered tcp transport module. [ 0.758483] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.759819] NET: Registered protocol family 44 [ 0.761249] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.763512] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.765911] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.767946] PCI: CLS 0 bytes, default 64 [ 0.770220] Unpacking initramfs... [ 2.281836] debug: unmapping init [mem 0xffff91e67cc64000-0xffff91e67ffcffff] [ 2.287992] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.290927] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.294291] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.306257] Initialise system trusted keyrings [ 3.307945] Key type blacklist registered [ 3.326129] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.344630] zbud: loaded [ 3.355818] *** VALIDATE nfs *** [ 3.357304] *** VALIDATE nfs4 *** [ 3.359172] pstore: using deflate compression [ 3.362499] Platform Keyring initialized [ 3.552165] NET: Registered protocol family 38 [ 3.554686] Key type asymmetric registered [ 3.557627] Asymmetric key parser 'x509' registered [ 3.565898] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.575358] io scheduler mq-deadline registered [ 3.597197] io scheduler kyber registered [ 3.604512] io scheduler bfq registered [ 3.608651] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.611892] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.618665] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.624245] ACPI: Power Button [PWRF] [ 3.633658] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.645352] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.689416] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.741431] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.812933] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.818470] Non-volatile memory driver v1.3 [ 3.820324] Linux agpgart interface v0.103 [ 3.860494] virtio_blk virtio1: [vda] 145784 512-byte logical blocks (74.6 MB/71.2 MiB) [ 3.863705] vda: detected capacity change from 0 to 74641408 [ 3.899208] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.903096] vdb: detected capacity change from 0 to 1073741824 [ 3.920214] libphy: Fixed MDIO Bus: probed [ 3.949728] usbcore: registered new interface driver usbserial_generic [ 3.951940] usbserial: USB Serial support registered for generic [ 3.954341] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.960705] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.963726] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.966942] mousedev: PS/2 mouse device common for all mice [ 3.972321] rtc_cmos 00:05: RTC can wake from S4 [ 3.978927] rtc_cmos 00:05: registered as rtc0 [ 3.982902] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.994644] intel_pstate: CPU model not supported [ 3.999357] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 4.033729] hid: raw HID events driver (C) Jiri Kosina [ 4.096354] usbcore: registered new interface driver usbhid [ 4.096657] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 4.105219] usbhid: USB HID core driver [ 4.140182] drop_monitor: Initializing network drop monitor service [ 4.188742] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 4.189625] Initializing XFRM netlink socket [ 4.189988] NET: Registered protocol family 10 [ 4.192545] Segment Routing with IPv6 [ 4.204289] NET: Registered protocol family 17 [ 4.205881] mpls_gso: MPLS GSO support [ 4.211531] RAS: Correctable Errors collector initialized. [ 4.213589] AVX version of gcm_enc/dec engaged. [ 4.215917] AES CTR mode by8 optimization enabled [ 4.295432] sched_clock: Marking stable (4295413915, 0)->(5083351772, -787937857) [ 4.299979] registered taskstats version 1 [ 4.302759] Loading compiled-in X.509 certificates [ 4.305831] zswap: loaded using pool lzo/zbud [ 4.345886] Key type big_key registered [ 4.372765] Key type encrypted registered [ 4.373864] ima: No TPM chip found, activating TPM-bypass! [ 4.375231] ima: Allocated hash algorithm: sha1 [ 4.377017] ima: No architecture policies found [ 4.378971] evm: Initialising EVM extended attributes: [ 4.380150] evm: security.selinux [ 4.380891] evm: security.ima [ 4.384068] evm: security.capability [ 4.385668] evm: HMAC attrs: 0x1 [ 4.390337] rtc_cmos 00:05: setting system clock to 2026-07-15 13:25:23 UTC (1784121923) [ 4.407561] debug: unmapping init [mem 0xffffffff9ec03000-0xffffffff9edfffff] [ 4.416890] debug: unmapping init [mem 0xffffffff9d982000-0xffffffff9dc58fff] [ 4.426099] Write protecting the kernel read-only data: 28672k [ 4.430468] debug: unmapping init [mem 0xffffffff9c003000-0xffffffff9c1fffff] [ 4.435377] debug: unmapping init [mem 0xffffffff9c914000-0xffffffff9c9fffff] [ 4.472725] 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) [ 4.480819] systemd[1]: Detected virtualization kvm. [ 4.482413] systemd[1]: Detected architecture x86-64. [ 4.490900] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 4.543881] systemd[1]: No hostname configured. [ 4.545631] systemd[1]: Set hostname to . [ 4.549599] random: systemd: uninitialized urandom read (16 bytes read) [ 4.551748] systemd[1]: Initializing machine ID from random generator. [ 4.817714] random: systemd: uninitialized urandom read (16 bytes read) [ 4.821370] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 4.830187] random: systemd: uninitialized urandom read (16 bytes read) [ 4.832874] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 4.839966] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Sockets. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Paths. Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ 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 dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 6.886747] device-mapper: uevent: version 1.0.3 [ 6.907491] 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 ] Started udev Coldplug all Devices. [ OK ] Mounted Kernel Configuration File System. [ 9.347604] random: fast init done [ 9.445673] virtio_net virtio0 ens2: renamed from eth0 [ 9.485580] scsi host0: ata_piix [ 9.490992] scsi host1: ata_piix [ 9.492531] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 9.506266] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 14.982142] random: crng init done [ 14.986481] random: 7 urandom warning(s) missed due to ratelimiting [ 17.610992] dracut-initqueue[582]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 19.796105] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 21.535173] printk: systemd: 26 output lines suppressed due to ratelimiting [ 22.039265] SELinux: Disabled at runtime. [ 22.110551] 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) [ 22.120024] systemd[1]: Detected virtualization kvm. [ 22.122366] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 23.115398] systemd[1]: initrd-switch-root.service: Succeeded. [ 23.122686] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 23.139426] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 23.148542] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 23.157472] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 23.177528] systemd[1]: Starting Journal Service... Starting Journal Service... [ 23.185960] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-getty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target rpc_pipefs.target. [ OK ] Reached target RPC Port Mapper. Mounting Kernel Debug File System... Starting Create list of required st…ce nodes for the current kernel... Mounting POSIX Message Queue File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Forward Password Requests to Wall Directory Watch. Mounting Huge Pages File System... [ OK ] Listening on udev Control Socket. Activating swap /dev/disk/by-label/SWAP... Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ 23.921422] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Apply Kernel Variables... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages 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 ] Started Apply Kernel Variables. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 25.075837] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 26.604405] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 26.627071] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 26.745588] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 26.830285] EDAC sbridge: Ver: 1.1.2 [ 30.673111] Key type dns_resolver registered [* ] A start job is running for Configur…-only root support (8s / no limit)[ 31.376684] NFS: Registering the id_resolver key type [ 31.380259] Key type id_resolver registered [ 31.383512] Key type id_legacy registered [** ] A start job is running for Configur…-only root support (8s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Load/Save Random Seed. 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 Daily Cleanup of Temporary Directories. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ 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... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg224-client login: [ 68.824156] libcfs: loading out-of-tree module taints kernel. [ 68.868201] Key type ._llcrypt registered [ 68.869797] Key type .llcrypt registered [ 69.163531] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 69.169734] alg: No test for adler32 (adler32-zlib) [ 70.158575] Lustre: Lustre: Build Version: 2.17.54_162_g38d062c [ 70.480939] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 72.095166] Key type lgssc registered [ 72.806726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 142.428812] Lustre: Mounted lustre-client [ 144.974617] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 151.128920] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing check_logdir /tmp/testlogs/ [ 152.945108] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing yml_node [ 154.481495] Lustre: DEBUG MARKER: Client: 2.17.54.162 [ 155.535438] Lustre: DEBUG MARKER: MDS: 2.17.54.162 [ 156.392150] Lustre: DEBUG MARKER: OSS: 2.17.54.162 [ 156.950113] Lustre: DEBUG MARKER: -----============= acceptance-small: sanityn ============----- Wed Jul 15 09:27:55 EDT 2026 [ 162.524153] Lustre: DEBUG MARKER: excepting tests: 27 40a [ 162.978262] Lustre: DEBUG MARKER: skipping tests SLOW=no: 33a [ 163.427171] Lustre: DEBUG MARKER: === sanityn: start setup 09:28:02 (1784122082) === [ 163.595550] Lustre: Mounted lustre-client [ 165.252838] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing check_config_client /mnt/lustre [ 168.927236] Lustre: lustre-OST0000-osc-ffff91e6d070d000: disconnect after 25s idle [ 171.692900] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 176.018773] Lustre: DEBUG MARKER: === sanityn: finish setup 09:28:14 (1784122094) === [ 176.714216] Lustre: DEBUG MARKER: == sanityn test 0: do_node_vp() and do_facet_vp() do the right thing ========================================================== 09:28:15 (1784122095) [ 179.277497] Lustre: DEBUG MARKER: == sanityn test 1: Check attribute updates on 2 mount points ========================================================== 09:28:17 (1784122097) [ 181.441354] Lustre: DEBUG MARKER: == sanityn test 2a: check cached attribute updates on 2 mtpt's ================================================================== 09:28:20 (1784122100) [ 183.818279] Lustre: DEBUG MARKER: == sanityn test 2b: check cached attribute updates on 2 mtpt's ================================================================== 09:28:22 (1784122102) [ 186.167767] Lustre: DEBUG MARKER: == sanityn test 2c: check cached attribute updates on 2 mtpt's root ============================================================= 09:28:24 (1784122104) [ 188.425853] Lustre: DEBUG MARKER: == sanityn test 2d: check cached attribute updates on 2 mtpt's root ============================================================= 09:28:27 (1784122107) [ 190.786910] Lustre: DEBUG MARKER: == sanityn test 2e: check chmod on root is propagated to others ========================================================== 09:28:29 (1784122109) [ 193.235596] Lustre: DEBUG MARKER: == sanityn test 2f: check attr/owner updates on DNE with 2 mtpt's ========================================================== 09:28:31 (1784122111) [ 196.304428] Lustre: DEBUG MARKER: == sanityn test 2g: check blocks update on sync write ==== 09:28:34 (1784122114) [ 199.035540] Lustre: DEBUG MARKER: == sanityn test 3: symlink on one mtpt, readlink on another ===================================================================== 09:28:37 (1784122117) [ 201.708977] Lustre: DEBUG MARKER: == sanityn test 4: fstat validation on multiple mount points ==================================================================== 09:28:40 (1784122120) [ 205.197047] Lustre: DEBUG MARKER: == sanityn test 5: create a file on one mount, truncate it on the other ========================================================== 09:28:43 (1784122123) [ 207.507032] Lustre: DEBUG MARKER: == sanityn test 6: remove of open file on other node ============================================================================ 09:28:46 (1784122126) [ 210.047456] Lustre: DEBUG MARKER: == sanityn test 7: remove of open directory on other node ======================================================================= 09:28:48 (1784122128) [ 212.580627] Lustre: DEBUG MARKER: == sanityn test 8: remove of open special file on other node ==================================================================== 09:28:51 (1784122131) [ 215.139110] Lustre: DEBUG MARKER: == sanityn test 9a: append of file with sub-page size on multiple mounts ========================================================== 09:28:53 (1784122133) [ 218.066760] Lustre: DEBUG MARKER: == sanityn test 9b: append to striped sparse file ======== 09:28:56 (1784122136) [ 221.125268] Lustre: DEBUG MARKER: == sanityn test 10a: write of file with sub-page size on multiple mounts ========================================================== 09:28:59 (1784122139) [ 224.067512] Lustre: DEBUG MARKER: == sanityn test 10b: write of file with sub-page size on multiple mounts ========================================================== 09:29:02 (1784122142) [ 226.640359] Lustre: DEBUG MARKER: == sanityn test 11: execution of file opened for write should return error ============================================================== 09:29:05 (1784122145) [ 229.459903] Lustre: DEBUG MARKER: == sanityn test 12: test lock ordering (link, stat, unlink) ========================================================== 09:29:07 (1784122147) [ 229.689267] Lustre: DEBUG MARKER: start dir: /mnt/lustre/lockdir=144115205289279518 file: /mnt/lustre/lockdir/lockfile=144115205289279517 [ 385.335772] Lustre: DEBUG MARKER: == sanityn test 13: test directory page revocation ======= 09:31:43 (1784122303) [ 389.229669] Lustre: DEBUG MARKER: == sanityn test 14aa: execution of file open for write returns -ETXTBSY ========================================================== 09:31:47 (1784122307) [ 392.639755] Lustre: DEBUG MARKER: == sanityn test 14ab: open(RDWR) of executing file returns -ETXTBSY ========================================================== 09:31:51 (1784122311) [ 396.071459] Lustre: DEBUG MARKER: == sanityn test 14b: truncate of executing file returns -ETXTBSY ================================================================ 09:31:54 (1784122314) [ 400.003351] Lustre: DEBUG MARKER: == sanityn test 14c: open(O_TRUNC) of executing file return -ETXTBSY ============================================================ 09:31:58 (1784122318) [ 404.088315] Lustre: DEBUG MARKER: == sanityn test 14d: chmod of executing file is still possible ================================================================== 09:32:02 (1784122322) [ 405.004301] Lustre: DEBUG MARKER: chmod [ 408.298646] Lustre: DEBUG MARKER: == sanityn test 15: test out-of-space with multiple writers ===================================================================== 09:32:06 (1784122326) [ 923.094098] Lustre: DEBUG MARKER: == sanityn test 16a: 2500 iterations of dual-mount fsx === 09:40:41 (1784122841) [ 970.512721] Lustre: DEBUG MARKER: == sanityn test 16b: 2500 iterations of dual-mount fsx at small size ========================================================== 09:41:29 (1784122889) [ 995.436076] Lustre: DEBUG MARKER: == sanityn test 16c: verify data consistency on ldiskfs with cache disabled (b=17397) ========================================================== 09:41:54 (1784122914) [ 1039.595645] Lustre: DEBUG MARKER: == sanityn test 16d: Verify DIO and buffer IO with two clients ========================================================== 09:42:38 (1784122958) [ 1050.600756] Lustre: DEBUG MARKER: == sanityn test 16e: Verify size consistency for O_DIRECT write ========================================================== 09:42:49 (1784122969) [ 1053.087592] Lustre: DEBUG MARKER: == sanityn test 16f: rw sequential consistency vs drop_caches ========================================================== 09:42:51 (1784122971) [ 1053.547116] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.600603] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.628862] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.661338] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.683387] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.706033] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.727364] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.755484] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.777135] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.799592] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.819517] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.840370] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.865705] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.888968] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.909223] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.927169] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.948123] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.970948] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1053.993751] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.018410] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.042108] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.062042] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.083964] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.104399] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.125071] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.145922] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.165272] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.190204] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.210249] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.229973] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.250127] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.272178] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.293989] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.317709] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.340030] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.361938] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.388727] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.412446] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.435394] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.459801] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.484184] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.506518] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.528201] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.549100] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.570923] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.593747] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.621994] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.642777] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.664894] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.686316] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.706599] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.728735] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.753333] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.775405] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.805594] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.827320] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.850206] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.872461] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.895087] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.919215] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.951485] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1054.976246] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.001247] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.021822] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.049417] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.074870] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.101496] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.127909] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.155476] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.183199] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.206066] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.227570] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.248939] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.273884] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.303804] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.327053] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.350912] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.377842] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.403077] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.424864] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.444523] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.468391] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.493697] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.515651] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.541023] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.566928] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.589780] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.612482] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.644543] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.667791] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.699718] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.727487] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.750382] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.771118] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.793340] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.814065] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.838201] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.860321] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.885246] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.913873] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.940564] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.963562] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1055.987460] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.010156] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.033255] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.055222] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.081378] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.104254] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.127121] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.164689] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.187036] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.209302] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.233135] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.255410] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.275929] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.299464] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.324609] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.344652] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.365095] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.385922] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.408510] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.431360] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.455359] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.482950] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.508410] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.530181] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.550522] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.575129] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.599310] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.620126] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.641831] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.665443] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.690119] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.717957] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.742190] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.763219] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.784512] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.810073] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.841415] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.868817] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.894713] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.918825] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.942405] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.965847] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1056.991518] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.012608] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.035209] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.056365] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.077111] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.097632] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.117222] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.136288] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.159811] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.180692] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.207782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.232608] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.256694] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.282466] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.307612] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.337311] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.358424] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.380242] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.401592] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.421684] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.444164] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.466807] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.489395] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.509721] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.531426] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.554782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.577263] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.598360] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.617701] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.639507] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.659306] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.679578] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.698106] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.719782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.742200] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.763403] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.783679] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.803880] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.826950] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.847490] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.869667] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.894115] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.913772] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.937994] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.958023] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.977921] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1057.998425] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.020224] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.043111] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.064821] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.087585] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.108557] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.130742] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.155379] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.177980] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.203518] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.226777] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.259470] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.280335] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.303695] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.327749] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.350417] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.373485] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.394794] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.413915] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.434825] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.457139] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.481170] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.507077] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.529194] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.550161] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.571517] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.594247] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.616816] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.637141] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.657240] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.679192] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.701351] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.719627] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.741015] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.758709] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.776883] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.795593] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.816747] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.836134] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.856499] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.877226] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.899539] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.921995] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.944193] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.967146] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1058.987995] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.009927] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.028637] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.047200] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.065179] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.085392] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.103938] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.123289] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.143454] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.162383] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.181659] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.202912] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.221257] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.241675] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.259744] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.280027] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.299887] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.319374] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.341029] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.359579] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.383027] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.406938] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.427109] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.451238] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.472866] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.495103] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.516672] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.537688] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.557834] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.579595] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.610676] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.633634] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.653218] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.673782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.698131] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.719636] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.741934] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.763242] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.785834] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.808450] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.830031] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.855834] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.879454] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.904623] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.924338] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.944886] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.963482] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1059.984715] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.006210] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.027225] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.046969] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.066688] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.090038] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.109650] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.129791] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.150128] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.170347] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.189733] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.210438] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.231052] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.251063] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.272395] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.292181] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.311054] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.330994] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.351984] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.371599] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.393601] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.417674] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.440176] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.461807] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.484370] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.506902] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.527617] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.551061] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.571851] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.591866] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.611105] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.631292] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.653966] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.673937] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.696519] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.717622] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.738230] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.761505] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.782669] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.810269] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.845722] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.869343] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.891726] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.912299] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.933172] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.958599] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1060.981723] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.003258] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.023097] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.045328] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.066886] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.088879] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.110519] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.132077] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.154018] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.175510] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.199737] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.218478] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.238026] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.257814] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.281115] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.300206] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.321996] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.342851] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.362322] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.385176] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.404690] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.425118] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.444416] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.464873] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.485267] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.503285] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.521467] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.541337] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.560569] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.579612] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.598986] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.617394] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.639134] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.657932] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.676436] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.695782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.717623] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.739933] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.758949] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.779481] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.800359] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.819692] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.839182] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.859438] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.879027] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.898201] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.915620] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.935662] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.956176] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.975463] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1061.996581] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.015422] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.033412] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.054506] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.073220] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.093402] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.112704] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.131589] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.150969] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.170298] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.190594] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.212110] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.231931] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.251282] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.271417] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.292293] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.313607] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.333134] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.352917] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.372622] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.391864] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.410824] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.430580] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.456922] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.477725] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.498560] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.523023] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.544911] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.565464] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.591556] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.615511] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.636716] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.657499] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.679203] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.698584] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.718689] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.738755] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.761340] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.782180] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.801370] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.820128] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.840427] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.858076] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.875765] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.892996] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.912351] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.931726] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.950345] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.968915] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1062.991765] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.011099] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.029558] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.047789] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.068156] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.088106] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.107405] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.126715] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.144561] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.162653] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.182509] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.201980] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.220320] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.241000] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.260719] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.280624] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.300112] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.322729] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.341937] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.360687] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.379937] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.397839] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.416253] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.433877] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.454358] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.472379] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.491782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.511545] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.530878] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.549910] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.568774] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.587534] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.607989] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.629598] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.649966] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.671421] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.691460] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.715267] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.736395] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.757623] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.780680] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.804938] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.829553] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.848725] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.873499] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.894930] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.916363] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.937614] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.958253] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.978499] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1063.998049] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.018478] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.037295] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.056967] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.076765] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.095273] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.118809] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.139242] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.161419] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.183596] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.206029] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.226875] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.248648] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.269150] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.292697] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.317190] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.339082] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.360711] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.383743] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.406170] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.427846] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.449659] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.470164] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.490194] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.508858] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.529194] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.550131] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.572244] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.594875] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.614843] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.639052] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.658102] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.678909] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.699804] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.726284] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.753130] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.776839] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.802332] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.825119] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.846356] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.868119] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.888739] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.910147] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.936573] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.961176] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1064.981992] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.002890] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.028333] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.053918] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.075133] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.095187] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.113988] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.134012] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.155859] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.177750] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.201158] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.224108] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.248174] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.270195] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.292270] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.313241] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.332436] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.352290] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.372055] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.392159] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.412402] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.434341] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.454423] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.473373] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.494439] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.514924] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.538290] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.568386] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.597160] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.630608] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.656986] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.682295] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.706270] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.732136] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.756166] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.781358] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.807538] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.828079] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.850830] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.870919] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.894597] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.915124] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.939147] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.963936] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1065.988124] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.010294] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.030935] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.051398] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.072593] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.092576] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.110658] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.132296] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.152691] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.178198] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.200980] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.220864] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.243145] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.263608] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.283251] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.303379] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.322598] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.345429] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.364752] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.385446] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.404127] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.424416] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.444943] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.464129] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.482963] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.505416] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.529519] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.552792] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.576183] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.599137] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.627555] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.647783] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.669770] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.688938] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.706243] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.726639] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.747267] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.768751] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.789149] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.812050] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.833385] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.858419] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.879183] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.902047] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.924645] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.943745] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.964928] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1066.982677] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.002635] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.023852] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.045352] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.071254] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.091078] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.110361] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.131079] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.150838] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.172607] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.192725] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.214665] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.235995] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.257374] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.281382] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.314158] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.340320] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.369157] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.395311] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.420790] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.442811] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.464040] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.485017] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.510423] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.535786] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.558111] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.585213] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.608206] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.629670] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.652239] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.674473] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.694423] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.716338] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.738679] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.759811] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.778783] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.800734] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.824938] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.848234] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.869569] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.895033] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.918136] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.940566] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.963399] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1067.985584] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.005945] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.027675] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.048564] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.069961] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.093381] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.114511] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.136084] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.157744] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.179198] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.201928] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.225056] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.246646] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.270248] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.295102] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.320597] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.343987] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.369062] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.390681] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.411183] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.437447] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.459395] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.485853] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.509458] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.532946] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.552816] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.573634] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.597977] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.622353] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.644203] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.667705] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.691749] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.713393] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.735865] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.758357] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.780855] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.804084] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.827349] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.852065] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.874417] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.898503] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.919852] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.942564] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.964508] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1068.989037] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.015916] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.042087] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.070668] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.099289] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.124808] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.147419] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.169629] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.191325] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.211429] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.233128] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.254620] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.274859] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.295535] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.319099] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.344427] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.368251] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.389788] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.412381] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.436205] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.459897] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.482313] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.506751] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.529201] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.551671] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.580124] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.603589] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.632627] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.657369] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.681210] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.710394] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.742417] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.770740] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.796614] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.820368] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.848403] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.874677] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.904231] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.936479] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.962436] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1069.993782] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.024070] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.047202] Lustre: lustre-OST0000-osc-ffff91e6c59f7000: disconnect after 20s idle [ 1070.050352] Lustre: Skipped 1 previous similar message [ 1070.053572] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.084150] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.112774] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.142796] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.170352] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.195260] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.216728] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.239619] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.262174] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.284883] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.306516] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.327030] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.348102] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.369446] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.390581] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.413967] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.434620] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.454972] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.478738] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.499639] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.521043] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.542206] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.567401] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.589134] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.609902] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.634549] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.662171] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.684019] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.704614] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.727615] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.747912] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.769229] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.792944] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.817066] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.838505] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.863611] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.891686] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.913997] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.937350] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.961589] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1070.988703] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.024391] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.057349] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.084832] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.111037] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.134824] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.157725] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.180429] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.202145] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.221900] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.242540] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.269404] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.295446] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.318097] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.339877] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.360523] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.381932] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.403682] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.425521] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.448200] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.471564] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.493272] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.515686] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.537154] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.562243] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.585990] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.609196] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.636058] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.662150] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.691381] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.714963] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.740781] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.768617] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.794458] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.825947] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.855026] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.884154] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.910361] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.939835] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1071.978386] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.001031] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.023453] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.046741] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.068942] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.090764] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.111053] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.130619] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.149735] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.172202] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.194281] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.217201] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.237361] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.256272] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.276098] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.294700] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.317854] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.339264] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.361709] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.385766] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.406160] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.428060] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.448865] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.471213] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.491840] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.513109] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.536183] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.558157] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.578802] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.600408] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.622731] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.642132] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.661469] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.682238] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.702843] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.723649] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.745258] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.769535] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.789607] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.813761] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.834876] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.855272] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.882194] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.904234] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.925216] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.946190] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.969143] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1072.990349] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.011375] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.032519] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.052516] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.072613] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.092718] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.114115] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1073.134162] rw_seq_cst_vs_d (32581): drop_caches: 3 [ 1075.168192] Lustre: lustre-OST0000-osc-ffff91e6d070d000: disconnect after 22s idle [ 1075.502414] Lustre: DEBUG MARKER: == sanityn test 16g: mmap rw sequential consistency vs drop_caches ========================================================== 09:43:14 (1784122994) [ 1075.598920] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.616543] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.636486] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.655298] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.671947] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.711407] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.732396] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.751547] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.767242] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.787954] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.809617] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.830239] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.867850] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.885419] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.904094] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.918108] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.935435] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.953495] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1075.986394] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.000803] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.015988] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.031341] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.051963] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.188069] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.206673] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.225046] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.281513] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.295765] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.329681] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.364432] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.385590] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.407867] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.443801] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.463390] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.479573] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.494935] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.510406] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.525771] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.542790] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.561227] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.577521] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.594571] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.610631] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.624668] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.644653] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.666446] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.680979] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.695288] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.709962] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.729836] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.821905] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.845139] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.866687] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.884388] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.899349] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.913959] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.931231] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.948878] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.964322] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.980324] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1076.995777] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.015455] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.030396] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.075543] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.098533] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.116423] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.141496] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.160477] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.180337] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.195588] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.211173] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.228770] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.269420] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.293558] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.312741] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.333832] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.348925] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.462029] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.477672] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.492360] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.524585] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.543996] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.560586] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.635943] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.654323] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.675234] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.693138] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.710646] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.730343] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.744592] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.762229] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.785554] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.800701] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.822183] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.843421] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.882466] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.897719] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.919143] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.953539] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.970777] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1077.986938] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.002920] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.024046] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.039592] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.053195] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.068461] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.084130] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.097697] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.112132] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.192812] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.209936] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.224893] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.244819] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.262456] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.279118] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.293167] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.307723] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.323550] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.371904] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.387976] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.403997] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.421266] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.440313] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.500650] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.516269] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.530107] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.543648] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.561956] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.578234] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.611773] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.625419] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.639143] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.654532] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.669667] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.685655] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.700552] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.717944] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.736708] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.753194] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.770472] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.786236] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.800946] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.817719] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.832782] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.848032] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.861706] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.877588] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.896741] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.910875] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.924751] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.940828] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.975093] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1078.995747] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.030201] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.044096] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.058959] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.079445] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.092303] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.106421] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.120841] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.136428] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.152380] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.168979] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.202109] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.222685] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.237114] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.250556] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.272741] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.315338] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.334387] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.352720] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.370808] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.386088] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.404555] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.422245] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.442834] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.467896] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.485017] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.500053] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.514464] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.527559] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.570535] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.584632] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.599129] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.618154] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.641131] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.658252] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.673511] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.690644] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.706519] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.721475] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.736529] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.768444] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.808316] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.823916] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.843344] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.860776] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.893252] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.907556] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.923397] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.939088] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.963646] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1079.982850] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.025615] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.040083] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.075318] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.116070] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.152546] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.166904] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.183318] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.203359] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.237408] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.255851] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.313183] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.328913] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.456110] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.537679] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.562827] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.629157] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.646911] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.665209] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.683762] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.702252] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.717564] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.736071] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.752611] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.769286] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.845460] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.867325] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.884754] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.902099] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1080.919447] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.023868] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.039184] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.054269] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.074222] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.089269] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.105367] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.122652] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.138201] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.164975] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.181504] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.196389] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.246536] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.261371] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.277323] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.293540] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.310164] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.328619] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.347378] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.369437] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.414288] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.430986] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.445738] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.464701] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.480251] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.496298] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.514490] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.530245] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.607758] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.625093] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.775212] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.802294] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.815195] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.831984] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.867079] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.885066] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1081.904090] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.010040] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.026755] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.071940] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.090251] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.155047] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.172952] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.253554] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.269633] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.310453] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.328242] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.347246] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.367832] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.389880] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.409333] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.427753] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.509286] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.525905] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.541661] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.559324] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.574174] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.592681] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.904483] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.921415] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.937220] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1082.985374] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.006868] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.021943] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.041910] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.056920] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.072089] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.086689] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.103346] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.120862] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.154424] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.169163] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.183834] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.204816] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.237488] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.253060] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.271932] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.352881] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.372913] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.478697] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.492632] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.506460] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.522107] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.537844] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.553449] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.569552] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.605399] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.662461] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.681327] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.700045] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.719781] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.739362] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.754576] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.770844] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.788644] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.805724] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.839355] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.857373] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.874656] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.893319] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.912026] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.933049] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.950504] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1083.998294] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.020245] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.057049] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.070645] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.087867] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.110362] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.175641] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.194446] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.216176] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.233377] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.247444] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.305654] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.323934] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.400147] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.414192] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.429494] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.446819] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.473518] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.507861] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.528112] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.566654] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.587991] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.604807] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.621632] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.647208] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.682065] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.786370] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.808161] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.827468] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.849643] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.865531] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.880656] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.898456] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.915376] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.931362] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.951228] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1084.965523] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.022182] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.040194] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.058478] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.076310] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.091852] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.108688] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.127233] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.189406] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.210915] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.250960] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.268187] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.286554] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.351827] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.370374] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.385350] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.402658] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.485214] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.502892] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.516413] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.530919] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.546253] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.609756] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.623960] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.642084] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.658865] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.673578] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.691770] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.709644] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.721917] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.737519] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.753291] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.767379] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.786157] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.803242] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.817794] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.834692] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.848681] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.862528] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.877800] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.891570] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.905791] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.919045] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.962869] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1085.981373] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.000596] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.013303] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.029307] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.048026] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.062653] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.077687] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.092684] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.125247] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.138902] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.152832] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.166777] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.181115] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.199847] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.222890] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.242216] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.294362] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.312848] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.361298] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.376937] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.395758] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.410248] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.427996] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.441181] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.455323] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.470611] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.506410] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.524725] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.543034] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.563302] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.577807] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.594928] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.628952] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.645249] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.662965] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.677753] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.690692] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.703929] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.717899] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.731475] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.748027] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.763279] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.777791] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.808628] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.842079] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.950633] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1086.969087] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.003820] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.017842] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.033467] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.057760] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.076704] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.092092] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.105902] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.126987] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.146518] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.168288] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.232586] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.287876] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.326459] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.356349] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.389744] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.406277] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.425249] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.445108] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.460030] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.474565] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.490500] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.512648] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.549763] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.569975] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.583673] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.599244] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.613488] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.626922] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.640070] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.686904] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.703621] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.722855] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.736544] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.752796] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.769350] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.787552] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.801163] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.813558] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.829367] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.843838] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.857658] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.872607] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.886693] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.901475] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.918889] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.937557] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.955974] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1087.987708] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.006931] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.025760] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.042024] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.076667] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.089852] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.106168] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.140507] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.204381] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.218986] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.252218] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.270810] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.285687] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.304049] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.321798] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.336706] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.356278] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.390544] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.409248] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.461752] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.475130] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.493916] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.514540] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.548503] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.568796] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.589069] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.606990] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.620671] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.636466] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.648488] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.661800] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.678087] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.697934] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.772698] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.855579] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.873774] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.895347] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.910464] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.928263] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.943308] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.961029] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.979907] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1088.993722] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.009177] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.059905] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.078143] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.110118] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.125225] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.142433] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.161256] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.178776] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.193237] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.212913] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.227914] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.244149] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.260486] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.305160] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.321042] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.334653] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.349694] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.364287] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.377891] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.423895] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.503240] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.521649] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.535346] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.549960] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.566192] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.584226] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.664389] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.682978] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.702492] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.721626] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.741848] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.758699] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.774166] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.794093] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.810904] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.831166] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.848169] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.865687] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.883544] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.898405] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.915132] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1089.929859] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.008689] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.041171] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.057631] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.072798] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.086760] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.104036] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.124037] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.139547] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.157049] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.193099] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.222692] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.237488] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.256712] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.296213] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.319106] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.339449] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.360080] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.381829] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.401374] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.422562] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.467571] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.502718] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.520053] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.537787] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.595335] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.609260] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.642540] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.659186] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.675064] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.756703] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.776831] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.816052] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.832127] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.848326] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.902637] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.958895] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1090.975712] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.018542] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.036386] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.051976] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.067864] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.093050] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.107352] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.127825] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.144378] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.160458] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.231802] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.247021] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.263613] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.402966] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.420069] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.435982] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.533851] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.549247] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.570207] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.586669] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.630164] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.672420] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.713197] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.773718] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.789037] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.802725] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.820979] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.843739] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.891331] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1091.911129] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.030546] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.075398] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.091071] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.113856] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.138054] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.157072] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.174349] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.193393] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.217109] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.305021] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.324426] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.372131] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.416162] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.441821] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.466853] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.531703] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.628039] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.672406] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.695564] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.713870] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.731386] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.749502] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.767020] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.869911] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.887110] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.902397] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.946246] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.965827] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1092.987623] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.014274] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.037636] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.123918] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.144506] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.170113] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.189574] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.223301] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.240972] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.258092] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.273174] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.292499] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.313761] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.349193] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.366650] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.388412] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.597480] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.611389] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.624970] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.640242] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.657104] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.676203] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.695789] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.712530] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.726402] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.742411] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.757660] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.774345] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.805494] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.822516] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.858745] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.873383] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.888190] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.901488] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.935301] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.956778] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1093.989250] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.009160] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.025316] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.044909] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.058739] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.072291] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.088378] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.100703] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.115052] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.128116] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.142511] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.157610] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.174335] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.195062] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.220388] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.252586] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.291136] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.309368] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.322499] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.336080] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.368840] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.381422] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.399246] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.451083] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.485526] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.520703] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.534835] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.550307] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.564553] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.578313] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.591767] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.630207] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.643679] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.657589] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.671093] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.685453] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.703574] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.732913] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.745608] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.760093] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.777148] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.795784] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.810172] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.824034] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.840065] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.854052] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.870365] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.885987] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.904642] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.917243] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.934022] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.948230] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1094.985864] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.016298] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.033499] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.051299] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.084826] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.101295] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.120810] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.135280] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.151324] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.167166] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.185027] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.199154] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.215230] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.229690] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.244778] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.265327] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.278995] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.293791] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.310073] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.326429] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.341310] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.357838] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.372510] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.388776] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.402527] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.434626] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.452037] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.477161] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.505781] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1095.526107] rw_seq_cst_vs_d (33162): drop_caches: 3 [ 1097.828772] Lustre: DEBUG MARKER: == sanityn test 16h: mmap read after truncate file ======= 09:43:36 (1784123016) [ 1099.868796] Lustre: DEBUG MARKER: == sanityn test 16i: read after truncate file ============ 09:43:38 (1784123018) [ 1101.846826] Lustre: DEBUG MARKER: == sanityn test 16j: race dio with buffered i/o ========== 09:43:40 (1784123020) [ 1108.887622] Lustre: DEBUG MARKER: == sanityn test 16k: Parallel FSX and drop caches should not panic ========================================================== 09:43:47 (1784123027) [ 1109.071181] bash (35644): drop_caches: 3 [ 1112.173103] bash (35644): drop_caches: 3 [ 1115.236247] bash (35644): drop_caches: 3 [ 1118.348423] bash (35644): drop_caches: 3 [ 1122.053317] Lustre: DEBUG MARKER: == sanityn test 17: resource creation/LVB creation race ========================================================================= 09:44:00 (1784123040) [ 1126.698279] Lustre: DEBUG MARKER: == sanityn test 18: mmap sanity check =========================================================================================== 09:44:05 (1784123045) [ 1138.661525] Lustre: DEBUG MARKER: == sanityn test 19: test concurrent uncached read races ========================================================================= 09:44:17 (1784123057) [ 1141.557300] Lustre: DEBUG MARKER: loop 5 [ 1143.237636] Lustre: DEBUG MARKER: loop 10 [ 1144.896884] Lustre: DEBUG MARKER: loop 15 [ 1146.565677] Lustre: DEBUG MARKER: loop 20 [ 1149.223308] Lustre: DEBUG MARKER: == sanityn test 20: test extra readahead page left in cache ============================================================== 09:44:27 (1784123067) [ 1151.396650] Lustre: DEBUG MARKER: == sanityn test 21: Try to remove mountpoint on another dir ============================================================== 09:44:30 (1784123070) [ 1153.549978] Lustre: DEBUG MARKER: == sanityn test 23: others should see updated atime while another read============================================================== 09:44:32 (1784123072) [ 1172.447241] Lustre: lustre-OST0000-osc-ffff91e6d070d000: disconnect after 23s idle [ 1177.567228] Lustre: lustre-OST0001-osc-ffff91e6d070d000: disconnect after 23s idle [ 1177.568867] Lustre: Skipped 2 previous similar messages [ 1217.333336] Lustre: DEBUG MARKER: == sanityn test 24a: lfs df [-ih] [path] test =================================================================================== 09:45:35 (1784123135) [ 1219.679188] Lustre: DEBUG MARKER: == sanityn test 24b: lfs df should show both filesystems ========================================================================= 09:45:38 (1784123138) [ 1221.789586] Lustre: DEBUG MARKER: == sanityn test 25a: change ACL on one mountpoint be seen on another ============================================================= 09:45:40 (1784123140) [ 1224.091626] Lustre: DEBUG MARKER: == sanityn test 25b: change ACL under remote dir on one mountpoint be seen on another ========================================================== 09:45:42 (1784123142) [ 1226.566204] Lustre: DEBUG MARKER: == sanityn test 26a: allow mtime to get older ============ 09:45:45 (1784123145) [ 1229.788347] Lustre: DEBUG MARKER: == sanityn test 26b: sync mtime between ost and mds ====== 09:45:48 (1784123148) [ 1234.055803] Lustre: DEBUG MARKER: == sanityn test 26c: set-in-past on open file is not lost on close ========================================================== 09:45:52 (1784123152) [ 1237.438930] Lustre: DEBUG MARKER: SKIP: sanityn test_27 skipping excluded test 27 [ 1238.058821] Lustre: DEBUG MARKER: == sanityn test 30: recreate file race =================== 09:45:56 (1784123156) [ 1242.416550] Lustre: DEBUG MARKER: == sanityn test 31a: voluntary cancel / blocking ast race======================================================================== 09:46:00 (1784123160) [ 1242.547985] Lustre: *** cfs_fail_loc=314, val=0*** [ 1243.615209] Lustre: *** cfs_fail_loc=314, val=0*** [ 1243.616942] Lustre: Skipped 2 previous similar messages [ 1246.029987] Lustre: DEBUG MARKER: == sanityn test 31b: voluntary OST cancel / blocking ast race======================================================================== 09:46:04 (1784123164) [ 1251.337679] Lustre: *** cfs_fail_loc=314, val=0*** [ 1253.815054] Lustre: DEBUG MARKER: == sanityn test 31r: open-rename(replace) race =========== 09:46:12 (1784123172) [ 1253.904305] LustreError: 47216:0:(file.c:818:ll_intent_file_open()) cfs_fail_timeout id 1419 sleeping for 3000ms [ 1254.369134] Lustre: lustre-OST0000-osc-ffff91e6c59f7000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1254.375183] LustreError: lustre-OST0000-osc-ffff91e6c59f7000: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1254.379233] Lustre: lustre-OST0000-osc-ffff91e6c59f7000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1256.919119] LustreError: 47216:0:(file.c:818:ll_intent_file_open()) cfs_fail_timeout id 1419 awake [ 1259.222776] Lustre: DEBUG MARKER: == sanityn test 31s: open should not revalidate invalid dentry ========================================================== 09:46:17 (1784123177) [ 1262.110815] Lustre: DEBUG MARKER: == sanityn test 31t: getattr should not revalidate invalid dentry ========================================================== 09:46:20 (1784123180) [ 1265.448218] Lustre: DEBUG MARKER: == sanityn test 32b: lockless i/o ======================== 09:46:24 (1784123184) [ 1266.155743] Lustre: DEBUG MARKER: SKIP: sanityn test_32b max_nolock_bytes is removed >= 2.17.53 [ 1266.836655] Lustre: DEBUG MARKER: == sanityn test 32c: contention detection ================ 09:46:25 (1784123185) [ 1278.637340] Lustre: DEBUG MARKER: SKIP: sanityn test_33a skipping SLOW test 33a [ 1279.238462] Lustre: DEBUG MARKER: == sanityn test 33b: COS: cross create/delete, 2 clients, benchmark under remote dir ========================================================== 09:46:37 (1784123197) [ 1279.853139] Lustre: DEBUG MARKER: SKIP: sanityn test_33b Need two or more clients, have 1 [ 1280.518688] Lustre: DEBUG MARKER: == sanityn test 33c: Cancel cross-MDT lock should trigger Sync-on-Lock-Cancel ========================================================== 09:46:39 (1784123199) [ 1285.089677] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 1285.089710] Lustre: lustre-MDT0000-mdc-ffff91e6d070d000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1285.094937] Lustre: Evicted from MGS (at 192.168.202.124@tcp) after server handle changed from 0x4f697e8b5e023332 to 0x4f697e8b5e16f4d3 [ 1285.101692] Lustre: MGC192.168.202.124@tcp: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1290.319935] Lustre: lustre-MDT0000-mdc-ffff91e6c59f7000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1295.327250] Lustre: lustre-OST0001-osc-ffff91e6d070d000: disconnect after 22s idle [ 1303.261787] Lustre: DEBUG MARKER: == sanityn test 33d: dependent transactions should trigger COS ========================================================== 09:47:01 (1784123221) [ 1320.927260] Lustre: lustre-OST0000-osc-ffff91e6c59f7000: disconnect after 21s idle [ 1320.930187] Lustre: Skipped 2 previous similar messages [ 1325.347025] Lustre: DEBUG MARKER: == sanityn test 33e: independent transactions shouldn't trigger COS ========================================================== 09:47:23 (1784123243) [ 1331.820638] Lustre: DEBUG MARKER: == sanityn test 34: no lock timeout under IO ============= 09:47:30 (1784123250) [ 1351.647233] Lustre: lustre-OST0000-osc-ffff91e6d070d000: disconnect after 20s idle [ 1351.650202] Lustre: Skipped 1 previous similar message [ 1381.308524] Lustre: lustre-OST0001-osc-ffff91e6d070d000: Connection to lustre-OST0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1381.313864] Lustre: Skipped 1 previous similar message [ 1381.317041] LustreError: lustre-OST0001-osc-ffff91e6d070d000: This client was evicted by lustre-OST0001; in progress operations using this service will fail. [ 1381.321089] LustreError: lustre-OST0001-osc-ffff91e6c59f7000: This client was evicted by lustre-OST0001; in progress operations using this service will fail. [ 1381.321328] Lustre: lustre-OST0001-osc-ffff91e6d070d000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1381.327907] Lustre: Skipped 2 previous similar messages [ 1396.668686] Lustre: lustre-OST0000-osc-ffff91e6d070d000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1396.673690] Lustre: Skipped 1 previous similar message [ 1396.677054] LustreError: lustre-OST0000-osc-ffff91e6d070d000: This client was evicted by lustre-OST0000; in progress operations using this service will fail. [ 1396.681077] Lustre: lustre-OST0000-osc-ffff91e6d070d000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1402.847287] Lustre: lustre-OST0001-osc-ffff91e6d070d000: disconnect after 21s idle [ 1402.850093] Lustre: Skipped 1 previous similar message [ 1407.784894] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff91e6c59f7000.ost_server_uuid 50 [ 1408.305113] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff91e6c59f7000.ost_server_uuid in FULL state after 0 sec [ 1410.098651] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91e6c59f7000.ost_server_uuid 50 [ 1410.588874] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91e6c59f7000.ost_server_uuid in IDLE state after 0 sec [ 1412.760570] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff91e6c59f7000.ost_server_uuid 50 [ 1413.287726] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff91e6c59f7000.ost_server_uuid in FULL state after 0 sec [ 1415.230418] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91e6c59f7000.ost_server_uuid 50 [ 1415.745855] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91e6c59f7000.ost_server_uuid in IDLE state after 0 sec [ 1419.748172] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff91e6c59f7000.ost_server_uuid 50 [ 1420.283985] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff91e6c59f7000.ost_server_uuid in FULL state after 0 sec [ 1422.255036] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91e6c59f7000.ost_server_uuid 50 [ 1422.821245] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91e6c59f7000.ost_server_uuid in IDLE state after 0 sec [ 1423.538932] Lustre: DEBUG MARKER: == sanityn test 35: -EINTR cp_ast vs. bl_ast race does not evict client ========================================================== 09:49:02 (1784123342) [ 1424.504911] Lustre: DEBUG MARKER: Race attempt 0 [ 1426.122459] Lustre: DEBUG MARKER: Wait for 59803 59931 for 60 sec... [ 1488.324595] Lustre: DEBUG MARKER: == sanityn test 36: handle ESTALE/open-unlink correctly == 09:50:06 (1784123406) [ 1493.421031] Lustre: DEBUG MARKER: start test - cycle (0) [ 1512.013910] Lustre: DEBUG MARKER: start test - cycle (1) [ 1527.880620] Lustre: DEBUG MARKER: start test - cycle (2) [ 1542.440677] Lustre: DEBUG MARKER: start test - cycle (3) [ 1558.666795] Lustre: DEBUG MARKER: start test - cycle (4) [ 1573.629911] Lustre: DEBUG MARKER: start test - cycle (5) [ 1588.515100] Lustre: DEBUG MARKER: start test - cycle (6) [ 1604.569626] Lustre: DEBUG MARKER: start test - cycle (7) [ 1618.977310] Lustre: DEBUG MARKER: start test - cycle (8) [ 1634.925380] Lustre: DEBUG MARKER: start test - cycle (9) [ 1649.852052] Lustre: DEBUG MARKER: start test - cycle (10) [ 1668.107572] Lustre: DEBUG MARKER: == sanityn test 37: check i_size is not updated for directory on close (bug 18695) ======================================================================== 09:53:06 (1784123586) [ 1674.207291] Lustre: lustre-OST0001-osc-ffff91e6c59f7000: disconnect after 21s idle [ 1674.211158] Lustre: Skipped 2 previous similar messages [ 1681.864502] Lustre: DEBUG MARKER: == sanityn test 39a: file mtime does not change after rename ========================================================== 09:53:20 (1784123600) [ 1684.093968] Lustre: DEBUG MARKER: == sanityn test 39b: file mtime the same on clients with/out lock ========================================================== 09:53:22 (1784123602) [ 1687.067770] Lustre: DEBUG MARKER: == sanityn test 39c: check truncate mtime update ================================================================================ 09:53:25 (1784123605) [ 1690.011861] Lustre: DEBUG MARKER: == sanityn test 39d: sync write should update mtime ====== 09:53:28 (1784123608) [ 1690.089207] Lustre: *** cfs_fail_loc=411, val=0*** [ 1691.996874] Lustre: DEBUG MARKER: SKIP: sanityn test_40a skipping ALWAYS excluded test 40a [ 1692.478489] Lustre: DEBUG MARKER: == sanityn test 40b: pdirops: open|create and others ======================================================================== 09:53:31 (1784123611) [ 1700.368414] Lustre: DEBUG MARKER: == sanityn test 40c: pdirops: link and others ======================================================================== 09:53:39 (1784123619) [ 1708.054535] Lustre: DEBUG MARKER: == sanityn test 40d: pdirops: unlink and others ======================================================================== 09:53:46 (1784123626) [ 1715.877568] Lustre: DEBUG MARKER: == sanityn test 40e: pdirops: rename and others ======================================================================== 09:53:54 (1784123634) [ 1722.997924] Lustre: DEBUG MARKER: == sanityn test 41a: pdirops: create vs mkdir ======================================================================== 09:54:01 (1784123641) [ 1727.864377] Lustre: DEBUG MARKER: == sanityn test 41b: pdirops: create vs create ======================================================================== 09:54:06 (1784123646) [ 1732.652215] Lustre: DEBUG MARKER: == sanityn test 41c: pdirops: create vs link ======================================================================== 09:54:11 (1784123651) [ 1737.658193] Lustre: DEBUG MARKER: == sanityn test 41d: pdirops: create vs unlink ======================================================================== 09:54:16 (1784123656) [ 1742.541970] Lustre: DEBUG MARKER: == sanityn test 41e: pdirops: create and rename (tgt) ======================================================================== 09:54:21 (1784123661) [ 1747.676193] Lustre: DEBUG MARKER: == sanityn test 41f: pdirops: create and rename (src) ======================================================================== 09:54:26 (1784123666) [ 1752.952752] Lustre: DEBUG MARKER: == sanityn test 41g: pdirops: create vs getattr ======================================================================== 09:54:31 (1784123671) [ 1757.943370] Lustre: DEBUG MARKER: == sanityn test 41h: pdirops: create vs readdir ======================================================================== 09:54:36 (1784123676) [ 1762.946281] Lustre: DEBUG MARKER: == sanityn test 41i: reint_open: create vs create ======== 09:54:41 (1784123681) [ 2385.887221] Lustre: lustre-OST0000-osc-ffff91e6c59f7000: disconnect after 22s idle [ 2385.890667] Lustre: Skipped 4 previous similar messages [ 2485.669227] Lustre: DEBUG MARKER: == sanityn test 42a: pdirops: mkdir vs mkdir ======================================================================== 10:06:44 (1784124404) [ 2491.058734] Lustre: DEBUG MARKER: == sanityn test 42b: pdirops: mkdir vs create ======================================================================== 10:06:49 (1784124409) [ 2496.609822] Lustre: DEBUG MARKER: == sanityn test 42c: pdirops: mkdir vs link ======================================================================== 10:06:55 (1784124415) [ 2502.073932] Lustre: DEBUG MARKER: == sanityn test 42d: pdirops: mkdir vs unlink ======================================================================== 10:07:00 (1784124420) [ 2507.192524] Lustre: DEBUG MARKER: == sanityn test 42e: pdirops: mkdir and rename (tgt) ======================================================================== 10:07:05 (1784124425) [ 2512.596419] Lustre: DEBUG MARKER: == sanityn test 42f: pdirops: mkdir and rename (src) ======================================================================== 10:07:11 (1784124431) [ 2517.949397] Lustre: DEBUG MARKER: == sanityn test 42g: pdirops: mkdir vs getattr ======================================================================== 10:07:16 (1784124436) [ 2523.657431] Lustre: DEBUG MARKER: == sanityn test 42h: pdirops: mkdir vs readdir ======================================================================== 10:07:22 (1784124442) [ 2529.113986] Lustre: DEBUG MARKER: == sanityn test 43a: rmdir,mkdir doesn't return -EEXIST ======================================================================== 10:07:27 (1784124447) [ 2569.337757] Lustre: DEBUG MARKER: == sanityn test 43b: pdirops: unlink vs create ======================================================================== 10:08:06 (1784124486) [ 2580.635156] Lustre: DEBUG MARKER: == sanityn test 43c: pdirops: unlink vs link ======================================================================== 10:08:18 (1784124498) [ 2592.615233] Lustre: DEBUG MARKER: == sanityn test 43d: pdirops: unlink vs unlink ======================================================================== 10:08:30 (1784124510) [ 2605.506666] Lustre: DEBUG MARKER: == sanityn test 43e: pdirops: unlink and rename (tgt) ======================================================================== 10:08:43 (1784124523) [ 2615.657657] Lustre: DEBUG MARKER: == sanityn test 43f: pdirops: unlink and rename (src) ======================================================================== 10:08:53 (1784124533) [ 2624.122241] Lustre: DEBUG MARKER: == sanityn test 43g: pdirops: unlink vs getattr ======================================================================== 10:09:02 (1784124542) [ 2631.823078] Lustre: DEBUG MARKER: == sanityn test 43h: pdirops: unlink vs readdir ======================================================================== 10:09:10 (1784124550) [ 2638.767773] Lustre: DEBUG MARKER: == sanityn test 43i: pdirops: unlink vs remote mkdir ===== 10:09:17 (1784124557) [ 2645.833736] Lustre: DEBUG MARKER: == sanityn test 43j: racy mkdir return EEXIST ======================================================================== 10:09:24 (1784124564) [ 2657.248554] Lustre: lustre-OST0000-osc-ffff91e6d070d000: disconnect after 21s idle [ 2657.254669] Lustre: Skipped 3 previous similar messages [ 2664.278459] hrtimer: interrupt took 8435821 ns [ 2710.244091] Lustre: DEBUG MARKER: == sanityn test 43k: unlink vs create ==================== 10:10:28 (1784124628) [ 3481.730092] Lustre: DEBUG MARKER: == sanityn test 44a: pdirops: rename tgt vs mkdir ======================================================================== 10:23:20 (1784125400) [ 3489.970310] Lustre: DEBUG MARKER: == sanityn test 44b: pdirops: rename tgt vs create ======================================================================== 10:23:28 (1784125408) [ 3491.808192] Lustre: lustre-OST0000-osc-ffff91e6c59f7000: disconnect after 21s idle [ 3491.812726] Lustre: Skipped 5 previous similar messages [ 3498.273543] Lustre: DEBUG MARKER: == sanityn test 44c: pdirops: rename tgt vs link ======================================================================== 10:23:36 (1784125416) [ 3506.102916] Lustre: DEBUG MARKER: == sanityn test 44d: pdirops: rename tgt vs unlink ======================================================================== 10:23:44 (1784125424) [ 3514.668474] Lustre: DEBUG MARKER: == sanityn test 44e: pdirops: rename tgt and rename (tgt) ======================================================================== 10:23:52 (1784125432) [ 3523.517114] Lustre: DEBUG MARKER: == sanityn test 44f: pdirops: rename tgt and rename (src) ======================================================================== 10:24:01 (1784125441) [ 3532.373272] Lustre: DEBUG MARKER: == sanityn test 44g: pdirops: rename tgt vs getattr ======================================================================== 10:24:10 (1784125450) [ 3541.332327] Lustre: DEBUG MARKER: == sanityn test 44h: pdirops: rename tgt vs readdir ======================================================================== 10:24:19 (1784125459) [ 3550.914760] Lustre: DEBUG MARKER: == sanityn test 44i: pdirops: rename tgt vs remote mkdir ========================================================== 10:24:28 (1784125468) [ 3559.826368] Lustre: DEBUG MARKER: == sanityn test 45a: rename,mkdir doesn't return -EEXIST ======================================================================== 10:24:38 (1784125478) [ 3662.075676] Lustre: DEBUG MARKER: == sanityn test 45b: pdirops: rename src vs create ======================================================================== 10:26:20 (1784125580) [ 3669.966906] Lustre: DEBUG MARKER: == sanityn test 45c: pdirops: rename src vs link ======================================================================== 10:26:28 (1784125588) [ 3678.135346] Lustre: DEBUG MARKER: == sanityn test 45d: pdirops: rename src vs unlink ======================================================================== 10:26:36 (1784125596) [ 3685.976805] Lustre: DEBUG MARKER: == sanityn test 45e: pdirops: rename src and rename (tgt) ======================================================================== 10:26:44 (1784125604) [ 3694.057899] Lustre: DEBUG MARKER: == sanityn test 45f: pdirops: rename src and rename (src) ======================================================================== 10:26:52 (1784125612) [ 3701.849706] Lustre: DEBUG MARKER: == sanityn test 45g: pdirops: rename src vs getattr ======================================================================== 10:27:00 (1784125620) [ 3710.062144] Lustre: DEBUG MARKER: == sanityn test 45h: pdirops: unlink vs readdir ======================================================================== 10:27:08 (1784125628) [ 3718.364509] Lustre: DEBUG MARKER: == sanityn test 45i: pdirops: rename src vs remote mkdir ========================================================== 10:27:16 (1784125636) [ 3726.671317] Lustre: DEBUG MARKER: == sanityn test 45j: read vs rename ====================== 10:27:25 (1784125645) [ 4280.311405] Lustre: DEBUG MARKER: == sanityn test 46a: pdirops: link vs mkdir ======================================================================== 10:36:38 (1784126198) [ 4285.720599] Lustre: DEBUG MARKER: == sanityn test 46b: pdirops: link vs create ======================================================================== 10:36:44 (1784126204) [ 4291.605484] Lustre: DEBUG MARKER: == sanityn test 46c: pdirops: link vs link ======================================================================== 10:36:50 (1784126210) [ 4297.312827] Lustre: DEBUG MARKER: == sanityn test 46d: pdirops: link vs unlink ======================================================================== 10:36:55 (1784126215) [ 4303.343085] Lustre: DEBUG MARKER: == sanityn test 46e: pdirops: link and rename (tgt) ======================================================================== 10:37:01 (1784126221) [ 4309.115509] Lustre: DEBUG MARKER: == sanityn test 46f: pdirops: link and rename (src) ======================================================================== 10:37:07 (1784126227) [ 4314.737330] Lustre: DEBUG MARKER: == sanityn test 46g: pdirops: link vs getattr ======================================================================== 10:37:13 (1784126233) [ 4320.299384] Lustre: DEBUG MARKER: == sanityn test 46h: pdirops: link vs readdir ======================================================================== 10:37:18 (1784126238) [ 4326.258360] Lustre: DEBUG MARKER: == sanityn test 46i: pdirops: link vs remote mkdir ======= 10:37:24 (1784126244) [ 4331.915713] Lustre: DEBUG MARKER: == sanityn test 47a: pdirops: remote mkdir vs mkdir ====== 10:37:30 (1784126250) [ 4338.165733] Lustre: DEBUG MARKER: == sanityn test 47b: pdirops: remote mkdir vs create ===== 10:37:36 (1784126256) [ 4345.222607] Lustre: DEBUG MARKER: == sanityn test 47c: pdirops: remote mkdir vs link ======= 10:37:43 (1784126263) [ 4350.963777] Lustre: DEBUG MARKER: == sanityn test 47d: pdirops: remote mkdir vs unlink ===== 10:37:49 (1784126269) [ 4351.967133] Lustre: lustre-OST0000-osc-ffff91e6d070d000: disconnect after 21s idle [ 4351.969224] Lustre: Skipped 3 previous similar messages [ 4356.718469] Lustre: DEBUG MARKER: == sanityn test 47e: pdirops: remote mkdir and rename (tgt) ========================================================== 10:37:55 (1784126275) [ 4362.821706] Lustre: DEBUG MARKER: == sanityn test 47f: pdirops: remote mkdir and rename (src) ========================================================== 10:38:01 (1784126281) [ 4368.677252] Lustre: DEBUG MARKER: == sanityn test 47g: pdirops: remote mkdir vs getattr ==== 10:38:07 (1784126287) [ 4375.879573] Lustre: DEBUG MARKER: == sanityn test 50: osc lvb attrs: enqueue vs. CP AST ======================================================================== 10:38:14 (1784126294) [ 4375.994276] LustreError: 6139:0:(ldlm_lockd.c:2079:ldlm_handle_cp_callback()) cfs_fail_timeout id 410 sleeping for 2000ms [ 4378.079107] LustreError: 6139:0:(ldlm_lockd.c:2079:ldlm_handle_cp_callback()) cfs_fail_timeout id 410 awake [ 4383.621400] Lustre: DEBUG MARKER: == sanityn test 51a: layout lock: refresh layout should work ========================================================== 10:38:22 (1784126302) [ 4388.240538] Lustre: DEBUG MARKER: == sanityn test 51b: layout lock: glimpse should be able to restart if layout changed ========================================================== 10:38:26 (1784126306) [ 4388.369231] LustreError: 241823:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 4392.431104] LustreError: 241823:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 awake [ 4392.439854] LustreError: 241823:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 4396.495137] LustreError: 241823:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 awake [ 4396.511870] LustreError: 241829:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 sleeping for 4000ms [ 4400.567190] LustreError: 241829:0:(glimpse.c:206:__cl_glimpse_size()) cfs_fail_timeout id 1404 awake [ 4403.120925] Lustre: DEBUG MARKER: == sanityn test 51c: layout lock: IT_LAYOUT blocked and correct layout can be returned ========================================================== 10:38:41 (1784126321) [ 4410.089952] Lustre: DEBUG MARKER: == sanityn test 51d: layout lock: losing layout lock should clean up memory map region ========================================================== 10:38:48 (1784126328) [ 4413.582977] Lustre: DEBUG MARKER: == sanityn test 51e: lfs getstripe does not break leases, part 2 ========================================================== 10:38:52 (1784126332) [ 4418.060374] Lustre: DEBUG MARKER: == sanityn test 54: rename locking ======================= 10:38:56 (1784126336) [ 4442.716643] Lustre: DEBUG MARKER: == sanityn test 55a: rename vs unlink target dir ========= 10:39:21 (1784126361) [ 4450.611779] Lustre: DEBUG MARKER: == sanityn test 55b: rename vs unlink source dir ========= 10:39:29 (1784126369) [ 4458.454451] Lustre: DEBUG MARKER: == sanityn test 55c: rename vs unlink orphan target dir == 10:39:37 (1784126377) [ 4471.450436] Lustre: DEBUG MARKER: == sanityn test 55d: rename file vs link ================= 10:39:50 (1784126390) [ 4481.170394] Lustre: DEBUG MARKER: == sanityn test 55e: rename race AB/BA under the same parent dir ========================================================== 10:39:59 (1784126399) [ 4494.433793] Lustre: DEBUG MARKER: == sanityn test 55f: rename: (P1/A -> P2/B) race with (P2/B -> P1/A) ========================================================== 10:40:13 (1784126413) [ 4507.592895] Lustre: DEBUG MARKER: == sanityn test 55g: rename: race with trylock =========== 10:40:26 (1784126426) [ 4521.590572] Lustre: DEBUG MARKER: == sanityn test 56a: test llverdev with single large stripe ========================================================== 10:40:40 (1784126440) [ 4529.004283] Lustre: DEBUG MARKER: == sanityn test 56b: test llverdev and partial verify of wide stripe file ========================================================== 10:40:47 (1784126447) [ 4560.394921] Lustre: DEBUG MARKER: == sanityn test 60: Verify data_version behaviour ======== 10:41:19 (1784126479) [ 4562.793518] Lustre: DEBUG MARKER: == sanityn test 70a: cd directory [ 4565.670182] Lustre: DEBUG MARKER: == sanityn test 70b: remove files after calling rm_entry ========================================================== 10:41:24 (1784126484) [ 4568.174428] Lustre: DEBUG MARKER: == sanityn test 71a: correct file map just after write operation is finished ========================================================== 10:41:26 (1784126486) [ 4570.723825] Lustre: DEBUG MARKER: == sanityn test 71b: check fiemap support for stripecount > 1 ========================================================== 10:41:29 (1784126489) [ 4572.948368] Lustre: DEBUG MARKER: == sanityn test 71c: check FIEMAP_EXTENT_LAST flag with different extents number ========================================================== 10:41:31 (1784126491) [ 4583.644548] Lustre: DEBUG MARKER: == sanityn test 71d: fiemap corruption test with fm_extent_count=0 ========================================================== 10:41:42 (1784126502) [ 4599.502235] Lustre: DEBUG MARKER: == sanityn test 72: getxattr/setxattr cache should be consistent between nodes ========================================================== 10:41:58 (1784126518) [ 4601.875791] Lustre: DEBUG MARKER: == sanityn test 73: getxattr should not cause xattr lock cancellation ========================================================== 10:42:00 (1784126520) [ 4604.286917] Lustre: DEBUG MARKER: == sanityn test 74: flock deadlock: different mounts ======================================================================== 10:42:02 (1784126522) [ 4607.360493] LustreError: lustre-MDT0000-mdc-ffff91e6d070d000: operation ldlm_enqueue to node 192.168.202.124@tcp failed: rc = -35 [ 4607.363871] LustreError: Skipped 1 previous similar message [ 4610.622446] Lustre: DEBUG MARKER: == sanityn test 75: osc: upcall after unuse lock============================================================================= 10:42:09 (1784126529) [ 4610.782546] LustreError: 2391:0:(osc_request.c:3138:osc_enqueue_interpret()) cfs_fail_timeout id 31d sleeping for 2000ms [ 4612.863099] LustreError: 2391:0:(osc_request.c:3138:osc_enqueue_interpret()) cfs_fail_timeout id 31d awake [ 4617.836384] Lustre: DEBUG MARKER: == sanityn test 76: Verify MDT open_files listing ======== 10:42:16 (1784126536) [ 4671.025847] Lustre: DEBUG MARKER: == sanityn test 77a: check FIFO NRS policy =============== 10:43:09 (1784126589) [ 4674.124239] Lustre: DEBUG MARKER: == sanityn test 77b: check CRR-N NRS policy ============== 10:43:12 (1784126592) [ 4678.633405] Lustre: DEBUG MARKER: == sanityn test 77c: check ORR NRS policy ================ 10:43:17 (1784126597) [ 4683.976432] Lustre: DEBUG MARKER: == sanityn test 77d: check TRR nrs policy ================ 10:43:22 (1784126602) [ 4689.105275] Lustre: DEBUG MARKER: == sanityn test 77e: check TBF NID nrs policy ============ 10:43:27 (1784126607) [ 4697.447448] Lustre: DEBUG MARKER: == sanityn test 77f: check TBF JobID nrs policy ========== 10:43:36 (1784126616) [ 4705.898988] Lustre: DEBUG MARKER: == sanityn test 77g: Change TBF type directly ============ 10:43:44 (1784126624) [ 4709.487344] Lustre: DEBUG MARKER: == sanityn test 77h: Wrong policy name should report error, not LBUG ========================================================== 10:43:48 (1784126628) [ 4713.666249] Lustre: DEBUG MARKER: == sanityn test 77i: Change rank of TBF rule ============= 10:43:52 (1784126632) [ 4721.471822] Lustre: DEBUG MARKER: == sanityn test 77j: check TBF-OPCode NRS policy ========= 10:44:00 (1784126640) [ 4762.789995] Lustre: DEBUG MARKER: == sanityn test 77ja: check TBF-UID/GID NRS policy ======= 10:44:41 (1784126681) [ 4875.904718] Lustre: DEBUG MARKER: == sanityn test 77jb: check TBF-UID/GID NRS policy on files that don't belong to us ========================================================== 10:46:34 (1784126794) [ 4988.427302] Lustre: DEBUG MARKER: == sanityn test 77k: check TBF policy with UID/GID/JobID/OPCode expression ========================================================== 10:48:27 (1784126907) [ 5012.447196] Lustre: lustre-OST0001-osc-ffff91e6d070d000: disconnect after 23s idle [ 5012.449577] Lustre: Skipped 10 previous similar messages [ 5260.991329] Lustre: DEBUG MARKER: == sanityn test 77kb: Check different granular TBF type combination: jobid+opcode ========================================================== 10:52:59 (1784127179) [ 5292.450714] Lustre: DEBUG MARKER: == sanityn test 77kc: Check different granular TBF type combination: nid+opcode ========================================================== 10:53:31 (1784127211) [ 5323.778807] Lustre: DEBUG MARKER: == sanityn test 77kd: Check different granular TBF type combination: nid+jobid ========================================================== 10:54:02 (1784127242) [ 5343.413864] Lustre: DEBUG MARKER: == sanityn test 77ke: Check different granular TBF type combination: jobid+opcode ========================================================== 10:54:22 (1784127262) [ 5404.709239] Lustre: DEBUG MARKER: == sanityn test 77kf: Check different granular TBF type combination: uid+gid ========================================================== 10:55:23 (1784127323) [ 5456.956058] Lustre: DEBUG MARKER: == sanityn test 77kg: check different granular TBF type combination: uid+opcode ========================================================== 10:56:15 (1784127375) [ 5543.012861] Lustre: DEBUG MARKER: == sanityn test 77kh: Verify that Project ID support for NRS TBF rule ========================================================== 10:57:41 (1784127461) [ 5544.092086] Lustre: Unmounted lustre-client [ 5545.176115] Lustre: Unmounted lustre-client [ 5602.684224] Lustre: Mounted lustre-client [ 5604.249487] Lustre: Mounted lustre-client [ 5605.338323] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 5624.799279] Lustre: lustre-OST0000-osc-ffff91e6c3e09000: disconnect after 20s idle [ 5624.802673] Lustre: Skipped 8 previous similar messages [ 5660.358806] Lustre: DEBUG MARKER: == sanityn test 77ki: Add rule with unsupported TBF type should fail for generic TBF ========================================================== 10:59:38 (1784127578) [ 5668.090158] Lustre: DEBUG MARKER: == sanityn test 77kj: Verify nodemap support for NRS TBF rule ========================================================== 10:59:46 (1784127586) [ 5745.198600] Lustre: DEBUG MARKER: == sanityn test 77l: check the output of NRS policies for generic TBF ========================================================== 11:01:03 (1784127663) [ 5748.462752] Lustre: DEBUG MARKER: == sanityn test 77m: check NRS Delay slows write RPC processing ========================================================== 11:01:07 (1784127667) [ 5798.903146] Lustre: DEBUG MARKER: == sanityn test 77n: check wildcard support for TBF JobID NRS policy ========================================================== 11:01:57 (1784127717) [ 5839.018394] Lustre: DEBUG MARKER: == sanityn test 77o: Changing rank should not panic ====== 11:02:37 (1784127757) [ 5842.848574] Lustre: DEBUG MARKER: == sanityn test 77q: Parallel TBF rule definitions should not panic ========================================================== 11:02:41 (1784127761) [ 5880.589679] Lustre: DEBUG MARKER: == sanityn test 77p: Check validity of rule names for TBF policies ========================================================== 11:03:19 (1784127799) [ 5892.547831] Lustre: DEBUG MARKER: == sanityn test 77r: Change type of tbf policy at run time ========================================================== 11:03:31 (1784127811) [ 5932.808585] Lustre: DEBUG MARKER: == sanityn test 77s: Check TBF LRU shrinker ============== 11:04:11 (1784127851) [ 5944.754705] Lustre: DEBUG MARKER: == sanityn test 78: Enable policy and specify tunings right away ========================================================== 11:04:23 (1784127863) [ 5947.767639] Lustre: DEBUG MARKER: == sanityn test 79: xattr: intent error ================== 11:04:26 (1784127866) [ 5960.618812] Lustre: DEBUG MARKER: == sanityn test 80a: migrate directory when some children is being opened ========================================================== 11:04:39 (1784127879) [ 5964.557582] Lustre: DEBUG MARKER: == sanityn test 80b: Accessing directory during migration ========================================================== 11:04:43 (1784127883) [ 5964.853806] LustreError: 314872:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x77f:0x0]: rc = -5 [ 5964.857434] LustreError: 314872:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5965.378525] LustreError: 314912:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x78b:0x0]: rc = -5 [ 5965.382210] LustreError: 314912:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 7 previous similar messages [ 5965.385082] LustreError: 314912:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5965.387475] LustreError: 314912:0:(llite_lib.c:3878:ll_prep_inode()) Skipped 7 previous similar messages [ 5966.379099] LustreError: 314712:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x7a8:0x0]: rc = -5 [ 5966.383563] LustreError: 314712:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 16 previous similar messages [ 5966.465096] LustreError: 315008:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5966.467816] LustreError: 315008:0:(llite_lib.c:3878:ll_prep_inode()) Skipped 17 previous similar messages [ 5968.404562] LustreError: 315179:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x7e0:0x0]: rc = -5 [ 5968.407723] LustreError: 315179:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 32 previous similar messages [ 5968.558398] LustreError: 315190:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5968.560987] LustreError: 315190:0:(llite_lib.c:3878:ll_prep_inode()) Skipped 33 previous similar messages [ 5972.474472] LustreError: 315552:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x121:0x0]: rc = -5 [ 5972.477963] LustreError: 315552:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 113 previous similar messages [ 5972.575658] LustreError: 315562:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5972.578358] LustreError: 315562:0:(llite_lib.c:3878:ll_prep_inode()) Skipped 115 previous similar messages [ 5980.579383] LustreError: 316319:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x240000bd0:0x203:0x0]: rc = -5 [ 5980.583622] LustreError: 316319:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 299 previous similar messages [ 5980.586994] LustreError: 316319:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 5980.590438] LustreError: 316319:0:(llite_lib.c:3878:ll_prep_inode()) Skipped 295 previous similar messages [ 6086.734974] LustreError: 316652:0:(lcommon_cl.c:187:cl_file_inode_init()) lustre: failed to initialize cl_object [0x2000013a1:0x9ad:0x0]: rc = -5 [ 6086.738135] LustreError: 316652:0:(lcommon_cl.c:187:cl_file_inode_init()) Skipped 132 previous similar messages [ 6086.740427] LustreError: 316652:0:(llite_lib.c:3878:ll_prep_inode()) lustre: new_inode - fatal error: rc = -5 [ 6086.742731] LustreError: 316652:0:(llite_lib.c:3878:ll_prep_inode()) Skipped 132 previous similar messages [ 6086.748418] LustreError: lustre-MDT0000-mdc-ffff91e6eecc8000: operation mds_close to node 192.168.202.124@tcp failed: rc = -107 [ 6086.751380] Lustre: lustre-MDT0000-mdc-ffff91e6eecc8000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6086.756844] LustreError: lustre-MDT0000-mdc-ffff91e6eecc8000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 6086.760202] LustreError: 316644:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff91e6eecc8000: inode [0x2000013a1:0x9ac:0x0] mdc close failed: rc = -5 [ 6086.763356] LustreError: 316644:0:(file.c:6088:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 6086.769894] Lustre: lustre-MDT0000-mdc-ffff91e6eecc8000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 6096.490099] Lustre: DEBUG MARKER: == sanityn test 81a: rename and stat under striped directory ========================================================== 11:06:55 (1784128015) [ 6098.581395] Lustre: DEBUG MARKER: == sanityn test 81b: rename under striped directory doesn't deadlock ========================================================== 11:06:57 (1784128017) [ 6143.757560] Lustre: DEBUG MARKER: == sanityn test 81c: rename revoke LOOKUP lock for remote object ========================================================== 11:07:42 (1784128062) [ 6144.215231] Lustre: DEBUG MARKER: SKIP: sanityn test_81c needs >= 4 MDTs [ 6144.735287] Lustre: DEBUG MARKER: == sanityn test 81d: parallel rename file cross-dir on same MDT ========================================================== 11:07:43 (1784128063) [ 6188.131396] Lustre: DEBUG MARKER: == sanityn test 82: fsetxattr and fgetxattr on orphan files ========================================================== 11:08:26 (1784128106) [ 6190.381239] Lustre: DEBUG MARKER: == sanityn test 83: access striped directory while it is being created/unlinked ========================================================== 11:08:29 (1784128109) [ 6320.931584] Lustre: DEBUG MARKER: == sanityn test 84: 0-nlink race in lu_object_find() ===== 11:10:37 (1784128237) [ 6336.931229] Lustre: DEBUG MARKER: == sanityn test 85: Lustre API root cache race =========== 11:10:53 (1784128253) [ 6354.125122] Lustre: DEBUG MARKER: == sanityn test 90: open/create and unlink striped directory ========================================================== 11:11:10 (1784128270) [ 6544.132747] Lustre: DEBUG MARKER: == sanityn test 91: chmod and unlink striped directory === 11:14:20 (1784128460) [ 6592.483065] Lustre: lustre-OST0000-osc-ffff91e6eecc8000: disconnect after 23s idle [ 6592.488202] Lustre: Skipped 12 previous similar messages [ 6730.369685] Lustre: DEBUG MARKER: == sanityn test 92: create remote directory under orphan directory ========================================================== 11:17:28 (1784128648) [ 6735.952258] Lustre: DEBUG MARKER: == sanityn test 93: alloc_rr should not allocate on same ost ========================================================== 11:17:34 (1784128654) [ 6750.518321] Lustre: DEBUG MARKER: == sanityn test 94: signal vs CP callback race =========== 11:17:48 (1784128668) [ 6750.835117] Lustre: DEBUG MARKER: write [ 6750.896716] LustreError: 332572:0:(ldlm_request.c:1533:ldlm_cli_cancel_req()) cfs_fail_timeout id 312 sleeping for 5000ms [ 6752.975383] Lustre: DEBUG MARKER: kill 352066 [ 6752.980263] LustreError: 352066:0:(ldlm_request.c:1393:ldlm_cli_cancel_local()) cfs_fail_timeout id 329 sleeping for 6000ms [ 6755.911184] LustreError: 332572:0:(ldlm_request.c:1533:ldlm_cli_cancel_req()) cfs_fail_timeout id 312 awake [ 6759.047163] LustreError: 352066:0:(ldlm_request.c:1393:ldlm_cli_cancel_local()) cfs_fail_timeout id 329 awake [ 6764.338872] Lustre: DEBUG MARKER: == sanityn test 95a: Check readpage() on a page that was removed from page cache ========================================================== 11:18:02 (1784128682) [ 6767.085340] LustreError: 352680:0:(rw.c:1865:ll_readpage()) cfs_fail_timeout id 1422 sleeping for 10000ms [ 6777.183370] LustreError: 352680:0:(rw.c:1865:ll_readpage()) cfs_fail_timeout id 1422 awake [ 6782.262554] Lustre: DEBUG MARKER: == sanityn test 95b: Check readpage() on a page that is no longer uptodate ========================================================== 11:18:20 (1784128700) [ 6782.636834] LustreError: 353269:0:(rw.c:2112:ll_readpage()) cfs_fail_timeout id 1424 sleeping for 5000ms [ 6784.727131] LustreError: 353269:0:(rw.c:2112:ll_readpage()) cfs_fail_timeout interrupted [ 6794.424643] Lustre: DEBUG MARKER: == sanityn test 100a: DoM: glimpse RPCs for stat without IO lock (DoM only file) ========================================================== 11:18:32 (1784128712) [ 6795.920316] Lustre: DEBUG MARKER: SKIP: sanityn test_100a Reserved for glimpse-ahead [ 6797.416238] Lustre: DEBUG MARKER: == sanityn test 100b: DoM: no glimpse RPC for stat with IO lock (DoM only file) ========================================================== 11:18:35 (1784128715) [ 6803.532126] Lustre: DEBUG MARKER: == sanityn test 100c: DoM: write vs stat without IO lock (combined file) ========================================================== 11:18:41 (1784128721) [ 6809.817227] Lustre: DEBUG MARKER: == sanityn test 100d: DoM: write+truncate vs stat without IO lock (combined file) ========================================================== 11:18:47 (1784128727) [ 6815.159846] Lustre: DEBUG MARKER: == sanityn test 100e: DoM: read on open and file size ==== 11:18:53 (1784128733) [ 6821.062433] Lustre: DEBUG MARKER: == sanityn test 101a: Discard DoM data on unlink ========= 11:18:59 (1784128739) [ 6826.374304] Lustre: DEBUG MARKER: == sanityn test 101b: Discard DoM data on rename ========= 11:19:04 (1784128744) [ 6832.497180] Lustre: DEBUG MARKER: == sanityn test 101c: Discard DoM data on close-unlink === 11:19:10 (1784128750) [ 6839.162487] Lustre: DEBUG MARKER: == sanityn test 102: Test open by handle of unlinked file ========================================================== 11:19:17 (1784128757) [ 6845.961398] Lustre: DEBUG MARKER: == sanityn test 103: Test size correctness with lockahead ========================================================== 11:19:23 (1784128763) [ 6847.319591] Lustre: *** cfs_fail_loc=415, val=0*** [ 6858.130729] Lustre: DEBUG MARKER: == sanityn test 104: Verify that MDS stores atime/mtime/ctime during close ========================================================== 11:19:36 (1784128776) [ 6882.903794] Lustre: DEBUG MARKER: == sanityn test 105: Glimpse and lock cancel race ======== 11:20:01 (1784128801) [ 6883.126728] LustreError: 291666:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) cfs_fail_timeout id 416 sleeping for 5000ms [ 6883.131815] LustreError: 291666:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) Skipped 3 previous similar messages [ 6888.127118] LustreError: 291666:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) cfs_fail_timeout id 416 awake [ 6898.327259] LustreError: 291666:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) cfs_fail_timeout id 416 awake [ 6898.330681] LustreError: 291666:0:(osc_lock.c:435:__osc_dlm_blocking_ast()) Skipped 6 previous similar messages [ 6906.437816] Lustre: DEBUG MARKER: == sanityn test 106a: Verify the btime via statx() ======= 11:20:24 (1784128824) [ 6910.006428] Lustre: DEBUG MARKER: == sanityn test 106b: Glimpse RPCs test for statx ======== 11:20:28 (1784128828) [ 6913.519678] Lustre: DEBUG MARKER: == sanityn test 106c: Verify statx attributes mask ======= 11:20:32 (1784128832) [ 6916.843930] Lustre: DEBUG MARKER: == sanityn test 107a: Basic grouplock conflict =========== 11:20:35 (1784128835) [ 6922.888471] Lustre: DEBUG MARKER: == sanityn test 107b: Grouplock is added to the head of waiting list ========================================================== 11:20:41 (1784128841) [ 6932.323162] Lustre: DEBUG MARKER: == sanityn test 108a: lseek: parallel updates ============ 11:20:50 (1784128850) [ 6932.566017] LustreError: 364008:0:(osc_request.c:2989:osc_build_rpc()) cfs_fail_timeout id 414 sleeping for 4000ms [ 6932.568746] LustreError: 364008:0:(osc_request.c:2989:osc_build_rpc()) Skipped 6 previous similar messages [ 6936.631135] LustreError: 364008:0:(osc_request.c:2989:osc_build_rpc()) cfs_fail_timeout id 414 awake [ 6936.635212] LustreError: 364008:0:(osc_request.c:2989:osc_build_rpc()) Skipped 2 previous similar messages [ 6939.733468] Lustre: DEBUG MARKER: == sanityn test 109: Race with several mount instances on 1 node ========================================================== 11:20:58 (1784128858) [ 6941.299111] Lustre: Unmounted lustre-client [ 6942.151099] Lustre: Unmounted lustre-client [ 6942.887618] Lustre: DEBUG MARKER: Iteration 0 [ 6943.069201] LustreError: 364900:0:(llite_lib.c:1514:ll_fill_super()) cfs_race id 1417 sleeping [ 6943.069255] LustreError: 364902:0:(llite_lib.c:1514:ll_fill_super()) cfs_fail_race id 1417 waking [ 6943.076949] LustreError: 364900:0:(llite_lib.c:1514:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4995 [ 6943.182279] Lustre: Mounted lustre-client [ 6943.742096] Lustre: Unmounted lustre-client [ 6945.023682] Key type lgssc unregistered [ 6945.173933] LNet: 365247:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6945.178412] LNetError: 365247:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6945.187151] LNet: Removed LNI 192.168.202.24@tcp [ 6945.672200] Key type .llcrypt unregistered [ 6945.676980] Key type ._llcrypt unregistered [ 6946.154647] Key type ._llcrypt registered [ 6946.156121] Key type .llcrypt registered [ 6946.391751] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6946.400687] alg: No test for adler32 (adler32-zlib) [ 6947.455363] Lustre: Lustre: Build Version: 2.17.54_162_g38d062c [ 6947.814958] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6949.447226] Key type lgssc registered [ 6950.208247] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6955.900918] Lustre: DEBUG MARKER: Iteration 1 [ 6956.019938] LustreError: 366079:0:(llite_lib.c:1514:ll_fill_super()) cfs_race id 1417 sleeping [ 6956.025493] LustreError: 366081:0:(llite_lib.c:1514:ll_fill_super()) cfs_fail_race id 1417 waking [ 6956.030952] LustreError: 366079:0:(llite_lib.c:1514:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4994 [ 6957.115838] Lustre: Mounted lustre-client [ 6957.686525] Lustre: Unmounted lustre-client [ 6958.910441] Key type lgssc unregistered [ 6959.053486] LNet: 366422:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6959.057431] LNetError: 366422:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6959.066626] LNet: Removed LNI 192.168.202.24@tcp [ 6959.394146] Key type .llcrypt unregistered [ 6959.400229] Key type ._llcrypt unregistered [ 6959.762528] Key type ._llcrypt registered [ 6959.764840] Key type .llcrypt registered [ 6959.962887] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6959.969651] alg: No test for adler32 (adler32-zlib) [ 6960.864777] Lustre: Lustre: Build Version: 2.17.54_162_g38d062c [ 6960.969453] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6962.575166] Key type lgssc registered [ 6963.133093] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6968.542297] Lustre: DEBUG MARKER: Iteration 2 [ 6968.726429] LustreError: 367254:0:(llite_lib.c:1514:ll_fill_super()) cfs_race id 1417 sleeping [ 6968.727826] LustreError: 367256:0:(llite_lib.c:1514:ll_fill_super()) cfs_fail_race id 1417 waking [ 6968.735067] LustreError: 367254:0:(llite_lib.c:1514:ll_fill_super()) cfs_fail_race id 1417 awake: rc=4995 [ 6969.826685] Lustre: Mounted lustre-client [ 6970.457198] Lustre: Unmounted lustre-client [ 6971.834874] Key type lgssc unregistered [ 6971.991692] LNet: 367600:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6971.995667] LNetError: 367600:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6972.008561] LNet: Removed LNI 192.168.202.24@tcp [ 6972.347111] Key type .llcrypt unregistered [ 6972.348645] Key type ._llcrypt unregistered [ 6972.740759] Key type ._llcrypt registered [ 6972.742063] Key type .llcrypt registered [ 6972.962829] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6972.970716] alg: No test for adler32 (adler32-zlib) [ 6973.879264] Lustre: Lustre: Build Version: 2.17.54_162_g38d062c [ 6973.991494] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6975.623203] Key type lgssc registered [ 6976.145657] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6981.769486] Lustre: Mounted lustre-client [ 6985.423721] Lustre: DEBUG MARKER: == sanityn test 110: do not grant another lock on resend ========================================================== 11:21:43 (1784128903) [ 7002.591423] Lustre: 368942:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784128905/real 1784128905] req@ffff91e6ec8aaa00 x1870794738117120/t0(0) o36->lustre-MDT0000-mdc-ffff91e6d850f000@192.168.202.124@tcp:12/10 lens 496/440 e 0 to 1 dl 1784128921 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7002.602567] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7002.614190] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7017.952119] Lustre: 368942:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784128921/real 1784128921] req@ffff91e6ec8aaa00 x1870794738117120/t0(0) o36->lustre-MDT0000-mdc-ffff91e6d850f000@192.168.202.124@tcp:12/10 lens 496/440 e 0 to 1 dl 1784128937 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7017.969506] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7017.986453] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7034.335145] Lustre: 368942:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784128937/real 1784128937] req@ffff91e6ec8aaa00 x1870794738117120/t0(0) o36->lustre-MDT0000-mdc-ffff91e6d850f000@192.168.202.124@tcp:12/10 lens 496/440 e 0 to 1 dl 1784128953 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7034.350773] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7034.367135] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7050.721611] Lustre: 368942:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784128953/real 1784128953] req@ffff91e6ec8aaa00 x1870794738117120/t0(0) o36->lustre-MDT0000-mdc-ffff91e6d850f000@192.168.202.124@tcp:12/10 lens 496/440 e 0 to 1 dl 1784128969 ref 2 fl Rpc:XQr/202/ffffffff rc 0/-1 job:'ln.0' uid:0 gid:0 projid:4294967295 [ 7050.742920] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7050.769058] Lustre: lustre-MDT0000-mdc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7051.967242] Lustre: DEBUG MARKER: == sanityn test 111: A racy rename/link an open file should not cause fs corruption ========================================================== 11:22:50 (1784128970) [ 7060.248550] Lustre: DEBUG MARKER: == sanityn test 112: update max-inherit in default LMV === 11:22:58 (1784128978) [ 7068.021858] Lustre: DEBUG MARKER: == sanityn test 113: check servers of specified fs ======= 11:23:06 (1784128986) [ 7072.524364] Lustre: DEBUG MARKER: == sanityn test 114: implicit default LMV inherit ======== 11:23:10 (1784128990) [ 7086.364243] Lustre: DEBUG MARKER: == sanityn test 115: ldiskfs doesn't check direntry for uniqueness ========================================================== 11:23:24 (1784129004) [ 7107.970694] Lustre: DEBUG MARKER: == sanityn test 116: DNE: Set default LMV layout from a remote client ========================================================== 11:23:46 (1784129026) [ 7110.902835] Lustre: DEBUG MARKER: == sanityn test 121: trunc append race =================== 11:23:49 (1784129029) [ 7111.000159] LustreError: 373718:0:(lcommon_cl.c:99:cl_setattr_ost()) cfs_fail_timeout id 1436 sleeping for 2000ms [ 7113.087152] LustreError: 373718:0:(lcommon_cl.c:99:cl_setattr_ost()) cfs_fail_timeout id 1436 awake [ 7115.433651] Lustre: DEBUG MARKER: == sanityn test 200: service remains healthy while able to process request ========================================================== 11:23:54 (1784129034) [ 7133.663156] Lustre: 367791:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784129036/real 1784129036] req@ffff91e6c7d23100 x1870794739156864/t0(0) o4->lustre-OST0000-osc-ffff91e6d850f000@192.168.202.124@tcp:6/4 lens 4584/448 e 0 to 1 dl 1784129052 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 7133.663288] Lustre: lustre-OST0000-osc-ffff91e6d850f000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7133.674655] Lustre: 367791:0:(client.c:2490:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 7133.688094] Lustre: lustre-OST0000-osc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7149.023191] Lustre: 367794:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784129052/real 1784129052] req@ffff91e6eff03480 x1870794739157760/t0(0) o4->lustre-OST0000-osc-ffff91e6d850f000@192.168.202.124@tcp:6/4 lens 4584/448 e 0 to 1 dl 1784129068 ref 2 fl Rpc:XQr/602/ffffffff rc 0/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 7149.023228] Lustre: lustre-OST0000-osc-ffff91e6d850f000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7149.030786] Lustre: 367794:0:(client.c:2490:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 7149.040913] Lustre: lustre-OST0000-osc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7165.407137] Lustre: 367793:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784129068/real 1784129068] req@ffff91e6f6910700 x1870794739157376/t0(0) o4->lustre-OST0000-osc-ffff91e6d850f000@192.168.202.124@tcp:6/4 lens 4584/448 e 0 to 1 dl 1784129084 ref 2 fl Rpc:XQr/602/ffffffff rc 0/-1 job:'dd.0' uid:0 gid:0 projid:0 [ 7165.407538] Lustre: lustre-OST0000-osc-ffff91e6d850f000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7165.415989] Lustre: 367793:0:(client.c:2490:ptlrpc_expire_one_request()) Skipped 4 previous similar messages [ 7165.425843] Lustre: lustre-OST0000-osc-ffff91e6d850f000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 7205.527978] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff91e6d0c04000.ost_server_uuid 50 [ 7206.034310] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff91e6d0c04000.ost_server_uuid in IDLE state after 0 sec [ 7206.561778] Lustre: DEBUG MARKER: cleanup: ====================================================== [ 7207.108764] Lustre: DEBUG MARKER: == sanityn test complete, duration 7049 sec ============== 11:25:25 (1784129125) [ 7207.635466] Lustre: DEBUG MARKER: === sanityn: start cleanup 11:25:26 (1784129126) === [ 7271.994793] Lustre: Unmounted lustre-client [ 7273.192732] Lustre: DEBUG MARKER: === sanityn: finish cleanup 11:26:31 (1784129191) === [ 7273.559620] Lustre: Unmounted lustre-client [ 7311.364535] Key type lgssc unregistered [ 7311.483532] LNet: 376777:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7311.485784] LNetError: 376777:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7311.493727] LNet: Removed LNI 192.168.202.24@tcp [ 7311.751126] Key type .llcrypt unregistered [ 7311.752128] Key type ._llcrypt unregistered