mtls.log

Namespace(baseline=False, bothsidecar=True, cacert=None, client=None, clientsidecar=False, config_file='./configs/istio/plaintext/latency.yaml', conn=None, duration=None, extra_labels=None, headers=None, ingress=None, mesh='istio', mode='http', perf=False, qps=None, server=None, serversidecar=False, size=1024, telemetry_mode='mixer')
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 2 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 0ec0d497_qps_1000_c_2_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:43:17 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 2 threads at 1000.0 qps
Starting at 1000 qps with 2 thread(s) [gomax 32] for 2m0s : 60000 calls each (total 120000)
01:45:17 I periodic.go:543> T001 ended after 2m0.001283344s : 60000 calls. qps=499.99465279051924
01:45:17 I periodic.go:543> T000 ended after 2m0.001357521s : 60000 calls. qps=499.99434372648756
Ended after 2m0.001381503s : 120000 calls. qps=999.99
Sleep times : count 119998 avg 0.00065088069 +/- 0.0001559 min -0.003944566 max 0.001040605 sum 78.1043809
Aggregated Function Time : count 120000 avg 0.00120467 +/- 0.000144 min 0.000838102 max 0.005860338 sum 144.560404
# range, mid point, percentile, count
>= 0.000838102 <= 0.0009 , 0.000869051 , 0.04, 44
> 0.0009 <= 0.001 , 0.00095 , 2.90, 3435
> 0.001 <= 0.00125 , 0.001125 , 66.70, 76559
> 0.00125 <= 0.0015 , 0.001375 , 97.75, 37260
> 0.0015 <= 0.00175 , 0.001625 , 99.61, 2231
> 0.00175 <= 0.002 , 0.001875 , 99.83, 267
> 0.002 <= 0.00225 , 0.002125 , 99.91, 97
> 0.00225 <= 0.0025 , 0.002375 , 99.96, 58
> 0.0025 <= 0.003 , 0.00275 , 99.98, 21
> 0.003 <= 0.0035 , 0.00325 , 99.99, 20
> 0.0035 <= 0.004 , 0.00375 , 100.00, 5
> 0.004 <= 0.0045 , 0.00425 , 100.00, 1
> 0.005 <= 0.00586034 , 0.00543017 , 100.00, 2
# target 50% 0.00118457
# target 75% 0.00131684
# target 90% 0.00143761
# target 99% 0.00166831
# target 99.9% 0.00221649
Sockets used: 2 (for perfect keepalive, would be 2)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 2 warmup) 1.205 ms avg, 1000.0 qps
Successfully wrote 3334 bytes of Json data to 2020-03-26-014317_0ec0d497_qps_1000_c_2_1024_none_plaintext_both.json
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 4 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 0ec0d497_qps_1000_c_4_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:45:17 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 4 threads at 1000.0 qps
Starting at 1000 qps with 4 thread(s) [gomax 32] for 2m0s : 30000 calls each (total 120000)
01:47:17 I periodic.go:543> T000 ended after 2m0.00193837s : 30000 calls. qps=249.99596179439612
01:47:17 I periodic.go:543> T003 ended after 2m0.00234095s : 30000 calls. qps=249.99512311597118
01:47:17 I periodic.go:543> T002 ended after 2m0.002384177s : 30000 calls. qps=249.99503306326716
01:47:17 I periodic.go:543> T001 ended after 2m0.002382431s : 30000 calls. qps=249.99503670062265
Ended after 2m0.002437699s : 120000 calls. qps=999.98
Sleep times : count 119996 avg 0.0021744989 +/- 0.0002047 min -0.00216885 max 0.002882478 sum 260.931169
Aggregated Function Time : count 120000 avg 0.001662544 +/- 0.0001915 min 0.001026266 max 0.006002931 sum 199.505279
# range, mid point, percentile, count
>= 0.00102627 <= 0.00125 , 0.00113813 , 0.83, 997
> 0.00125 <= 0.0015 , 0.001375 , 17.65, 20178
> 0.0015 <= 0.00175 , 0.001625 , 71.29, 64376
> 0.00175 <= 0.002 , 0.001875 , 96.19, 29883
> 0.002 <= 0.00225 , 0.002125 , 99.39, 3829
> 0.00225 <= 0.0025 , 0.002375 , 99.79, 488
> 0.0025 <= 0.003 , 0.00275 , 99.96, 204
> 0.003 <= 0.0035 , 0.00325 , 99.97, 14
> 0.0035 <= 0.004 , 0.00375 , 99.99, 20
> 0.004 <= 0.0045 , 0.00425 , 99.99, 4
> 0.0045 <= 0.005 , 0.00475 , 100.00, 3
> 0.005 <= 0.006 , 0.0055 , 100.00, 3
> 0.006 <= 0.00600293 , 0.00600147 , 100.00, 1
# target 50% 0.00165077
# target 75% 0.00178722
# target 90% 0.00193781
# target 99% 0.00221977
# target 99.9% 0.00281618
Sockets used: 4 (for perfect keepalive, would be 4)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 4 warmup) 1.663 ms avg, 1000.0 qps
Successfully wrote 3310 bytes of Json data to 2020-03-26-014517_0ec0d497_qps_1000_c_4_1024_none_plaintext_both.json
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 8 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 0ec0d497_qps_1000_c_8_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:47:18 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 8 threads at 1000.0 qps
Starting at 1000 qps with 8 thread(s) [gomax 32] for 2m0s : 15000 calls each (total 120000)
01:49:18 I periodic.go:543> T006 ended after 2m0.002487898s : 15000 calls. qps=124.99740849331171
01:49:18 I periodic.go:543> T005 ended after 2m0.002851411s : 15000 calls. qps=124.9970298507843
01:49:18 I periodic.go:543> T001 ended after 2m0.002895175s : 15000 calls. qps=124.99698426546732
01:49:18 I periodic.go:543> T000 ended after 2m0.002963545s : 15000 calls. qps=124.9969130501943
01:49:18 I periodic.go:543> T003 ended after 2m0.002992167s : 15000 calls. qps=124.99688323709063
01:49:18 I periodic.go:543> T002 ended after 2m0.003003428s : 15000 calls. qps=124.99687150746836
01:49:18 I periodic.go:543> T004 ended after 2m0.003046423s : 15000 calls. qps=124.99682672326786
01:49:18 I periodic.go:543> T007 ended after 2m0.003066967s : 15000 calls. qps=124.99680532435805
Ended after 2m0.003096332s : 120000 calls. qps=999.97
Sleep times : count 119992 avg 0.0050942156 +/- 0.0003642 min 0.00155677 max 0.006823065 sum 611.265122
Aggregated Function Time : count 120000 avg 0.0027093645 +/- 0.0003426 min 0.001071547 max 0.006325324 sum 325.123742
# range, mid point, percentile, count
>= 0.00107155 <= 0.00125 , 0.00116077 , 0.07, 84
> 0.00125 <= 0.0015 , 0.001375 , 0.39, 381
> 0.0015 <= 0.00175 , 0.001625 , 0.76, 448
> 0.00175 <= 0.002 , 0.001875 , 2.20, 1722
> 0.002 <= 0.00225 , 0.002125 , 10.75, 10261
> 0.00225 <= 0.0025 , 0.002375 , 23.03, 14739
> 0.0025 <= 0.003 , 0.00275 , 83.59, 72670
> 0.003 <= 0.0035 , 0.00325 , 98.98, 18477
> 0.0035 <= 0.004 , 0.00375 , 99.89, 1087
> 0.004 <= 0.0045 , 0.00425 , 99.97, 98
> 0.0045 <= 0.005 , 0.00475 , 99.98, 6
> 0.005 <= 0.006 , 0.0055 , 100.00, 21
> 0.006 <= 0.00632532 , 0.00616266 , 100.00, 6
# target 50% 0.00272268
# target 75% 0.0029291
# target 90% 0.00320823
# target 99% 0.00350828
# target 99.9% 0.00405612
Sockets used: 8 (for perfect keepalive, would be 8)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 8 warmup) 2.709 ms avg, 1000.0 qps
Successfully wrote 3277 bytes of Json data to 2020-03-26-014718_0ec0d497_qps_1000_c_8_1024_none_plaintext_both.json
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 16 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 0ec0d497_qps_1000_c_16_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:49:19 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 16 threads at 1000.0 qps
Starting at 1000 qps with 16 thread(s) [gomax 32] for 2m0s : 7500 calls each (total 120000)
01:51:19 I periodic.go:543> T001 ended after 2m0.005310835s : 7500 calls. qps=62.49723406251614
01:51:19 I periodic.go:543> T000 ended after 2m0.005423013s : 7500 calls. qps=62.49717564170027
01:51:19 I periodic.go:543> T007 ended after 2m0.005438176s : 7500 calls. qps=62.497167745019176
01:51:19 I periodic.go:543> T012 ended after 2m0.005449933s : 7500 calls. qps=62.49716162213725
01:51:19 I periodic.go:543> T006 ended after 2m0.006265114s : 7500 calls. qps=62.49673709014585
01:51:19 I periodic.go:543> T003 ended after 2m0.006345697s : 7500 calls. qps=62.496695124243665
01:51:19 I periodic.go:543> T014 ended after 2m0.006360134s : 7500 calls. qps=62.496687605768926
01:51:19 I periodic.go:543> T013 ended after 2m0.006371635s : 7500 calls. qps=62.49668161630025
01:51:19 I periodic.go:543> T008 ended after 2m0.006384646s : 7500 calls. qps=62.496674840458056
01:51:19 I periodic.go:543> T010 ended after 2m0.006390473s : 7500 calls. qps=62.49667180588529
01:51:19 I periodic.go:543> T002 ended after 2m0.006588152s : 7500 calls. qps=62.49656885920731
01:51:19 I periodic.go:543> T015 ended after 2m0.006587563s : 7500 calls. qps=62.496569165944464
01:51:19 I periodic.go:543> T005 ended after 2m0.006593479s : 7500 calls. qps=62.49656608503288
01:51:19 I periodic.go:543> T009 ended after 2m0.006625829s : 7500 calls. qps=62.496549237930495
01:51:19 I periodic.go:543> T011 ended after 2m0.006632142s : 7500 calls. qps=62.4965459502729
01:51:19 I periodic.go:543> T004 ended after 2m0.006615935s : 7500 calls. qps=62.49655439048691
Ended after 2m0.00681906s : 120000 calls. qps=999.94
Sleep times : count 119984 avg 0.011123441 +/- 0.0008164 min 0.006527401 max 0.014420101 sum 1334.6349
Aggregated Function Time : count 120000 avg 0.0046259392 +/- 0.0007855 min 0.001455965 max 0.009290561 sum 555.112705
# range, mid point, percentile, count
>= 0.00145597 <= 0.0015 , 0.00147798 , 0.01, 9
> 0.0015 <= 0.00175 , 0.001625 , 0.57, 670
> 0.00175 <= 0.002 , 0.001875 , 1.39, 984
> 0.002 <= 0.00225 , 0.002125 , 1.97, 705
> 0.00225 <= 0.0025 , 0.002375 , 2.35, 456
> 0.0025 <= 0.003 , 0.00275 , 3.14, 942
> 0.003 <= 0.0035 , 0.00325 , 7.90, 5715
> 0.0035 <= 0.004 , 0.00375 , 19.39, 13793
> 0.004 <= 0.0045 , 0.00425 , 33.48, 16903
> 0.0045 <= 0.005 , 0.00475 , 67.45, 40761
> 0.005 <= 0.006 , 0.0055 , 98.17, 36866
> 0.006 <= 0.007 , 0.0065 , 99.94, 2124
> 0.007 <= 0.008 , 0.0075 , 99.98, 44
> 0.008 <= 0.009 , 0.0085 , 99.99, 20
> 0.009 <= 0.00929056 , 0.00914528 , 100.00, 8
# target 50% 0.00474316
# target 75% 0.00524581
# target 90% 0.00573406
# target 99% 0.00646893
# target 99.9% 0.0069774
Sockets used: 16 (for perfect keepalive, would be 16)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 16 warmup) 4.626 ms avg, 999.9 qps
Successfully wrote 3576 bytes of Json data to 2020-03-26-014919_0ec0d497_qps_1000_c_16_1024_none_plaintext_both.json

plaintext.log

Namespace(baseline=False, bothsidecar=True, cacert=None, client=None, clientsidecar=False, config_file='./configs/istio/plaintext/latency.yaml', conn=None, duration=None, extra_labels=None, headers=None, ingress=None, mesh='istio', mode='http', perf=False, qps=None, server=None, serversidecar=False, size=1024, telemetry_mode='mixer')
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 2 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 1cea2d13_qps_1000_c_2_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:24:24 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 2 threads at 1000.0 qps
Starting at 1000 qps with 2 thread(s) [gomax 32] for 2m0s : 60000 calls each (total 120000)
01:26:24 I periodic.go:543> T000 ended after 2m0.001417303s : 60000 calls. qps=499.9940946405807
01:26:24 I periodic.go:543> T001 ended after 2m0.001434576s : 60000 calls. qps=499.9940226714578
Ended after 2m0.001574487s : 120000 calls. qps=999.99
Sleep times : count 119998 avg 0.00074670742 +/- 0.000146 min -0.002656395 max 0.001109707 sum 89.6033965
Aggregated Function Time : count 120000 avg 0.0011121117 +/- 0.0001383 min 0.000759605 max 0.004526859 sum 133.453399
# range, mid point, percentile, count
>= 0.000759605 <= 0.0008 , 0.000779802 , 0.01, 9
> 0.0008 <= 0.0009 , 0.00085 , 1.79, 2143
> 0.0009 <= 0.001 , 0.00095 , 20.31, 22221
> 0.001 <= 0.00125 , 0.001125 , 85.67, 78431
> 0.00125 <= 0.0015 , 0.001375 , 98.97, 15962
> 0.0015 <= 0.00175 , 0.001625 , 99.78, 973
> 0.00175 <= 0.002 , 0.001875 , 99.93, 175
> 0.002 <= 0.00225 , 0.002125 , 99.97, 48
> 0.00225 <= 0.0025 , 0.002375 , 99.98, 17
> 0.0025 <= 0.003 , 0.00275 , 99.99, 7
> 0.003 <= 0.0035 , 0.00325 , 99.99, 6
> 0.0035 <= 0.004 , 0.00375 , 100.00, 6
> 0.0045 <= 0.00452686 , 0.00451343 , 100.00, 2
# target 50% 0.00111356
# target 75% 0.00120919
# target 90% 0.00133138
# target 99% 0.00150874
# target 99.9% 0.00195143
Sockets used: 2 (for perfect keepalive, would be 2)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 2 warmup) 1.112 ms avg, 1000.0 qps
Successfully wrote 3324 bytes of Json data to 2020-03-26-012424_1cea2d13_qps_1000_c_2_1024_none_plaintext_both.json
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 4 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 1cea2d13_qps_1000_c_4_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:26:25 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 4 threads at 1000.0 qps
Starting at 1000 qps with 4 thread(s) [gomax 32] for 2m0s : 30000 calls each (total 120000)
01:28:25 I periodic.go:543> T002 ended after 2m0.001667885s : 30000 calls. qps=249.99652528787848
01:28:25 I periodic.go:543> T001 ended after 2m0.001889682s : 30000 calls. qps=249.99606322449378
01:28:25 I periodic.go:543> T000 ended after 2m0.001909807s : 30000 calls. qps=249.99602129873793
01:28:25 I periodic.go:543> T003 ended after 2m0.001910826s : 30000 calls. qps=249.99601917588885
Ended after 2m0.00196562s : 120000 calls. qps=999.98
Sleep times : count 119996 avg 0.0022843084 +/- 0.0002064 min -0.001518769 max 0.002882847 sum 274.107871
Aggregated Function Time : count 120000 avg 0.0015502482 +/- 0.0001932 min 0.000830821 max 0.005308988 sum 186.029789
# range, mid point, percentile, count
>= 0.000830821 <= 0.0009 , 0.000865411 , 0.00, 1
> 0.001 <= 0.00125 , 0.001125 , 5.04, 6044
> 0.00125 <= 0.0015 , 0.001375 , 40.26, 42271
> 0.0015 <= 0.00175 , 0.001625 , 87.06, 56161
> 0.00175 <= 0.002 , 0.001875 , 98.19, 13353
> 0.002 <= 0.00225 , 0.002125 , 99.64, 1740
> 0.00225 <= 0.0025 , 0.002375 , 99.88, 287
> 0.0025 <= 0.003 , 0.00275 , 99.97, 106
> 0.003 <= 0.0035 , 0.00325 , 99.98, 18
> 0.0035 <= 0.004 , 0.00375 , 100.00, 14
> 0.004 <= 0.0045 , 0.00425 , 100.00, 4
> 0.005 <= 0.00530899 , 0.00515449 , 100.00, 1
# target 50% 0.00155201
# target 75% 0.00168556
# target 90% 0.00181596
# target 99% 0.00213937
# target 99.9% 0.00260849
Sockets used: 4 (for perfect keepalive, would be 4)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 4 warmup) 1.550 ms avg, 1000.0 qps
Successfully wrote 3222 bytes of Json data to 2020-03-26-012625_1cea2d13_qps_1000_c_4_1024_none_plaintext_both.json
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 8 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 1cea2d13_qps_1000_c_8_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:28:26 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 8 threads at 1000.0 qps
Starting at 1000 qps with 8 thread(s) [gomax 32] for 2m0s : 15000 calls each (total 120000)
01:30:26 I periodic.go:543> T005 ended after 2m0.002507778s : 15000 calls. qps=124.99738778584044
01:30:26 I periodic.go:543> T003 ended after 2m0.002990892s : 15000 calls. qps=124.99688456514941
01:30:26 I periodic.go:543> T000 ended after 2m0.003048406s : 15000 calls. qps=124.99682465774777
01:30:26 I periodic.go:543> T001 ended after 2m0.00319078s : 15000 calls. qps=124.9966763592084
01:30:26 I periodic.go:543> T002 ended after 2m0.003203726s : 15000 calls. qps=124.9966628745103
01:30:26 I periodic.go:543> T006 ended after 2m0.003208087s : 15000 calls. qps=124.99665833204467
01:30:26 I periodic.go:543> T004 ended after 2m0.003675995s : 15000 calls. qps=124.9961709558379
01:30:26 I periodic.go:543> T007 ended after 2m0.003677315s : 15000 calls. qps=124.99616958092214
Ended after 2m0.004458807s : 120000 calls. qps=999.96
Sleep times : count 119992 avg 0.0053352325 +/- 0.0003368 min 0.002094029 max 0.006862499 sum 640.185217
Aggregated Function Time : count 120000 avg 0.0024699966 +/- 0.0003159 min 0.001034916 max 0.005722197 sum 296.39959
# range, mid point, percentile, count
>= 0.00103492 <= 0.00125 , 0.00114246 , 0.25, 299
> 0.00125 <= 0.0015 , 0.001375 , 0.77, 626
> 0.0015 <= 0.00175 , 0.001625 , 1.73, 1146
> 0.00175 <= 0.002 , 0.001875 , 7.82, 7315
> 0.002 <= 0.00225 , 0.002125 , 20.87, 15658
> 0.00225 <= 0.0025 , 0.002375 , 50.48, 35531
> 0.0025 <= 0.003 , 0.00275 , 96.52, 55243
> 0.003 <= 0.0035 , 0.00325 , 99.82, 3961
> 0.0035 <= 0.004 , 0.00375 , 99.97, 189
> 0.004 <= 0.0045 , 0.00425 , 99.99, 17
> 0.0045 <= 0.005 , 0.00475 , 99.99, 8
> 0.005 <= 0.0057222 , 0.0053611 , 100.00, 7
# target 50% 0.00249595
# target 75% 0.00276632
# target 90% 0.00292924
# target 99% 0.00337642
# target 99.9% 0.0037672
Sockets used: 8 (for perfect keepalive, would be 8)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 8 warmup) 2.470 ms avg, 1000.0 qps
Successfully wrote 3201 bytes of Json data to 2020-03-26-012826_1cea2d13_qps_1000_c_8_1024_none_plaintext_both.json
-------------- Running in both sidecar mode --------------
kubectl --namespace twopods-istio exec fortioclient-9c8d6768f-glqtx  -- fortio load  -c 16 -qps 1000 -t 120s -a -r 0.00005   -httpbufferkb=128 -labels 1cea2d13_qps_1000_c_16_1024_none_plaintext_both http://fortioserver:8080/echo?size=1024
Defaulting container name to captured.
Use 'kubectl describe pod/fortioclient-9c8d6768f-glqtx -n twopods-istio' to see all of the containers in this pod.
Fortio 1.3.2-pre running at 1000 queries per second, 32->32 procs, for 2m0s: http://fortioserver:8080/echo?size=1024
01:30:26 I httprunner.go:82> Starting http test for http://fortioserver:8080/echo?size=1024 with 16 threads at 1000.0 qps
Starting at 1000 qps with 16 thread(s) [gomax 32] for 2m0s : 7500 calls each (total 120000)
01:32:26 I periodic.go:543> T009 ended after 2m0.003893506s : 7500 calls. qps=62.49797219808549
01:32:26 I periodic.go:543> T003 ended after 2m0.004366535s : 7500 calls. qps=62.49772584577228
01:32:26 I periodic.go:543> T010 ended after 2m0.004900452s : 7500 calls. qps=62.49744778547504
01:32:26 I periodic.go:543> T008 ended after 2m0.005300618s : 7500 calls. qps=62.49723938339978
01:32:26 I periodic.go:543> T015 ended after 2m0.005333947s : 7500 calls. qps=62.49722202608388
01:32:26 I periodic.go:543> T007 ended after 2m0.005321257s : 7500 calls. qps=62.497228634872044
01:32:26 I periodic.go:543> T011 ended after 2m0.005384758s : 7500 calls. qps=62.49719556438506
01:32:26 I periodic.go:543> T012 ended after 2m0.005400708s : 7500 calls. qps=62.49718725784
01:32:26 I periodic.go:543> T004 ended after 2m0.005407675s : 7500 calls. qps=62.49718362952097
01:32:26 I periodic.go:543> T001 ended after 2m0.005416038s : 7500 calls. qps=62.497179274184646
01:32:26 I periodic.go:543> T014 ended after 2m0.005425567s : 7500 calls. qps=62.49717431161218
01:32:26 I periodic.go:543> T013 ended after 2m0.005413121s : 7500 calls. qps=62.497180793318385
01:32:26 I periodic.go:543> T006 ended after 2m0.005407159s : 7500 calls. qps=62.497183898246746
01:32:26 I periodic.go:543> T000 ended after 2m0.005442347s : 7500 calls. qps=62.4971655728203
01:32:26 I periodic.go:543> T005 ended after 2m0.005413115s : 7500 calls. qps=62.49718079644311
01:32:26 I periodic.go:543> T002 ended after 2m0.005430751s : 7500 calls. qps=62.49717161185643
Ended after 2m0.005526304s : 120000 calls. qps=999.95
Sleep times : count 119984 avg 0.011653908 +/- 0.0007146 min 0.007801116 max 0.014567419 sum 1398.28252
Aggregated Function Time : count 120000 avg 0.0041071873 +/- 0.000688 min 0.001299489 max 0.008034768 sum 492.862472
# range, mid point, percentile, count
>= 0.00129949 <= 0.0015 , 0.00139974 , 0.09, 106
> 0.0015 <= 0.00175 , 0.001625 , 0.85, 910
> 0.00175 <= 0.002 , 0.001875 , 1.86, 1221
> 0.002 <= 0.00225 , 0.002125 , 2.42, 665
> 0.00225 <= 0.0025 , 0.002375 , 2.87, 544
> 0.0025 <= 0.003 , 0.00275 , 6.07, 3832
> 0.003 <= 0.0035 , 0.00325 , 18.03, 14357
> 0.0035 <= 0.004 , 0.00375 , 34.10, 19283
> 0.004 <= 0.0045 , 0.00425 , 71.74, 45168
> 0.0045 <= 0.005 , 0.00475 , 94.34, 27121
> 0.005 <= 0.006 , 0.0055 , 99.94, 6723
> 0.006 <= 0.007 , 0.0065 , 99.98, 49
> 0.007 <= 0.008 , 0.0075 , 100.00, 20
> 0.008 <= 0.00803477 , 0.00801738 , 100.00, 1
# target 50% 0.00421123
# target 75% 0.00457216
# target 90% 0.004904
# target 99% 0.00583192
# target 99.9% 0.00599256
Sockets used: 16 (for perfect keepalive, would be 16)
Jitter: false
Code 200 : 120000 (100.0 %)
Response Header Sizes : count 120000 avg 167 +/- 0 min 167 max 167 sum 20040000
Response Body/Total Sizes : count 120000 avg 1191 +/- 0 min 1191 max 1191 sum 142920000
All done 120000 calls (plus 16 warmup) 4.107 ms avg, 1000.0 qps
Successfully wrote 3461 bytes of Json data to 2020-03-26-013026_1cea2d13_qps_1000_c_16_1024_none_plaintext_both.json