Sorry, fat fingered.
Hi All,
We're noticing some TCP rtt/congestion window/aggregation issues when using
wi-fi on fedora 22 or greater. Something being used to help debug is a
read delay on the server, i.e. have a n millisecond delay between an
accept() and a server thread's initial read(). Also, a display of this
latency. For now, I've used a -q <int value milliseconds> to prototype
this.
iperf -s -e -q 200 -B 192.168.1.70 -l 16384 -i 0.5 -fb -p 61001
Server thread scheduling latency is 0.200279 seconds
iperf -s -e -q 0 -B 192.168.1.70 -l 16384 -i 0.5 -fb -p 61001
Server thread scheduling latency is 0.000272 seconds
I was wondering if this was of interest to the larger group? An example
run is shown below. (Note: There is a tool on top that is abstracting and
managing the iperf processes.)
utf> tcp configure -readdelay 300 -w 1M
utf> tcp start; UTF::Sleep 0.5; tcp stop
13:40:47.427 LOG itx-lx3 iperf -s -e -q 300 -B 192.168.1.70 -w 1M -l
16384 -i 0.01 -fb -p 61001
13:40:47.481 HNDLR_ tcp-rx Server listening on TCP port 61001
(SoftAP,file10)
13:40:47.482 HNDLR_ tcp-rx Binding to local address 192.168.1.70
(SoftAP,file10)
13:40:47.482 HNDLR_ tcp-rx TCP window size: 2097152 Byte (WARNING:
requested 1048576 Byte) (SoftAP,file10)
13:40:47.487 LOG skylake-lx1 iperf -c 192.168.1.70 -e -w 1M -B
192.168.1.122 -i 0.01 -fb -S 0x0 -T 255 -t 5356800 -p 61001
13:40:47.534 HNDLR tcp-tx
------------------------------------------------------------
(skylake,file11)
13:40:47.535 HNDLR_ tcp-rx [ 4] local 192.168.1.70 port 61001
connected with 192.168.1.122 port 59220 (SoftAP,file10)
13:40:47.535 HNDLR tcp-tx Client connecting to 192.168.1.70, TCP port
61001 (skylake,file11)
13:40:47.536 INFO Sleep 0.5 sec
13:40:47.536 HNDLR tcp-tx Binding to local address 192.168.1.122
(skylake,file11)
13:40:47.536 HNDLR tcp-tx TCP window size: 2097152 Byte (WARNING:
requested 1048576 Byte) (skylake,file11)
13:40:47.536 HNDLR tcp-tx
------------------------------------------------------------
(skylake,file11)
13:40:47.539 HNDLR tcp-tx [ 3] local 192.168.1.122 port 59220
connected with 192.168.1.70 port 61001 (skylake,file11)
13:40:47.552 HNDLR tcp-tx [ ID] Interval Transfer Bandwidth
Write/Err Rtry Cwnd/RTT (skylake,file11)
13:40:47.552 HNDLR tcp-tx [ 3] 0.00-0.01 sec 750064 Bytes 600051200
bits/sec 7/0 0 171K/2391 (skylake,file11)
13:40:47.562 HNDLR tcp-tx [ 3] 0.01-0.02 sec 163624 Bytes 130899200
bits/sec 2/0 0 192K/2451 (skylake,file11)
13:40:47.572 HNDLR tcp-tx [ 3] 0.02-0.03 sec 163624 Bytes 130899200
bits/sec 2/0 0 192K/2451 (skylake,file11)
13:40:47.573 HNDLR tcp-tx [ 3] 0.03-0.04 sec 0.00 Bytes 0.00
bits/sec 0/2 0 192K/2451 (skylake,file11)
13:40:47.593 HNDLR tcp-tx [ 3] 0.04-0.05 sec 0.00 Bytes 0.00
bits/sec 0/2 0 386K/7274 (skylake,file11)
13:40:47.593 HNDLR tcp-tx [ 3] 0.05-0.06 sec 0.00 Bytes 0.00
bits/sec 0/2 0 386K/7274 (skylake,file11)
13:40:47.603 HNDLR tcp-tx [ 3] 0.06-0.07 sec 198376 Bytes 158700800
bits/sec 2/1 0 386K/7274 (skylake,file11)
13:40:47.612 HNDLR tcp-tx [ 3] 0.07-0.08 sec 0.00 Bytes 0.00
bits/sec 0/2 0 386K/7274 (skylake,file11)
13:40:47.623 HNDLR tcp-tx [ 3] 0.08-0.09 sec 0.00 Bytes 0.00
bits/sec 0/2 0 386K/7274 (skylake,file11)
13:40:47.634 HNDLR tcp-tx [ 3] 0.09-0.10 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/11362 (skylake,file11)
13:40:47.643 HNDLR tcp-tx [ 3] 0.10-0.11 sec 396752 Bytes 317401600
bits/sec 4/1 0 773K/11362 (skylake,file11)
13:40:47.653 HNDLR tcp-tx [ 3] 0.11-0.12 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/11362 (skylake,file11)
13:40:47.663 HNDLR tcp-tx [ 3] 0.12-0.13 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/11362 (skylake,file11)
13:40:47.673 HNDLR tcp-tx [ 3] 0.13-0.14 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/14955 (skylake,file11)
13:40:47.684 HNDLR tcp-tx [ 3] 0.14-0.15 sec 224440 Bytes 179552000
bits/sec 2/1 0 773K/14955 (skylake,file11)
13:40:47.695 HNDLR tcp-tx [ 3] 0.15-0.16 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/14955 (skylake,file11)
13:40:47.704 HNDLR tcp-tx [ 3] 0.16-0.17 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/14955 (skylake,file11)
13:40:47.714 HNDLR tcp-tx [ 3] 0.17-0.18 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/18063 (skylake,file11)
13:40:47.725 HNDLR tcp-tx [ 3] 0.18-0.19 sec 34752 Bytes 27801600
bits/sec 1/1 0 773K/18063 (skylake,file11)
13:40:47.735 HNDLR tcp-tx [ 3] 0.19-0.20 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/18063 (skylake,file11)
13:40:47.746 HNDLR tcp-tx [ 3] 0.20-0.21 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/18063 (skylake,file11)
13:40:47.756 HNDLR tcp-tx [ 3] 0.21-0.22 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/20821 (skylake,file11)
13:40:47.766 HNDLR tcp-tx [ 3] 0.22-0.23 sec 5792 Bytes 4633600
bits/sec 1/1 0 773K/20821 (skylake,file11)
13:40:47.776 HNDLR tcp-tx [ 3] 0.23-0.24 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/20821 (skylake,file11)
13:40:47.787 HNDLR tcp-tx [ 3] 0.24-0.25 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/20821 (skylake,file11)
13:40:47.797 HNDLR tcp-tx [ 3] 0.25-0.26 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/23217 (skylake,file11)
13:40:47.807 HNDLR tcp-tx [ 3] 0.26-0.27 sec 1448 Bytes 1158400
bits/sec 1/1 0 773K/23217 (skylake,file11)
13:40:47.817 HNDLR tcp-tx [ 3] 0.27-0.28 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/23217 (skylake,file11)
13:40:47.827 HNDLR tcp-tx [ 3] 0.28-0.29 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/23217 (skylake,file11)
13:40:47.836 HNDLR_ tcp-rx Server thread scheduling latency is
0.300320 seconds (SoftAP,file10)
13:40:47.836 HNDLR_ tcp-rx [ ID] Interval Transfer Bandwidth
Reads Dist(bin=2.0K) (SoftAP,file10)
13:40:47.837 HNDLR tcp-tx [ 3] 0.29-0.30 sec 0.00 Bytes 0.00
bits/sec 0/2 0 773K/7252 (skylake,file11)
13:40:47.847 HNDLR tcp-tx [ 3] 0.30-0.31 sec 131072 Bytes 104857600
bits/sec 1/1 0 773K/3775 (skylake,file11)
13:40:47.858 HNDLR tcp-tx [ 3] 0.31-0.32 sec 660984 Bytes 528787200
bits/sec 6/0 0 773K/3521 (skylake,file11)
13:40:47.868 HNDLR tcp-tx [ 3] 0.32-0.33 sec 418528 Bytes 334822400
bits/sec 4/0 0 773K/4193 (skylake,file11)
13:40:47.878 HNDLR tcp-tx [ 3] 0.33-0.34 sec 248304 Bytes 198643200
bits/sec 2/0 0 773K/3448 (skylake,file11)
13:40:47.887 HNDLR tcp-tx [ 3] 0.34-0.35 sec 679808 Bytes 543846400
bits/sec 6/0 0 773K/3575 (skylake,file11)
13:40:47.898 HNDLR tcp-tx [ 3] 0.35-0.36 sec 422816 Bytes 338252800
bits/sec 4/0 0 773K/4083 (skylake,file11)
13:40:47.908 HNDLR tcp-tx [ 3] 0.36-0.37 sec 456176 Bytes 364940800
bits/sec 4/0 0 773K/3541 (skylake,file11)
13:40:47.918 HNDLR tcp-tx [ 3] 0.37-0.38 sec 542944 Bytes 434355200
bits/sec 6/0 0 773K/3788 (skylake,file11)
13:40:47.928 HNDLR tcp-tx [ 3] 0.38-0.39 sec 440192 Bytes 352153600
bits/sec 4/0 0 773K/3484 (skylake,file11)
13:40:47.938 HNDLR tcp-tx [ 3] 0.39-0.40 sec 608160 Bytes 486528000
bits/sec 6/0 0 773K/4443 (skylake,file11)
13:40:47.948 HNDLR tcp-tx [ 3] 0.40-0.41 sec 388064 Bytes 310451200
bits/sec 3/0 0 773K/3634 (skylake,file11)
13:40:47.959 HNDLR tcp-tx [ 3] 0.41-0.42 sec 385168 Bytes 308134400
bits/sec 3/0 0 773K/3944 (skylake,file11)
13:40:47.969 HNDLR tcp-tx [ 3] 0.42-0.43 sec 693648 Bytes 554918400
bits/sec 6/0 0 773K/3841 (skylake,file11)
13:40:47.979 HNDLR tcp-tx [ 3] 0.43-0.44 sec 408336 Bytes 326668800
bits/sec 4/0 0 773K/3682 (skylake,file11)
13:40:47.989 HNDLR tcp-tx [ 3] 0.44-0.45 sec 399648 Bytes 319718400
bits/sec 4/0 0 773K/4115 (skylake,file11)
13:40:47.999 HNDLR tcp-tx [ 3] 0.45-0.46 sec 434400 Bytes 347520000
bits/sec 4/0 0 773K/3410 (skylake,file11)
13:40:48.009 HNDLR tcp-tx [ 3] 0.46-0.47 sec 410480 Bytes 328384000
bits/sec 4/0 0 773K/3287 (skylake,file11)
13:40:48.020 HNDLR tcp-tx [ 3] 0.47-0.48 sec 401792 Bytes 321433600
bits/sec 4/0 0 773K/4056 (skylake,file11)
13:40:48.030 HNDLR tcp-tx [ 3] 0.48-0.49 sec 393856 Bytes 315084800
bits/sec 4/0 0 773K/3419 (skylake,file11)
13:40:48.042 INFO tcp Kill signal -HUP sent to (skylake,file11) :
iperf -c 192.168.1.70 -e -w 1M -B 192.168.1.122 -i 0.01 -fb -S 0x0 -T 255
-t 5356800 -p 61001
13:40:48.046 INFO tcp Kill signal -HUP sent to (SoftAP,file10) :
iperf -s -e -q 300 -B 192.168.1.70 -w 1M -l 16384 -i 0.01 -fb -p 61001
13:40:48.047 HNDLR tcp-tx [ 3] 0.49-0.50 sec 457568 Bytes 366054400
bits/sec 4/0 0 773K/3407 (skylake,file11)
13:40:48.047 HNDLR tcp-tx Close actions for event handler
(skylake,file11)
13:40:48.048 INFO tcp-tx Closed : (skylake,file11)
utf>
Bob
On Mon, Feb 22, 2016 at 1:41 PM, Bob McMahon <bob.mcma...@broadcom.com>
wrote:
> Hi All,
>
> We're noticing some TCP rtt/congestion window/aggregation issues when
> using wi-fi on fedora 22 or greater. Something being used to help debug
> is a read delay on the server, i.e. have a n millisecond delay between an
> accept() and a server thread's initial read(). Also, a display of this
> latency. For now, I've used a -q <int value milliseconds> to prototype
> this.
>
> iperf -s -e -q 200 -B 192.168.1.70 -l 16384 -i 0.5 -fb -p 61001
> Server thread scheduling latency is 0.200279 seconds
>
> iperf -s -e -q 0 -B 192.168.1.70 -l 16384 -i 0.5 -fb -p 61001
> Server thread scheduling latency is 0.000272 seconds
>
>
>
------------------------------------------------------------------------------
Site24x7 APM Insight: Get Deep Visibility into Application Performance
APM + Mobile APM + RUM: Monitor 3 App instances at just $35/Month
Monitor end-to-end web transactions and take corrective actions now
Troubleshoot faster and improve end-user experience. Signup Now!
http://pubads.g.doubleclick.net/gampad/clk?id=272487151&iu=/4140
_______________________________________________
Iperf-users mailing list
Iperf-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/iperf-users
