@@ -26,6 +26,164 @@ deployment quickly resolves the situation.
2626Error from server: etcdserver: request timed out
2727```
2828
29+ ```
30+ Error from server: etcdserver: leader changed
31+ ```
32+
33+ ```
34+ Error from server (InternalError): an error on the server ("") has prevented the request from succeeding (get pods fio-c8xm8)
35+ ```
36+
37+ # First run
38+
39+ This run, all 7 of the nodes are running on zvols in Proxmox 6.4. I think this
40+ what's causing the etcd timeouts according to [ this
41+ thread] ( https://forum.proxmox.com/threads/high-disk-io-overhead-for-clients-on-zfs.80151/ )
42+
43+ ```
44+ ❯ k get pods -o wide
45+ NAME READY STATUS RESTARTS AGE IP NODE NOMINATED NODE READINESS GATES
46+ fio-c8xm8 0/1 Completed 0 5m59s 10.65.91.73 k1-9f87 <none> <none>
47+ fio-g4vzl 0/1 Completed 0 5m59s 10.65.97.10 k1-8843 <none> <none>
48+ fio-lchqb 0/1 Completed 0 5m59s 10.65.128.202 k1-9e1c <none> <none>
49+ ```
50+
51+ ```
52+ # k logs fio-c8xm8
53+ testjob: (groupid=0, jobs=12): err= 0: pid=10: Fri May 14 04:48:08 2021
54+ read: IOPS=3099, BW=24.3MiB/s (25.5MB/s)(1469MiB/60441msec)
55+ slat (usec): min=6, max=3540.7k, avg=1558.36, stdev=20618.60
56+ clat (msec): min=2, max=8167, avg=249.77, stdev=519.20
57+ lat (msec): min=2, max=8168, avg=251.36, stdev=521.86
58+ clat percentiles (msec):
59+ | 1.00th=[ 11], 5.00th=[ 16], 10.00th=[ 22], 20.00th=[ 37],
60+ | 30.00th=[ 56], 40.00th=[ 80], 50.00th=[ 108], 60.00th=[ 146],
61+ | 70.00th=[ 201], 80.00th=[ 296], 90.00th=[ 550], 95.00th=[ 877],
62+ | 99.00th=[ 2467], 99.50th=[ 3876], 99.90th=[ 6812], 99.95th=[ 7416],
63+ | 99.99th=[ 7819]
64+ bw ( KiB/s): min= 298, max=134826, per=100.00%, avg=26346.06, stdev=2160.49, samples=1350
65+ iops : min= 37, max=16853, avg=3292.96, stdev=270.05, samples=1350
66+ write: IOPS=3102, BW=24.3MiB/s (25.5MB/s)(1471MiB/60441msec); 0 zone resets
67+ slat (usec): min=7, max=2726.3k, avg=1544.94, stdev=20722.35
68+ clat (msec): min=3, max=8168, avg=263.67, stdev=533.98
69+ lat (msec): min=3, max=8168, avg=265.27, stdev=536.77
70+ clat percentiles (msec):
71+ | 1.00th=[ 13], 5.00th=[ 20], 10.00th=[ 26], 20.00th=[ 43],
72+ | 30.00th=[ 62], 40.00th=[ 87], 50.00th=[ 116], 60.00th=[ 155],
73+ | 70.00th=[ 211], 80.00th=[ 309], 90.00th=[ 575], 95.00th=[ 927],
74+ | 99.00th=[ 2500], 99.50th=[ 3876], 99.90th=[ 7215], 99.95th=[ 7416],
75+ | 99.99th=[ 7819]
76+ bw ( KiB/s): min= 259, max=138774, per=100.00%, avg=26411.35, stdev=2180.11, samples=1349
77+ iops : min= 32, max=17346, avg=3301.10, stdev=272.51, samples=1349
78+ lat (msec) : 4=0.01%, 10=0.73%, 20=6.52%, 50=18.50%, 100=20.62%
79+ lat (msec) : 250=29.37%, 500=13.36%, 750=4.65%, 1000=2.33%, 2000=2.83%
80+ lat (msec) : >=2000=1.50%
81+ cpu : usr=0.54%, sys=0.93%, ctx=220001, majf=0, minf=699
82+ IO depths : 1=0.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=100.0%
83+ submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
84+ complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.1%
85+ issued rwts: total=187319,187496,0,0 short=0,0,0,0 dropped=0,0,0,0
86+ latency : target=0, window=0, percentile=100.00%, depth=128
87+
88+ Run status group 0 (all jobs):
89+ READ: bw=24.3MiB/s (25.5MB/s), 24.3MiB/s-24.3MiB/s (25.5MB/s-25.5MB/s), io=1469MiB (1541MB), run=60441-60441msec
90+ WRITE: bw=24.3MiB/s (25.5MB/s), 24.3MiB/s-24.3MiB/s (25.5MB/s-25.5MB/s), io=1471MiB (1542MB), run=60441-60441msec
91+
92+ Disk stats (read/write):
93+ sda: ios=188636/188853, merge=6/176, ticks=27586579/28446782, in_queue=57486792, util=100.00%
94+ ```
95+
96+ ```
97+ # k logs fio-g4vzl
98+ testjob: (groupid=0, jobs=12): err= 0: pid=9: Fri May 14 04:46:14 2021
99+ read: IOPS=11.3k, BW=87.0MiB/s (92.3MB/s)(5284MiB/60051msec)
100+ slat (usec): min=5, max=251618, avg=423.78, stdev=2730.90
101+ clat (usec): min=252, max=1086.7k, avg=65384.45, stdev=74248.45
102+ lat (usec): min=312, max=1101.9k, avg=65812.03, stdev=74737.90
103+ clat percentiles (msec):
104+ | 1.00th=[ 6], 5.00th=[ 8], 10.00th=[ 9], 20.00th=[ 12],
105+ | 30.00th=[ 18], 40.00th=[ 27], 50.00th=[ 40], 60.00th=[ 56],
106+ | 70.00th=[ 77], 80.00th=[ 107], 90.00th=[ 157], 95.00th=[ 209],
107+ | 99.00th=[ 347], 99.50th=[ 418], 99.90th=[ 600], 99.95th=[ 684],
108+ | 99.99th=[ 793]
109+ bw ( KiB/s): min= 9408, max=583781, per=98.87%, avg=89094.02, stdev=7590.92, samples=1428
110+ iops : min= 1176, max=72965, avg=11135.63, stdev=948.77, samples=1428
111+ write: IOPS=11.3k, BW=88.0MiB/s (92.3MB/s)(5285MiB/60051msec); 0 zone resets
112+ slat (usec): min=6, max=194375, avg=428.54, stdev=2746.07
113+ clat (usec): min=1137, max=1086.7k, avg=70104.71, stdev=76850.28
114+ lat (usec): min=1159, max=1086.7k, avg=70537.12, stdev=77319.37
115+ clat percentiles (msec):
116+ | 1.00th=[ 7], 5.00th=[ 9], 10.00th=[ 11], 20.00th=[ 13],
117+ | 30.00th=[ 21], 40.00th=[ 31], 50.00th=[ 44], 60.00th=[ 61],
118+ | 70.00th=[ 84], 80.00th=[ 114], 90.00th=[ 165], 95.00th=[ 218],
119+ | 99.00th=[ 359], 99.50th=[ 430], 99.90th=[ 609], 99.95th=[ 693],
120+ | 99.99th=[ 802]
121+ bw ( KiB/s): min=10160, max=578179, per=98.89%, avg=89121.73, stdev=7576.27, samples=1428
122+ iops : min= 1270, max=72267, avg=11139.18, stdev=946.95, samples=1428
123+ lat (usec) : 500=0.01%, 750=0.01%, 1000=0.01%
124+ lat (msec) : 2=0.03%, 4=0.29%, 10=12.21%, 20=18.56%, 50=24.59%
125+ lat (msec) : 100=21.52%, 250=19.79%, 500=2.86%, 750=0.22%, 1000=0.02%
126+ lat (msec) : 2000=0.01%
127+ cpu : usr=1.54%, sys=4.13%, ctx=1292901, majf=0, minf=711
128+ IO depths : 1=0.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=100.0%
129+ submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
130+ complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.1%
131+ issued rwts: total=675673,675692,0,0 short=0,0,0,0 dropped=0,0,0,0
132+ latency : target=0, window=0, percentile=100.00%, depth=128
133+
134+ Run status group 0 (all jobs):
135+ READ: bw=87.0MiB/s (92.3MB/s), 87.0MiB/s-87.0MiB/s (92.3MB/s-92.3MB/s), io=5284MiB (5541MB), run=60051-60051msec
136+ WRITE: bw=88.0MiB/s (92.3MB/s), 88.0MiB/s-88.0MiB/s (92.3MB/s-92.3MB/s), io=5285MiB (5542MB), run=60051-60051msec
137+
138+ Disk stats (read/write):
139+ sda: ios=719725/720400, merge=233/373, ticks=26710138/28593412, in_queue=62634044, util=100.00%
140+ ```
141+
142+ ```
143+ # logs fio-lchqb
144+ testjob: (groupid=0, jobs=12): err= 0: pid=9: Fri May 14 04:48:26 2021
145+ read: IOPS=5104, BW=39.0MiB/s (41.9MB/s)(2402MiB/60079msec)
146+ slat (usec): min=6, max=802100, avg=966.58, stdev=8960.66
147+ clat (msec): min=3, max=2816, avg=145.48, stdev=208.61
148+ lat (msec): min=3, max=2816, avg=146.45, stdev=209.87
149+ clat percentiles (msec):
150+ | 1.00th=[ 7], 5.00th=[ 13], 10.00th=[ 19], 20.00th=[ 34],
151+ | 30.00th=[ 51], 40.00th=[ 69], 50.00th=[ 88], 60.00th=[ 110],
152+ | 70.00th=[ 140], 80.00th=[ 190], 90.00th=[ 309], 95.00th=[ 468],
153+ | 99.00th=[ 1116], 99.50th=[ 1485], 99.90th=[ 2123], 99.95th=[ 2232],
154+ | 99.99th=[ 2601]
155+ bw ( KiB/s): min= 591, max=141856, per=100.00%, avg=41109.57, stdev=2567.72, samples=1417
156+ iops : min= 73, max=17732, avg=5138.41, stdev=320.96, samples=1417
157+ write: IOPS=5108, BW=40.0MiB/s (41.0MB/s)(2404MiB/60079msec); 0 zone resets
158+ slat (usec): min=7, max=762950, avg=983.32, stdev=8862.25
159+ clat (msec): min=3, max=2949, avg=154.51, stdev=213.48
160+ lat (msec): min=3, max=3083, avg=155.51, stdev=214.72
161+ clat percentiles (msec):
162+ | 1.00th=[ 11], 5.00th=[ 17], 10.00th=[ 23], 20.00th=[ 41],
163+ | 30.00th=[ 57], 40.00th=[ 77], 50.00th=[ 95], 60.00th=[ 117],
164+ | 70.00th=[ 148], 80.00th=[ 201], 90.00th=[ 326], 95.00th=[ 489],
165+ | 99.00th=[ 1150], 99.50th=[ 1502], 99.90th=[ 2123], 99.95th=[ 2265],
166+ | 99.99th=[ 2702]
167+ bw ( KiB/s): min= 527, max=141696, per=100.00%, avg=41117.14, stdev=2550.11, samples=1418
168+ iops : min= 65, max=17712, avg=5139.34, stdev=318.76, samples=1418
169+ lat (msec) : 4=0.01%, 10=2.18%, 20=7.21%, 50=18.45%, 100=26.55%
170+ lat (msec) : 250=31.77%, 500=9.41%, 750=2.35%, 1000=1.03%, 2000=1.13%
171+ lat (msec) : >=2000=0.15%
172+ cpu : usr=0.84%, sys=1.54%, ctx=359679, majf=0, minf=699
173+ IO depths : 1=0.0%, 2=0.0%, 4=0.0%, 8=0.0%, 16=0.0%, 32=0.0%, >=64=100.0%
174+ submit : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.0%
175+ complete : 0=0.0%, 4=100.0%, 8=0.0%, 16=0.0%, 32=0.0%, 64=0.0%, >=64=0.1%
176+ issued rwts: total=306670,306939,0,0 short=0,0,0,0 dropped=0,0,0,0
177+ latency : target=0, window=0, percentile=100.00%, depth=128
178+
179+ Run status group 0 (all jobs):
180+ READ: bw=39.0MiB/s (41.9MB/s), 39.0MiB/s-39.0MiB/s (41.9MB/s-41.9MB/s), io=2402MiB (2518MB), run=60079-60079msec
181+ WRITE: bw=40.0MiB/s (41.0MB/s), 40.0MiB/s-40.0MiB/s (41.0MB/s-41.0MB/s), io=2404MiB (2521MB), run=60079-60079msec
182+
183+ Disk stats (read/write):
184+ sda: ios=313580/314089, merge=19/178, ticks=25889231/27114911, in_queue=55047900, util=100.00%
185+ ```
186+
29187# Reference
30188
31189Forked from [ this post] ( https://medium.com/@joshua_robinson/storage-benchmarking-with-fio-in-kubernetes-14cf29dc5375 )
0 commit comments