Page MenuHomePhabricator
Paste P10324

HTTP vs HTTPS local latency
ActivePublic

Authored by BBlack on Thu, Feb 6, 7:24 PM.
bblack@cp1075:~$ wrk -t1 -c1 -d10s --latency -H 'X-Forwarded-Proto: https' https://en.wikipedia.org/favicon.ico
Running 10s test @ https://en.wikipedia.org/favicon.ico
1 threads and 1 connections
Thread Stats Avg Stdev Max +/- Stdev
Latency 8.29ms 11.84ms 87.16ms 86.63%
Req/Sec 293.42 121.50 690.00 68.00%
Latency Distribution
50% 786.00us
75% 12.31ms
90% 23.73ms
99% 53.50ms
2924 requests in 10.01s, 10.47MB read
Requests/sec: 292.12
Transfer/sec: 1.05MB
=====
bblack@cp1075:~$ wrk -t1 -c1 -d10s --latency -H 'X-Forwarded-Proto: https' http://en.wikipedia.org/favicon.ico
Running 10s test @ http://en.wikipedia.org/favicon.ico
1 threads and 1 connections
Thread Stats Avg Stdev Max +/- Stdev
Latency 141.61us 28.23us 1.58ms 86.61%
Req/Sec 7.01k 394.99 7.64k 83.17%
Latency Distribution
50% 132.00us
75% 148.00us
90% 180.00us
99% 228.00us
70453 requests in 10.10s, 254.51MB read
Requests/sec: 6975.53
Transfer/sec: 25.20MB

Event Timeline

BBlack created this paste.Thu, Feb 6, 7:24 PM
vgutierrez@cp1075:~$ wrk -t1 -c1 -d10s --latency -H 'X-Forwarded-Proto: https' https://en.wikipedia.org/favicon.ico
Running 10s test @ https://en.wikipedia.org/favicon.ico
  1 threads and 1 connections
  Thread Stats   Avg      Stdev     Max   +/- Stdev
    Latency     8.33ms   13.28ms 140.15ms   89.15%
    Req/Sec   306.79    141.88   747.00     65.66%
  Latency Distribution
     50%  811.00us
     75%   11.72ms
     90%   22.78ms
     99%   60.95ms
  3032 requests in 10.01s, 10.86MB read
Requests/sec:    303.03
Transfer/sec:      1.09MB
vgutierrez@cp1075:~$ wrk -t1 -c1 -d10s --latency -H 'X-Forwarded-Proto: https' -H 'Host: en.wikipedia.org' http://127.0.0.1:3128/favicon.ico
Running 10s test @ http://127.0.0.1:3128/favicon.ico
  1 threads and 1 connections
  Thread Stats   Avg      Stdev     Max   +/- Stdev
    Latency     3.46ms    6.31ms  50.96ms   84.39%
    Req/Sec     4.68k     1.52k    8.26k    64.00%
  Latency Distribution
     50%  114.00us
     75%    4.30ms
     90%   13.66ms
     99%   23.83ms
  46570 requests in 10.00s, 141.05MB read
Requests/sec:   4655.94
Transfer/sec:     14.10MB

Tested again on cp1075 (now running buster) before disabling DNS on ats-tls and after:

before
vgutierrez@cp1075:~$ ./hey -c 1 -z 10s https://en.wikipedia.org/favicon.ico

Summary:
  Total:	10.0166 secs
  Slowest:	0.0785 secs
  Fastest:	0.0005 secs
  Average:	0.0019 secs
  Requests/sec:	530.8187


Response time histogram:
  0.001 [1]	|
  0.008 [4927]	|■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■
  0.016 [249]	|■■
  0.024 [94]	|■
  0.032 [28]	|
  0.039 [6]	|
  0.047 [7]	|
  0.055 [1]	|
  0.063 [3]	|
  0.071 [0]	|
  0.078 [1]	|


Latency distribution:
  10% in 0.0006 secs
  25% in 0.0006 secs
  50% in 0.0007 secs
  75% in 0.0007 secs
  90% in 0.0011 secs
  95% in 0.0097 secs
  99% in 0.0222 secs

Details (average, fastest, slowest):
  DNS+dialup:	0.0000 secs, 0.0005 secs, 0.0785 secs
  DNS-lookup:	0.0000 secs, 0.0000 secs, 0.0007 secs
  req write:	0.0000 secs, 0.0000 secs, 0.0004 secs
  resp wait:	0.0017 secs, 0.0004 secs, 0.0783 secs
  resp read:	0.0001 secs, 0.0001 secs, 0.0009 secs

Status code distribution:
  [200]	5317 responses
after
vgutierrez@cp1075:~$ ./hey -c 1 -z 10s https://en.wikipedia.org/favicon.ico

Summary:
  Total:	10.0005 secs
  Slowest:	0.0279 secs
  Fastest:	0.0005 secs
  Average:	0.0007 secs
  Requests/sec:	1349.2330


Response time histogram:
  0.000 [1]	|
  0.003 [13440]	|■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■■
  0.006 [0]	|
  0.009 [0]	|
  0.011 [0]	|
  0.014 [1]	|
  0.017 [3]	|
  0.020 [38]	|
  0.022 [7]	|
  0.025 [1]	|
  0.028 [2]	|


Latency distribution:
  10% in 0.0006 secs
  25% in 0.0006 secs
  50% in 0.0007 secs
  75% in 0.0007 secs
  90% in 0.0008 secs
  95% in 0.0008 secs
  99% in 0.0010 secs

Details (average, fastest, slowest):
  DNS+dialup:	0.0000 secs, 0.0005 secs, 0.0279 secs
  DNS-lookup:	0.0000 secs, 0.0000 secs, 0.0007 secs
  req write:	0.0000 secs, 0.0000 secs, 0.0001 secs
  resp wait:	0.0006 secs, 0.0004 secs, 0.0278 secs
  resp read:	0.0001 secs, 0.0001 secs, 0.0008 secs

Status code distribution:
  [200]	13493 responses