fio test with iscsi+Multipath and LIO with 2 targets ZFS pool 8 vdevs, 16 disks - LUNs are 512b bs
## First Run
random-writers: (g=0): rw=randwrite, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
...
random-writers: (g=0): rw=randwrite, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
random-readers: (g=0): rw=randread, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
...
random-readers: (g=0): rw=randread, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
fio-2.1.2
Starting 8 processes
Jobs: 1 (f=1): [w_______] [99.7% done] [0KB/45650KB/0KB /s] [0/1426/0 iops] [eta 00m:01s]
random-writers: (groupid=0, jobs=1): err= 0: pid=17752: Thu Sep 19 13:58:33 2013
write: io=0B, bw=31910KB/s, iops=997, runt=394319msec
slat (usec): min=3, max=330356, avg=36.37, stdev=1219.64
clat (usec): min=1, max=2794.7K, avg=3968.63, stdev=40144.83
lat (usec): min=26, max=2794.8K, avg=4005.00, stdev=40165.46
clat percentiles (usec):
| 1.00th=[ 2], 5.00th=[ 30], 10.00th=[ 35], 20.00th=[ 41],
| 30.00th=[ 47], 40.00th=[ 55], 50.00th=[ 64], 60.00th=[ 88],
| 70.00th=[ 133], 80.00th=[ 227], 90.00th=[10048], 95.00th=[20096],
| 99.00th=[40192], 99.50th=[59648], 99.90th=[179200], 99.95th=[1073152],
| 99.99th=[1925120]
bw (KB /s): min= 130, max=1598113, per=30.17%, avg=38515.36, stdev=111353.77
lat (usec) : 2=0.47%, 4=1.28%, 10=0.03%, 20=1.16%, 50=30.20%
lat (usec) : 100=29.31%, 250=18.35%, 500=2.87%, 750=0.61%, 1000=0.22%
lat (msec) : 2=0.23%, 4=0.08%, 10=5.48%, 20=5.15%, 50=3.97%
lat (msec) : 100=0.40%, 250=0.11%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.05%, >=2000=0.01%
cpu : usr=92.66%, sys=5.49%, ctx=703451, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-writers: (groupid=0, jobs=1): err= 0: pid=17753: Thu Sep 19 13:58:33 2013
write: io=0B, bw=32294KB/s, iops=1009, runt=389640msec
slat (usec): min=3, max=252177, avg=29.65, stdev=1003.50
clat (usec): min=1, max=2774.7K, avg=3928.01, stdev=40112.43
lat (usec): min=30, max=2774.7K, avg=3957.66, stdev=40128.54
clat percentiles (usec):
| 1.00th=[ 26], 5.00th=[ 34], 10.00th=[ 38], 20.00th=[ 45],
| 30.00th=[ 52], 40.00th=[ 59], 50.00th=[ 68], 60.00th=[ 88],
| 70.00th=[ 137], 80.00th=[ 211], 90.00th=[10048], 95.00th=[20096],
| 99.00th=[40192], 99.50th=[60160], 99.90th=[171008], 99.95th=[1073152],
| 99.99th=[1941504]
bw (KB /s): min= 121, max=766554, per=30.34%, avg=38723.64, stdev=94725.06
lat (usec) : 2=0.06%, 4=0.43%, 10=0.02%, 20=0.19%, 50=26.53%
lat (usec) : 100=34.87%, 250=19.73%, 500=2.65%, 750=0.55%, 1000=0.24%
lat (msec) : 2=0.24%, 4=0.10%, 10=5.16%, 20=4.76%, 50=3.75%
lat (msec) : 100=0.51%, 250=0.12%, 500=0.02%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.05%, >=2000=0.01%
cpu : usr=93.06%, sys=5.44%, ctx=674762, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-writers: (groupid=0, jobs=1): err= 0: pid=17754: Thu Sep 19 13:58:33 2013
write: io=0B, bw=37384KB/s, iops=1168, runt=336581msec
slat (usec): min=2, max=290852, avg=58.44, stdev=1236.22
clat (usec): min=1, max=2774.8K, avg=3359.07, stdev=40136.03
lat (usec): min=21, max=2774.8K, avg=3417.51, stdev=40157.14
clat percentiles (usec):
| 1.00th=[ 1], 5.00th=[ 2], 10.00th=[ 2], 20.00th=[ 30],
| 30.00th=[ 44], 40.00th=[ 52], 50.00th=[ 63], 60.00th=[ 88],
| 70.00th=[ 126], 80.00th=[ 191], 90.00th=[ 9920], 95.00th=[19840],
| 99.00th=[40192], 99.50th=[60160], 99.90th=[150528], 99.95th=[1105920],
| 99.99th=[1925120]
bw (KB /s): min= 139, max=572928, per=36.11%, avg=46092.96, stdev=100534.26
lat (usec) : 2=4.96%, 4=7.82%, 10=0.05%, 20=5.72%, 50=18.74%
lat (usec) : 100=25.77%, 250=21.10%, 500=3.66%, 750=0.50%, 1000=0.19%
lat (msec) : 2=0.18%, 4=0.05%, 10=3.78%, 20=3.68%, 50=3.18%
lat (msec) : 100=0.45%, 250=0.10%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.05%, >=2000=0.01%
cpu : usr=90.75%, sys=6.35%, ctx=950383, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-writers: (groupid=0, jobs=1): err= 0: pid=17755: Thu Sep 19 13:58:33 2013
write: io=0B, bw=38109KB/s, iops=1190, runt=330182msec
slat (usec): min=2, max=360107, avg=55.90, stdev=1286.20
clat (usec): min=1, max=2804.6K, avg=3296.55, stdev=39643.40
lat (usec): min=25, max=2804.6K, avg=3352.45, stdev=39662.63
clat percentiles (usec):
| 1.00th=[ 1], 5.00th=[ 1], 10.00th=[ 2], 20.00th=[ 28],
| 30.00th=[ 47], 40.00th=[ 56], 50.00th=[ 70], 60.00th=[ 91],
| 70.00th=[ 127], 80.00th=[ 183], 90.00th=[ 9920], 95.00th=[19840],
| 99.00th=[40192], 99.50th=[49920], 99.90th=[160768], 99.95th=[1056768],
| 99.99th=[1925120]
bw (KB /s): min= 183, max=570158, per=37.11%, avg=47362.23, stdev=102767.27
lat (usec) : 2=5.98%, 4=9.33%, 10=0.07%, 20=3.67%, 50=14.36%
lat (usec) : 100=29.50%, 250=21.65%, 500=3.32%, 750=0.43%, 1000=0.14%
lat (msec) : 2=0.14%, 4=0.08%, 10=3.86%, 20=3.81%, 50=3.12%
lat (msec) : 100=0.38%, 250=0.09%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.05%, >=2000=0.01%
cpu : usr=90.79%, sys=6.50%, ctx=982249, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=17756: Thu Sep 19 13:58:33 2013
read : io=0B, bw=1420.6MB/s, iops=45458, runt= 8650msec
slat (usec): min=1, max=140502, avg= 6.76, stdev=255.40
clat (usec): min=1, max=348612, avg=78.71, stdev=1466.16
lat (usec): min=18, max=348617, avg=85.47, stdev=1488.48
clat percentiles (usec):
| 1.00th=[ 20], 5.00th=[ 26], 10.00th=[ 29], 20.00th=[ 34],
| 30.00th=[ 37], 40.00th=[ 41], 50.00th=[ 46], 60.00th=[ 51],
| 70.00th=[ 59], 80.00th=[ 74], 90.00th=[ 107], 95.00th=[ 149],
| 99.00th=[ 270], 99.50th=[ 338], 99.90th=[ 652], 99.95th=[ 1064],
| 99.99th=[60160]
bw (MB /s): min= 118, max= 2373, per=25.26%, avg=1433.16, stdev=569.38
lat (usec) : 2=0.06%, 4=0.12%, 10=0.08%, 20=0.65%, 50=56.18%
lat (usec) : 100=31.35%, 250=10.31%, 500=1.06%, 750=0.11%, 1000=0.03%
lat (msec) : 2=0.02%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.01%
lat (msec) : 100=0.01%, 250=0.01%, 500=0.01%
cpu : usr=83.59%, sys=143.57%, ctx=607137, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=17757: Thu Sep 19 13:58:33 2013
read : io=0B, bw=1461.3MB/s, iops=46761, runt= 8409msec
slat (usec): min=1, max=300877, avg= 8.02, stdev=484.51
clat (usec): min=1, max=399875, avg=74.63, stdev=1646.07
lat (usec): min=17, max=399886, avg=82.65, stdev=1717.89
clat percentiles (usec):
| 1.00th=[ 21], 5.00th=[ 26], 10.00th=[ 29], 20.00th=[ 34],
| 30.00th=[ 38], 40.00th=[ 42], 50.00th=[ 46], 60.00th=[ 52],
| 70.00th=[ 60], 80.00th=[ 74], 90.00th=[ 109], 95.00th=[ 155],
| 99.00th=[ 294], 99.50th=[ 366], 99.90th=[ 620], 99.95th=[ 876],
| 99.99th=[11200]
bw (MB /s): min= 46, max= 2610, per=25.83%, avg=1465.74, stdev=653.00
lat (usec) : 2=0.02%, 4=0.05%, 10=0.02%, 20=0.59%, 50=55.31%
lat (usec) : 100=32.17%, 250=10.24%, 500=1.42%, 750=0.11%, 1000=0.02%
lat (msec) : 2=0.02%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.01%
lat (msec) : 100=0.01%, 250=0.01%, 500=0.01%
cpu : usr=77.33%, sys=144.60%, ctx=599218, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=17758: Thu Sep 19 13:58:33 2013
read : io=0B, bw=1503.5MB/s, iops=48111, runt= 8173msec
slat (usec): min=1, max=35705, avg= 5.96, stdev=58.60
clat (usec): min=1, max=421434, avg=74.61, stdev=1664.07
lat (usec): min=15, max=421488, avg=80.56, stdev=1665.24
clat percentiles (usec):
| 1.00th=[ 18], 5.00th=[ 24], 10.00th=[ 27], 20.00th=[ 32],
| 30.00th=[ 36], 40.00th=[ 41], 50.00th=[ 46], 60.00th=[ 53],
| 70.00th=[ 61], 80.00th=[ 75], 90.00th=[ 107], 95.00th=[ 145],
| 99.00th=[ 253], 99.50th=[ 318], 99.90th=[ 556], 99.95th=[ 860],
| 99.99th=[31360]
bw (MB /s): min= 45, max= 2106, per=26.58%, avg=1507.92, stdev=511.63
lat (usec) : 2=0.09%, 4=0.13%, 10=0.14%, 20=1.07%, 50=53.53%
lat (usec) : 100=33.35%, 250=10.64%, 500=0.92%, 750=0.08%, 1000=0.02%
lat (msec) : 2=0.01%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.01%
lat (msec) : 100=0.01%, 250=0.01%, 500=0.01%
cpu : usr=82.91%, sys=144.68%, ctx=621926, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=17759: Thu Sep 19 13:58:33 2013
read : io=0B, bw=1418.5MB/s, iops=45390, runt= 8663msec
slat (usec): min=1, max=20546, avg= 6.82, stdev=47.75
clat (usec): min=1, max=428975, avg=78.55, stdev=1658.64
lat (usec): min=14, max=428979, avg=85.37, stdev=1659.48
clat percentiles (usec):
| 1.00th=[ 2], 5.00th=[ 21], 10.00th=[ 26], 20.00th=[ 31],
| 30.00th=[ 36], 40.00th=[ 41], 50.00th=[ 47], 60.00th=[ 53],
| 70.00th=[ 62], 80.00th=[ 78], 90.00th=[ 111], 95.00th=[ 149],
| 99.00th=[ 253], 99.50th=[ 310], 99.90th=[ 588], 99.95th=[ 1176],
| 99.99th=[47872]
bw (MB /s): min= 55, max= 2241, per=24.71%, avg=1401.91, stdev=543.80
lat (usec) : 2=0.52%, 4=0.65%, 10=1.02%, 20=2.01%, 50=50.53%
lat (usec) : 100=32.55%, 250=11.69%, 500=0.89%, 750=0.06%, 1000=0.02%
lat (msec) : 2=0.01%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.01%
lat (msec) : 100=0.01%, 250=0.01%, 500=0.01%
cpu : usr=79.59%, sys=133.53%, ctx=628225, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
Run status group 0 (all jobs):
READ: io=49152MB, aggrb=5673.9MB/s, minb=1418.5MB/s, maxb=1503.5MB/s, mint=8173msec, maxt=8663msec
WRITE: io=49152MB, aggrb=127641KB/s, minb=31910KB/s, maxb=38109KB/s, mint=330182msec, maxt=394319msec
## Second Run
random-writers: (g=0): rw=randwrite, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
...
random-writers: (g=0): rw=randwrite, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
random-readers: (g=0): rw=randread, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
...
random-readers: (g=0): rw=randread, bs=32K-32K/32K-32K/32K-32K, ioengine=solarisaio, iodepth=4
fio-2.1.2
Starting 8 processes
Jobs: 1 (f=1): [___w____] [100.0% done] [0KB/737.8MB/0KB /s] [0/23.6K/0 iops] [eta 00m:00s]
random-writers: (groupid=0, jobs=1): err= 0: pid=20888: Thu Sep 19 14:23:10 2013
write: io=0B, bw=36016KB/s, iops=1125, runt=349372msec
slat (usec): min=2, max=239999, avg=52.55, stdev=1330.25
clat (usec): min=1, max=2166.9K, avg=3494.68, stdev=36092.40
lat (usec): min=22, max=2166.1K, avg=3547.23, stdev=36115.70
clat percentiles (usec):
| 1.00th=[ 1], 5.00th=[ 1], 10.00th=[ 2], 20.00th=[ 2],
| 30.00th=[ 32], 40.00th=[ 45], 50.00th=[ 52], 60.00th=[ 72],
| 70.00th=[ 97], 80.00th=[ 155], 90.00th=[ 9920], 95.00th=[20096],
| 99.00th=[49920], 99.50th=[60160], 99.90th=[179200], 99.95th=[946176],
| 99.99th=[1810432]
bw (KB /s): min= 181, max=1020931, per=32.52%, avg=43423.91, stdev=109695.58
lat (usec) : 2=8.88%, 4=13.43%, 10=0.35%, 20=3.24%, 50=21.71%
lat (usec) : 100=23.05%, 250=15.15%, 500=2.43%, 750=0.50%, 1000=0.21%
lat (msec) : 2=0.17%, 4=0.05%, 10=3.05%, 20=3.24%, 50=3.71%
lat (msec) : 100=0.62%, 250=0.13%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.05%, >=2000=0.01%
cpu : usr=91.20%, sys=4.90%, ctx=1022839, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-writers: (groupid=0, jobs=1): err= 0: pid=20889: Thu Sep 19 14:23:10 2013
write: io=0B, bw=35994KB/s, iops=1124, runt=349582msec
slat (usec): min=2, max=408552, avg=55.80, stdev=1515.66
clat (usec): min=1, max=2390.1K, avg=3492.95, stdev=36348.40
lat (usec): min=22, max=2390.1K, avg=3548.75, stdev=36386.06
clat percentiles (usec):
| 1.00th=[ 1], 5.00th=[ 1], 10.00th=[ 2], 20.00th=[ 18],
| 30.00th=[ 41], 40.00th=[ 46], 50.00th=[ 57], 60.00th=[ 77],
| 70.00th=[ 105], 80.00th=[ 161], 90.00th=[10048], 95.00th=[20096],
| 99.00th=[40192], 99.50th=[59648], 99.90th=[160768], 99.95th=[978944],
| 99.99th=[1826816]
bw (KB /s): min= 243, max=740992, per=32.06%, avg=42812.48, stdev=102662.57
lat (usec) : 2=6.39%, 4=8.76%, 10=0.22%, 20=5.38%, 50=23.04%
lat (usec) : 100=24.88%, 250=15.68%, 500=1.86%, 750=0.29%, 1000=0.12%
lat (msec) : 2=0.09%, 4=0.03%, 10=4.79%, 20=4.62%, 50=3.28%
lat (msec) : 100=0.40%, 250=0.11%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.04%, >=2000=0.01%
cpu : usr=91.14%, sys=5.15%, ctx=952348, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-writers: (groupid=0, jobs=1): err= 0: pid=20890: Thu Sep 19 14:23:10 2013
write: io=0B, bw=33916KB/s, iops=1059, runt=371007msec
slat (usec): min=2, max=440505, avg=53.32, stdev=1712.16
clat (usec): min=1, max=2217.1K, avg=3712.93, stdev=36016.23
lat (usec): min=22, max=2217.1K, avg=3766.25, stdev=36064.22
clat percentiles (usec):
| 1.00th=[ 1], 5.00th=[ 1], 10.00th=[ 2], 20.00th=[ 19],
| 30.00th=[ 36], 40.00th=[ 45], 50.00th=[ 54], 60.00th=[ 67],
| 70.00th=[ 90], 80.00th=[ 153], 90.00th=[10048], 95.00th=[20096],
| 99.00th=[40192], 99.50th=[60160], 99.90th=[168960], 99.95th=[978944],
| 99.99th=[1810432]
bw (KB /s): min= 204, max=671811, per=30.11%, avg=40196.30, stdev=96106.60
lat (usec) : 2=5.78%, 4=9.29%, 10=0.13%, 20=4.86%, 50=25.48%
lat (usec) : 100=26.95%, 250=11.30%, 500=1.84%, 750=0.36%, 1000=0.11%
lat (msec) : 2=0.11%, 4=0.04%, 10=4.94%, 20=4.49%, 50=3.61%
lat (msec) : 100=0.50%, 250=0.13%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.04%, >=2000=0.01%
cpu : usr=91.02%, sys=4.89%, ctx=850123, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-writers: (groupid=0, jobs=1): err= 0: pid=20891: Thu Sep 19 14:23:10 2013
write: io=0B, bw=33380KB/s, iops=1043, runt=376965msec
slat (usec): min=2, max=468272, avg=47.89, stdev=1580.12
clat (usec): min=1, max=2510.5K, avg=3779.73, stdev=36566.28
lat (usec): min=21, max=2510.6K, avg=3827.62, stdev=36602.10
clat percentiles (usec):
| 1.00th=[ 1], 5.00th=[ 1], 10.00th=[ 2], 20.00th=[ 18],
| 30.00th=[ 35], 40.00th=[ 43], 50.00th=[ 51], 60.00th=[ 65],
| 70.00th=[ 88], 80.00th=[ 151], 90.00th=[10048], 95.00th=[20096],
| 99.00th=[40704], 99.50th=[60160], 99.90th=[162816], 99.95th=[978944],
| 99.99th=[1810432]
bw (KB /s): min= 214, max=1087559, per=27.81%, avg=37133.41, stdev=95359.67
lat (usec) : 2=6.45%, 4=9.36%, 10=0.13%, 20=4.67%, 50=27.52%
lat (usec) : 100=24.79%, 250=11.22%, 500=1.53%, 750=0.26%, 1000=0.09%
lat (msec) : 2=0.10%, 4=0.04%, 10=4.75%, 20=4.56%, 50=3.81%
lat (msec) : 100=0.51%, 250=0.13%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.04%, >=2000=0.01%
cpu : usr=91.74%, sys=4.85%, ctx=843154, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=0/w=393216/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=20892: Thu Sep 19 14:23:10 2013
read : io=0B, bw=559539KB/s, iops=17485, runt= 22488msec
slat (usec): min=0, max=99866, avg= 4.35, stdev=159.33
clat (usec): min=1, max=1528.7K, avg=222.58, stdev=9377.56
lat (usec): min=11, max=1528.7K, avg=226.93, stdev=9378.99
clat percentiles (usec):
| 1.00th=[ 13], 5.00th=[ 16], 10.00th=[ 18], 20.00th=[ 21],
| 30.00th=[ 22], 40.00th=[ 23], 50.00th=[ 24], 60.00th=[ 26],
| 70.00th=[ 28], 80.00th=[ 31], 90.00th=[ 36], 95.00th=[ 42],
| 99.00th=[ 61], 99.50th=[ 87], 99.90th=[49408], 99.95th=[72192],
| 99.99th=[309248]
bw (KB /s): min= 1117, max=4037056, per=29.83%, avg=667541.89, stdev=1310176.92
lat (usec) : 2=0.03%, 4=0.04%, 10=0.01%, 20=13.97%, 50=83.64%
lat (usec) : 100=1.87%, 250=0.09%, 500=0.02%, 750=0.01%, 1000=0.01%
lat (msec) : 2=0.01%, 4=0.01%, 10=0.05%, 20=0.06%, 50=0.09%
lat (msec) : 100=0.07%, 250=0.01%, 500=0.01%, 750=0.01%, 1000=0.01%
lat (msec) : 2000=0.01%
cpu : usr=90.63%, sys=36.08%, ctx=426096, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=20893: Thu Sep 19 14:23:10 2013
read : io=0B, bw=2186.5MB/s, iops=69967, runt= 5620msec
slat (usec): min=1, max=120254, avg= 5.13, stdev=222.94
clat (usec): min=1, max=439760, avg=49.88, stdev=1363.27
lat (usec): min=17, max=439765, avg=55.02, stdev=1381.71
clat percentiles (usec):
| 1.00th=[ 19], 5.00th=[ 22], 10.00th=[ 24], 20.00th=[ 27],
| 30.00th=[ 30], 40.00th=[ 32], 50.00th=[ 35], 60.00th=[ 39],
| 70.00th=[ 43], 80.00th=[ 51], 90.00th=[ 64], 95.00th=[ 82],
| 99.00th=[ 135], 99.50th=[ 167], 99.90th=[ 314], 99.95th=[ 478],
| 99.99th=[ 8768]
bw (MB /s): min= 165, max= 2893, per=100.00%, avg=2189.93, stdev=987.11
lat (usec) : 2=0.01%, 4=0.02%, 10=0.07%, 20=0.91%, 50=77.76%
lat (usec) : 100=18.48%, 250=2.59%, 500=0.11%, 750=0.02%, 1000=0.01%
lat (msec) : 2=0.01%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.01%
lat (msec) : 100=0.01%, 250=0.01%, 500=0.01%
cpu : usr=89.45%, sys=180.58%, ctx=574338, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=20894: Thu Sep 19 14:23:10 2013
read : io=0B, bw=1743.5MB/s, iops=55791, runt= 7048msec
slat (usec): min=1, max=330150, avg= 7.31, stdev=545.46
clat (usec): min=1, max=411391, avg=62.17, stdev=1947.24
lat (usec): min=17, max=411403, avg=69.48, stdev=2026.74
clat percentiles (usec):
| 1.00th=[ 21], 5.00th=[ 25], 10.00th=[ 26], 20.00th=[ 29],
| 30.00th=[ 31], 40.00th=[ 34], 50.00th=[ 37], 60.00th=[ 41],
| 70.00th=[ 46], 80.00th=[ 54], 90.00th=[ 72], 95.00th=[ 95],
| 99.00th=[ 167], 99.50th=[ 205], 99.90th=[ 418], 99.95th=[ 668],
| 99.99th=[21632]
bw (MB /s): min= 83, max= 2487, per=78.96%, avg=1725.83, stdev=940.58
lat (usec) : 2=0.01%, 4=0.01%, 10=0.01%, 20=0.49%, 50=74.21%
lat (usec) : 100=20.78%, 250=4.21%, 500=0.20%, 750=0.03%, 1000=0.01%
lat (msec) : 2=0.01%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.01%
lat (msec) : 100=0.01%, 250=0.01%, 500=0.01%
cpu : usr=78.52%, sys=152.44%, ctx=601879, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
random-readers: (groupid=0, jobs=1): err= 0: pid=20895: Thu Sep 19 14:23:10 2013
read : io=0B, bw=1530.9MB/s, iops=48986, runt= 8027msec
slat (usec): min=1, max=60930, avg= 6.68, stdev=156.98
clat (usec): min=1, max=358568, avg=72.85, stdev=1809.87
lat (usec): min=16, max=358573, avg=79.53, stdev=1832.56
clat percentiles (usec):
| 1.00th=[ 19], 5.00th=[ 21], 10.00th=[ 24], 20.00th=[ 26],
| 30.00th=[ 29], 40.00th=[ 31], 50.00th=[ 34], 60.00th=[ 37],
| 70.00th=[ 42], 80.00th=[ 50], 90.00th=[ 69], 95.00th=[ 96],
| 99.00th=[ 183], 99.50th=[ 235], 99.90th=[ 588], 99.95th=[10176],
| 99.99th=[70144]
bw (MB /s): min= 44, max= 3566, per=64.94%, avg=1419.38, stdev=990.44
lat (usec) : 2=0.05%, 4=0.05%, 10=0.01%, 20=1.82%, 50=77.23%
lat (usec) : 100=16.19%, 250=4.22%, 500=0.30%, 750=0.04%, 1000=0.01%
lat (msec) : 2=0.01%, 4=0.01%, 10=0.01%, 20=0.01%, 50=0.02%
lat (msec) : 100=0.02%, 250=0.01%, 500=0.01%
cpu : usr=88.23%, sys=120.89%, ctx=564572, majf=0, minf=0
IO depths : 1=0.1%, 2=0.1%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
issued : total=r=393216/w=0/d=0, short=r=0/w=0/d=0
Run status group 0 (all jobs):
READ: io=49152MB, aggrb=2185.8MB/s, minb=559538KB/s, maxb=2186.5MB/s, mint=5620msec, maxt=22488msec
WRITE: io=49152MB, aggrb=133518KB/s, minb=33379KB/s, maxb=36015KB/s, mint=349372msec, maxt=376965msec