shchuko

anka-fio-ablk

Feb 15th, 2021 (edited)
917
0
Never
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
C++ 14.19 KB | None | 0 0
  1. Last login: Mon Feb 15 00:04:16 on ttys001
  2.  
  3. The default interactive shell is now zsh.
  4. To update your account to use zsh, please run `chsh -s /bin/zsh`.
  5. For more details, please visit https://support.apple.com/kb/HT208050.
  6. Mac-mini:fio anka$ ./runjobs.sh test-file
  7. Continue with test-file? [y/N] y
  8. randwrite: (g=0): rw=randwrite, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=posixaio, iodepth=32
  9. fio-3.19
  10. Starting 1 process
  11. Jobs: 1 (f=1): [w(1)][100.0%][w=57.5MiB/s][w=14.7k IOPS][eta 00m:00s]
  12. randwrite: (groupid=0, jobs=1): err= 0: pid=830: Mon Feb 15 00:08:21 2021
  13.   write: IOPS=11.9k, BW=46.6MiB/s (48.8MB/s)(932MiB/20001msec)
  14.     slat (nsec): min=676, max=4521.2k, avg=65560.19, stdev=55158.72
  15.     clat (usec): min=16, max=2934.2k, avg=777.04, stdev=24025.59
  16.      lat (usec): min=39, max=2934.2k, avg=842.60, stdev=24025.25
  17.     clat percentiles (usec):
  18.      |  1.00th=[   20],  5.00th=[   69], 10.00th=[  127], 20.00th=[  233],
  19.      | 30.00th=[  334], 40.00th=[  437], 50.00th=[  545], 60.00th=[  652],
  20.      | 70.00th=[  758], 80.00th=[  873], 90.00th=[ 1020], 95.00th=[ 1172],
  21.      | 99.00th=[ 1663], 99.50th=[ 1909], 99.90th=[ 2966], 99.95th=[ 4228],
  22.      | 99.99th=[72877]
  23.    bw (  KiB/s): min= 6236, max=63624, per=100.00%, avg=53487.54, stdev=10817.33, samples=26
  24.    iops        : min= 1559, max=15906, avg=13371.58, stdev=2704.31, samples=26
  25.   lat (usec)   : 20=1.64%, 50=2.26%, 100=3.84%, 250=13.89%, 500=24.29%
  26.   lat (usec)   : 750=23.40%, 1000=19.46%
  27.   lat (msec)   : 2=10.82%, 4=0.35%, 10=0.04%, 100=0.01%, >=2000=0.01%
  28.   cpu          : usr=5.72%, sys=25.14%, ctx=240221, majf=0, minf=27
  29.   IO depths    : 1=4.1%, 2=12.7%, 4=25.5%, 8=51.3%, 16=6.4%, 32=0.0%, >=64=0.0%
  30.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  31.      complete  : 0=0.0%, 4=94.3%, 8=0.1%, 16=5.7%, 32=0.0%, 64=0.0%, >=64=0.0%
  32.      issued rwts: total=0,238509,0,0 short=0,0,0,0 dropped=0,0,0,0
  33.      latency   : target=0, window=0, percentile=100.00%, depth=32
  34.  
  35. Run status group 0 (all jobs):
  36.   WRITE: bw=46.6MiB/s (48.8MB/s), 46.6MiB/s-46.6MiB/s (48.8MB/s-48.8MB/s), io=932MiB (977MB), run=20001-20001msec
  37. ----------------------------
  38. seqwrite: (g=0): rw=write, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=posixaio, iodepth=32
  39. fio-3.19
  40. Starting 1 process
  41. Jobs: 1 (f=1): [W(1)][100.0%][w=122MiB/s][w=31.4k IOPS][eta 00m:00s]
  42. seqwrite: (groupid=0, jobs=1): err= 0: pid=897: Mon Feb 15 00:08:36 2021
  43.   write: IOPS=36.3k, BW=142MiB/s (149MB/s)(2048MiB/14450msec)
  44.     slat (nsec): min=672, max=2587.3k, avg=25253.75, stdev=15826.98
  45.     clat (usec): min=15, max=3215, avg=221.96, stdev=130.16
  46.      lat (usec): min=36, max=3254, avg=247.21, stdev=130.45
  47.     clat percentiles (usec):
  48.      |  1.00th=[   17],  5.00th=[   22], 10.00th=[   54], 20.00th=[   98],
  49.      | 30.00th=[  137], 40.00th=[  176], 50.00th=[  212], 60.00th=[  258],
  50.      | 70.00th=[  302], 80.00th=[  343], 90.00th=[  388], 95.00th=[  429],
  51.      | 99.00th=[  529], 99.50th=[  586], 99.90th=[  750], 99.95th=[  840],
  52.      | 99.99th=[ 1418]
  53.    bw (  KiB/s): min=123464, max=154517, per=99.67%, avg=144658.47, stdev=9408.70, samples=19
  54.    iops        : min=30866, max=38629, avg=36164.21, stdev=2352.09, samples=19
  55.   lat (usec)   : 20=4.69%, 50=2.62%, 100=14.18%, 250=36.55%, 500=40.43%
  56.   lat (usec)   : 750=1.42%, 1000=0.07%
  57.   lat (msec)   : 2=0.02%, 4=0.01%
  58.   cpu          : usr=9.95%, sys=48.41%, ctx=266445, majf=0, minf=26
  59.   IO depths    : 1=5.4%, 2=12.6%, 4=25.2%, 8=50.5%, 16=6.3%, 32=0.0%, >=64=0.0%
  60.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  61.      complete  : 0=0.0%, 4=94.4%, 8=0.1%, 16=5.6%, 32=0.0%, 64=0.0%, >=64=0.0%
  62.      issued rwts: total=0,524288,0,0 short=0,0,0,0 dropped=0,0,0,0
  63.      latency   : target=0, window=0, percentile=100.00%, depth=32
  64.  
  65. Run status group 0 (all jobs):
  66.   WRITE: bw=142MiB/s (149MB/s), 142MiB/s-142MiB/s (149MB/s-149MB/s), io=2048MiB (2147MB), run=14450-14450msec
  67. ----------------------------
  68. seqwrite-sync: (g=0): rw=write, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=psync, iodepth=1
  69. fio-3.19
  70. Starting 1 process
  71. Jobs: 1 (f=1): [W(1)][-.-%][w=757MiB/s][w=194k IOPS][eta 00m:00s]
  72. seqwrite-sync: (groupid=0, jobs=1): err= 0: pid=899: Mon Feb 15 00:08:40 2021
  73.   write: IOPS=193k, BW=753MiB/s (789MB/s)(2048MiB/2721msec)
  74.     clat (usec): min=2, max=7122, avg= 4.74, stdev=11.41
  75.      lat (usec): min=2, max=7122, avg= 4.81, stdev=11.42
  76.     clat percentiles (usec):
  77.      |  1.00th=[    4],  5.00th=[    4], 10.00th=[    4], 20.00th=[    4],
  78.      | 30.00th=[    4], 40.00th=[    4], 50.00th=[    5], 60.00th=[    5],
  79.      | 70.00th=[    5], 80.00th=[    5], 90.00th=[    5], 95.00th=[    5],
  80.      | 99.00th=[   37], 99.50th=[   48], 99.90th=[   65], 99.95th=[   75],
  81.      | 99.99th=[  143]
  82.    bw (  KiB/s): min=769246, max=781740, per=100.00%, avg=773731.25, stdev=5600.98, samples=4
  83.    iops        : min=192311, max=195435, avg=193432.50, stdev=1400.52, samples=4
  84.   lat (usec)   : 4=49.94%, 10=47.79%, 20=1.12%, 50=0.76%, 100=0.36%
  85.   lat (usec)   : 250=0.02%, 500=0.01%, 750=0.01%, 1000=0.01%
  86.   lat (msec)   : 2=0.01%, 10=0.01%
  87.   cpu          : usr=16.88%, sys=82.43%, ctx=156, majf=0, minf=29
  88.   IO depths    : 1=100.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
  89.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  90.      complete  : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  91.      issued rwts: total=0,524288,0,0 short=0,0,0,0 dropped=0,0,0,0
  92.      latency   : target=0, window=0, percentile=100.00%, depth=1
  93.  
  94. Run status group 0 (all jobs):
  95.   WRITE: bw=753MiB/s (789MB/s), 753MiB/s-753MiB/s (789MB/s-789MB/s), io=2048MiB (2147MB), run=2721-2721msec
  96. ----------------------------
  97. randread: (g=0): rw=randread, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=posixaio, iodepth=32
  98. fio-3.19
  99. Starting 1 process
  100. Jobs: 1 (f=1): [r(1)][100.0%][r=83.5MiB/s][r=21.4k IOPS][eta 00m:00s]
  101. randread: (groupid=0, jobs=1): err= 0: pid=901: Mon Feb 15 00:09:01 2021
  102.   read: IOPS=20.3k, BW=79.2MiB/s (83.1MB/s)(1585MiB/20001msec)
  103.     slat (nsec): min=643, max=1680.0k, avg=21109.37, stdev=42418.47
  104.     clat (usec): min=18, max=329327, avg=632.31, stdev=1085.24
  105.      lat (usec): min=52, max=329327, avg=653.41, stdev=1085.87
  106.     clat percentiles (usec):
  107.      |  1.00th=[  130],  5.00th=[  297], 10.00th=[  396], 20.00th=[  453],
  108.      | 30.00th=[  523], 40.00th=[  562], 50.00th=[  594], 60.00th=[  627],
  109.      | 70.00th=[  676], 80.00th=[  742], 90.00th=[  881], 95.00th=[ 1037],
  110.      | 99.00th=[ 1352], 99.50th=[ 1549], 99.90th=[ 2573], 99.95th=[ 6194],
  111.      | 99.99th=[39060]
  112.    bw (  KiB/s): min=67467, max=94130, per=99.97%, avg=81109.79, stdev=5575.71, samples=34
  113.    iops        : min=16866, max=23532, avg=20277.09, stdev=1393.92, samples=34
  114.   lat (usec)   : 20=0.08%, 50=0.22%, 100=0.17%, 250=2.76%, 500=21.49%
  115.   lat (usec)   : 750=56.32%, 1000=13.08%
  116.   lat (msec)   : 2=5.69%, 4=0.13%, 10=0.04%, 20=0.01%, 50=0.01%
  117.   lat (msec)   : 100=0.01%, 250=0.01%, 500=0.01%
  118.   cpu          : usr=9.53%, sys=22.29%, ctx=200157, majf=0, minf=29
  119.   IO depths    : 1=0.2%, 2=2.4%, 4=6.3%, 8=67.9%, 16=23.2%, 32=0.0%, >=64=0.0%
  120.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  121.      complete  : 0=0.0%, 4=96.3%, 8=2.5%, 16=1.2%, 32=0.0%, 64=0.0%, >=64=0.0%
  122.      issued rwts: total=405711,0,0,0 short=0,0,0,0 dropped=0,0,0,0
  123.      latency   : target=0, window=0, percentile=100.00%, depth=32
  124.  
  125. Run status group 0 (all jobs):
  126.    READ: bw=79.2MiB/s (83.1MB/s), 79.2MiB/s-79.2MiB/s (83.1MB/s-83.1MB/s), io=1585MiB (1662MB), run=20001-20001msec
  127. ----------------------------
  128. seqread: (g=0): rw=read, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=posixaio, iodepth=32
  129. fio-3.19
  130. Starting 1 process
  131. Jobs: 1 (f=1): [R(1)][100.0%][r=78.8MiB/s][r=20.2k IOPS][eta 00m:00s]
  132. seqread: (groupid=0, jobs=1): err= 0: pid=903: Mon Feb 15 00:09:22 2021
  133.   read: IOPS=19.2k, BW=75.1MiB/s (78.8MB/s)(1502MiB/20001msec)
  134.     slat (nsec): min=641, max=3131.4k, avg=22135.69, stdev=47626.25
  135.     clat (usec): min=11, max=224682, avg=669.28, stdev=1028.10
  136.      lat (usec): min=51, max=224683, avg=691.41, stdev=1029.88
  137.     clat percentiles (usec):
  138.      |  1.00th=[  137],  5.00th=[  322], 10.00th=[  408], 20.00th=[  498],
  139.      | 30.00th=[  537], 40.00th=[  578], 50.00th=[  611], 60.00th=[  652],
  140.      | 70.00th=[  701], 80.00th=[  783], 90.00th=[  955], 95.00th=[ 1123],
  141.      | 99.00th=[ 1582], 99.50th=[ 1860], 99.90th=[ 3294], 99.95th=[ 7439],
  142.      | 99.99th=[41681]
  143.    bw (  KiB/s): min=51496, max=89780, per=100.00%, avg=77376.26, stdev=10918.71, samples=34
  144.    iops        : min=12874, max=22445, avg=19343.62, stdev=2729.75, samples=34
  145.   lat (usec)   : 20=0.07%, 50=0.23%, 100=0.17%, 250=2.43%, 500=17.32%
  146.   lat (usec)   : 750=56.59%, 1000=14.89%
  147.   lat (msec)   : 2=7.95%, 4=0.28%, 10=0.04%, 20=0.02%, 50=0.02%
  148.   lat (msec)   : 100=0.01%, 250=0.01%
  149.   cpu          : usr=9.12%, sys=22.60%, ctx=191199, majf=0, minf=30
  150.   IO depths    : 1=0.2%, 2=2.4%, 4=6.2%, 8=66.8%, 16=24.4%, 32=0.0%, >=64=0.0%
  151.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  152.      complete  : 0=0.0%, 4=96.8%, 8=2.0%, 16=1.1%, 32=0.0%, 64=0.0%, >=64=0.0%
  153.      issued rwts: total=384568,0,0,0 short=0,0,0,0 dropped=0,0,0,0
  154.      latency   : target=0, window=0, percentile=100.00%, depth=32
  155.  
  156. Run status group 0 (all jobs):
  157.    READ: bw=75.1MiB/s (78.8MB/s), 75.1MiB/s-75.1MiB/s (78.8MB/s-78.8MB/s), io=1502MiB (1575MB), run=20001-20001msec
  158. ----------------------------
  159. seqread-sync: (g=0): rw=read, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=psync, iodepth=1
  160. fio-3.19
  161. Starting 1 process
  162. Jobs: 1 (f=1): [R(1)][100.0%][r=31.2MiB/s][r=7993 IOPS][eta 00m:00s]
  163. seqread-sync: (groupid=0, jobs=1): err= 0: pid=937: Mon Feb 15 00:09:43 2021
  164.   read: IOPS=6825, BW=26.7MiB/s (27.0MB/s)(533MiB/20000msec)
  165.     clat (nsec): min=1291, max=167885k, avg=143869.56, stdev=706510.06
  166.      lat (nsec): min=1373, max=167886k, avg=144130.40, stdev=706512.43
  167.     clat percentiles (usec):
  168.      |  1.00th=[  102],  5.00th=[  104], 10.00th=[  106], 20.00th=[  110],
  169.      | 30.00th=[  115], 40.00th=[  119], 50.00th=[  123], 60.00th=[  127],
  170.      | 70.00th=[  135], 80.00th=[  145], 90.00th=[  159], 95.00th=[  180],
  171.      | 99.00th=[  330], 99.50th=[  562], 99.90th=[ 2638], 99.95th=[ 5407],
  172.      | 99.99th=[17433]
  173.    bw (  KiB/s): min=12272, max=34693, per=97.74%, avg=26685.03, stdev=6920.10, samples=32
  174.    iops        : min= 3068, max= 8673, avg=6670.97, stdev=1730.04, samples=32
  175.   lat (usec)   : 2=0.18%, 4=0.01%, 10=0.01%, 50=0.01%, 100=0.29%
  176.   lat (usec)   : 250=97.97%, 500=0.96%, 750=0.24%, 1000=0.08%
  177.   lat (msec)   : 2=0.13%, 4=0.06%, 10=0.06%, 20=0.01%, 50=0.01%
  178.   lat (msec)   : 100=0.01%, 250=0.01%
  179.   cpu          : usr=2.90%, sys=32.83%, ctx=140470, majf=0, minf=33
  180.   IO depths    : 1=100.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=0.0%
  181.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  182.      complete  : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  183.      issued rwts: total=136510,0,0,0 short=0,0,0,0 dropped=0,0,0,0
  184.      latency   : target=0, window=0, percentile=100.00%, depth=1
  185.  
  186. Run status group 0 (all jobs):
  187.    READ: bw=26.7MiB/s (27.0MB/s), 26.7MiB/s-26.7MiB/s (27.0MB/s-27.0MB/s), io=533MiB (559MB), run=20000-20000msec
  188. ----------------------------
  189. randrw: (g=0): rw=randrw, bs=(R) 4096B-4096B, (W) 4096B-4096B, (T) 4096B-4096B, ioengine=posixaio, iodepth=32
  190. fio-3.19
  191. Starting 1 process
  192. Jobs: 1 (f=1): [m(1)][30.3%][eta 00m:53s]                                              
  193. randrw: (groupid=0, jobs=1): err= 0: pid=992: Mon Feb 15 00:10:07 2021
  194.   read: IOPS=3363, BW=13.1MiB/s (13.8MB/s)(301MiB/22877msec)
  195.     slat (nsec): min=642, max=127121k, avg=102701.73, stdev=1014100.28
  196.     clat (usec): min=17, max=3766.4k, avg=1669.50, stdev=43300.65
  197.      lat (usec): min=87, max=3766.5k, avg=1772.20, stdev=43311.56
  198.     clat percentiles (usec):
  199.      |  1.00th=[     22],  5.00th=[    149], 10.00th=[    225],
  200.      | 20.00th=[    359], 30.00th=[    494], 40.00th=[    627],
  201.      | 50.00th=[    766], 60.00th=[    898], 70.00th=[   1045],
  202.      | 80.00th=[   1237], 90.00th=[   1631], 95.00th=[   1942],
  203.      | 99.00th=[   3425], 99.50th=[  11731], 99.90th=[ 109577],
  204.      | 99.95th=[ 143655], 99.99th=[3774874]
  205.    bw (  KiB/s): min=   15, max=23863, per=100.00%, avg=15723.51, stdev=3939.27, samples=35
  206.    iops        : min=    3, max= 5965, avg=3930.60, stdev=984.84, samples=35
  207.   write: IOPS=3346, BW=13.1MiB/s (13.7MB/s)(299MiB/22877msec)
  208.     slat (nsec): min=683, max=129564k, avg=106052.25, stdev=1168832.59
  209.     clat (usec): min=17, max=3766.1k, avg=1346.76, stdev=33793.79
  210.      lat (usec): min=43, max=3766.1k, avg=1452.81, stdev=33813.52
  211.     clat percentiles (usec):
  212.      |  1.00th=[    21],  5.00th=[    71], 10.00th=[   147], 20.00th=[   277],
  213.      | 30.00th=[   408], 40.00th=[   537], 50.00th=[   668], 60.00th=[   807],
  214.      | 70.00th=[   955], 80.00th=[  1156], 90.00th=[  1549], 95.00th=[  1876],
  215.      | 99.00th=[  3064], 99.50th=[  8455], 99.90th=[ 99091], 99.95th=[130548],
  216.      | 99.99th=[219153]
  217.    bw (  KiB/s): min=   47, max=22494, per=100.00%, avg=15640.86, stdev=3862.46, samples=35
  218.    iops        : min=   11, max= 5623, avg=3909.83, stdev=965.71, samples=35
  219.   lat (usec)   : 20=0.51%, 50=2.67%, 100=1.79%, 250=9.92%, 500=18.87%
  220.   lat (usec)   : 750=18.82%, 1000=17.19%
  221.   lat (msec)   : 2=26.22%, 4=3.19%, 10=0.31%, 20=0.11%, 50=0.12%
  222.   lat (msec)   : 100=0.16%, 250=0.09%, >=2000=0.01%
  223.   cpu          : usr=3.38%, sys=15.88%, ctx=165847, majf=0, minf=34
  224.   IO depths    : 1=3.3%, 2=11.7%, 4=25.5%, 8=52.9%, 16=6.8%, 32=0.0%, >=64=0.0%
  225.      submit    : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
  226.      complete  : 0=0.0%, 4=94.2%, 8=0.2%, 16=5.7%, 32=0.0%, 64=0.0%, >=64=0.0%
  227.      issued rwts: total=76954,76553,0,0 short=0,0,0,0 dropped=0,0,0,0
  228.      latency   : target=0, window=0, percentile=100.00%, depth=32
  229.  
  230. Run status group 0 (all jobs):
  231.    READ: bw=13.1MiB/s (13.8MB/s), 13.1MiB/s-13.1MiB/s (13.8MB/s-13.8MB/s), io=301MiB (315MB), run=22877-22877msec
  232.   WRITE: bw=13.1MiB/s (13.7MB/s), 13.1MiB/s-13.1MiB/s (13.7MB/s-13.7MB/s), io=299MiB (314MB), run=22877-22877msec
  233. ----------------------------
  234. Done!
  235. Mac-mini:fio anka$
  236.  
Add Comment
Please, Sign In to add comment