Menu

#55 iperf's -r option creates low throughput in reverse direction on 100GbE links

1.0
closed
None
2019-12-06
2019-11-27
No

Using iperf 2.0.13 on Ubuntu 18.04 to test 100GbE equipment, I've noticed that using iperf's "-r" option results in the expected throughput in the client-to-server direction, but only a fraction of the expected throughput in the server-to-client direction. A work-around is to manually setup client and server roles on each machine, then manually test data transfer one direction at a time, without using the -r option.

Since manually running iperf in each direction works well, I think there's a bug with the -r option.

It's worth mentioning that this is not an issue when testing 1GbE links in the same machines.

Here is a video showing what I'm seeing:
https://youtu.be/FNySfTvJd0w

Many thanks in advance for help.

Discussion

  • Chris Preimesberger

    I've just cloned the latest source code and installed iperf 2.0.14a from it, and the reverse direction throughput is considerably improved, but still not wire-speed. Here's a video showing that:

    https://youtu.be/c98yMgkVgpI

     
  • Robert McMahon

    Robert McMahon - 2019-11-29

    Hi Chris,

    Thanks for posting this. Can you try your 2.0.14a using --reverse? Also, if you can try with more debugging that could be helpful. To get advanced debugging requires a recompile after ./configure --enable-thread-debug. Finally, the WARNing your seeing is suggesting a mutex lock as a bottleneck. I'll need to make a change to the code to support some options to help fault isolate that. Give me a few days and I'll have something.

    Bob

     
    • Robert McMahon

      Robert McMahon - 2019-11-30

      Hi Chris,

      I adde support for NUM_REPORT_STRUCTS override. I'm curious if this will help. You'll need the latest (Nov 30) iperf 2.0.14a

      [rjmcmahon@localhost iperf2-code]$ src/iperf -c 192.168.100.10 -i 1 -t 4 --NUM_REPORT_STRUCTS 50000 -r -P 4
      ------------------------------------------------------------
      Server listening on TCP port 5001
      TCP window size:  128 KByte (default)
      ------------------------------------------------------------
      [  5] NUM_REPORT_STRUCTS override from 5000 to 50000
      [  6] NUM_REPORT_STRUCTS override from 5000 to 50000
      [  7] NUM_REPORT_STRUCTS override from 5000 to 50000
      [  4] NUM_REPORT_STRUCTS override from 5000 to 50000
      

      Bob

       
      • Chris Preimesberger

        using the latest source with debugging enabled, and adding this "--NUM_REPORT_STRUCTS 50000", here's what I get :

        transcript from the client:

        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ ./iperf -v
        iperf version 2.0.14a (1 Dec 2019) pthreads
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ ./iperf -c 192.168.1.111 -i1 -r -P4
        THREAD(27372):[07:31:41.065921] Init multiheader sum report 0x5594964fece0 id=-1
        THREAD(27372):[07:31:41.066025] Copy thread settings (malloc) from/to=0x5594964fde70/0x5594964ffa20 report/multi/bidir (nil)/0x5594964fece0/(nil)
        THREAD(27372):[07:31:41.066051] Copy thread settings (malloc) from/to=0x5594964fde70/0x5594964ffe50 report/multi/bidir (nil)/0x5594964fece0/(nil)
        THREAD(27372):[07:31:41.066070] Copy thread settings (malloc) from/to=0x5594964fde70/0x559496500e60 report/multi/bidir (nil)/0x5594964fece0/(nil)
        THREAD(27372):[07:31:41.066092] Copy thread settings (malloc) from/to=0x5594964fde70/0x5594965011f0 report/multi/bidir (nil)/0x5594964fece0/(nil)
        THREAD(27372):[07:31:41.066222] Thread_run_wrapper(0x5594965011f0 mode=4) thread counts tot/trfc=1/0
        THREAD(27373):[07:31:41.066298] Reporter thread started
        THREAD(27372):[07:31:41.066318] Thread_run_wrapper(0x5594964fde70 mode=2) thread counts tot/trfc=2/1
        THREAD(27374):[07:31:41.066410] Client thread started in constructor (3200/0)
        THREAD(27372):[07:31:41.066541] Thread_run_wrapper(0x5594964fe930 mode=7) thread counts tot/trfc=3/1
        THREAD(27372):[07:31:41.066651] Thread_run_wrapper(0x5594964ffa20 mode=2) thread counts tot/trfc=4/2
        THREAD(27375):[07:31:41.066668] Init settings report 0x7f9b8c001150
        THREAD(27375):[07:31:41.066715] Update connection report 0x7f9b8c001150 winreq=0 actual=131072
        THREAD(27376):[07:31:41.066742] Client thread started in constructor (1200/0)
        THREAD(27375):[07:31:41.066743] Jobq report 0x7f9b8c001150 (0x4) post
        THREAD(27377):[07:31:41.066804] Client thread started in constructor (1200/0)
        THREAD(27372):[07:31:41.066756] Thread_run_wrapper(0x5594964ffe50 mode=2) thread counts tot/trfc=5/3
        THREAD(27375):[07:31:41.066933] Copy thread settings (malloc) from/to=0x5594964fe930/0x7f9b8c004450 report/multi/bidir 0x7f9b8c001150/(nil)/(nil)
        THREAD(27375):[07:31:41.066966] Listener thread accepting for TCP (sock=3)
        THREAD(27372):[07:31:41.066980] Thread_run_wrapper(0x559496500e60 mode=2) thread counts tot/trfc=6/4
        THREAD(27378):[07:31:41.067068] Client thread started in constructor (1200/0)
        THREAD(27373):[07:31:41.067113] Reporter await done
        THREAD(27373):[07:31:41.067211] Jobq *ROOT* 0x7f9b8c001150 (last=(nil))
        ------------------------------------------------------------
        Server listening on TCP port 5001
        TCP window size:  128 KByte (default)
        ------------------------------------------------------------
        THREAD(27373):[07:31:41.067307] Jobq *FREE* 0x7f9b8c001150 (0) ((nil))
        THREAD(27373):[07:31:41.067348] Free report 0x7f9b8c001150 (flags = 0)
        THREAD(27374):[07:31:41.068118] Job report (nil) uses multireport 0x5594964fece0 and bidirreport is (nil)
        THREAD(27374):[07:31:41.068187] Init 5000 element packet ring=0x7f9b88020f80 producer=0x5594964fe188 consumer=0x559495cfc3a0
        THREAD(27374):[07:31:41.068213] Sum multiheader 0x5594964fece0 ref=0->1
        THREAD(27374):[07:31:41.068231] Init data report 0x7f9b88021350 size 1392 using packetring=0x7f9b88020f80 cond=0x5594964fe188
        THREAD(27374):[07:31:41.068251] Init connection report 0x7f9b88021350
        THREAD(27374):[07:31:41.068269] Update connection report 0x7f9b88021350 winreq=0 actual=87040
        THREAD(27374):[07:31:41.068295] Init settings report 0x7f9b880218d0
        THREAD(27374):[07:31:41.068313] Update connection report 0x7f9b880218d0 winreq=0 actual=87040
        THREAD(27374):[07:31:41.068330] Jobq report 0x7f9b880218d0 (0x4) post
        THREAD(27374):[07:31:41.068355] Jobq report 0x7f9b88021350 (0x9) post
        THREAD(27374):[07:31:41.068381] Client spawn thread normal (sock=5)
        THREAD(27374):[07:31:41.068404] Client start sync enterred
        THREAD(27374):[07:31:41.068420] Barrier WAIT on condition 0x5594964fece8 count=3
        THREAD(27373):[07:31:41.068445] Jobq *WAIT* exit  0x7f9b880218d0 
        THREAD(27373):[07:31:41.068537] Jobq *ROOT* 0x7f9b880218d0 (last=(nil))
        ------------------------------------------------------------
        Client connecting to 192.168.1.111, TCP port 5001
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(27373):[07:31:41.068617] Jobq *FREE* 0x7f9b880218d0 (0) (0x7f9b88021350)
        THREAD(27373):[07:31:41.068638] Free report 0x7f9b880218d0 (flags = 0)
        [  5] local 192.168.1.110 port 41792 connected with 192.168.1.111 port 5001 (ct=0.26 ms)
        [ ID] Interval       Transfer     Bandwidth
        [  5]  0.0- 0.0 sec  0.00 Bytes  -nan bits/sec
        [  5]  0.0- 1.0 sec  0.00 Bytes  0.00 bits/sec
        [  5]  1.0- 2.0 sec  0.00 Bytes  0.00 bits/sec
        THREAD(27376):[07:31:41.068697] Job report (nil) uses multireport 0x5594964fece0 and bidirreport is (nil)
        THREAD(27378):[07:31:41.068755] Job report (nil) uses multireport 0x5594964fece0 and bidirreport is (nil)
        THREAD(27376):[07:31:41.068826] Init 5000 element packet ring=0x7f9b80020f80 producer=0x5594964ffd38 consumer=0x559495cfc3a0
        THREAD(27378):[07:31:41.068861] Init 5000 element packet ring=0x7f9b78021960 producer=0x559496501178 consumer=0x559495cfc3a0
        THREAD(27377):[07:31:41.068742] Job report (nil) uses multireport 0x5594964fece0 and bidirreport is (nil)
        THREAD(27377):[07:31:41.068947] Init 5000 element packet ring=0x7f9b84020f80 producer=0x559496500168 consumer=0x559495cfc3a0
        THREAD(27376):[07:31:41.068869] Sum multiheader 0x5594964fece0 ref=1->2
        THREAD(27376):[07:31:41.069172] Init data report 0x7f9b80021350 size 1392 using packetring=0x7f9b80020f80 cond=0x5594964ffd38
        THREAD(27376):[07:31:41.069214] Init connection report 0x7f9b80021350
        THREAD(27376):[07:31:41.069237] Update connection report 0x7f9b80021350 winreq=0 actual=87040
        THREAD(27378):[07:31:41.069217] Sum multiheader 0x5594964fece0 ref=2->3
        THREAD(27376):[07:31:41.069269] Jobq report 0x7f9b80021350 (0x9) post
        THREAD(27377):[07:31:41.069317] Sum multiheader 0x5594964fece0 ref=3->4
        THREAD(27376):[07:31:41.069340] Client spawn thread normal (sock=6)
        THREAD(27378):[07:31:41.069309] Init data report 0x7f9b78021370 size 1392 using packetring=0x7f9b78021960 cond=0x559496501178
        THREAD(27377):[07:31:41.069351] Init data report 0x7f9b84021350 size 1392 using packetring=0x7f9b84020f80 cond=0x559496500168
        THREAD(27377):[07:31:41.069438] Init connection report 0x7f9b84021350
        THREAD(27377):[07:31:41.069465] Update connection report 0x7f9b84021350 winreq=0 actual=87040
        THREAD(27378):[07:31:41.069413] Init connection report 0x7f9b78021370
        THREAD(27376):[07:31:41.069375] Client start sync enterred
        THREAD(27377):[07:31:41.069486] Jobq report 0x7f9b84021350 (0x9) post
        THREAD(27378):[07:31:41.069537] Update connection report 0x7f9b78021370 winreq=0 actual=87040
        THREAD(27376):[07:31:41.069557] Barrier WAIT on condition 0x5594964fece8 count=2
        THREAD(27377):[07:31:41.069586] Client spawn thread normal (sock=8)
        THREAD(27377):[07:31:41.069649] Client start sync enterred
        THREAD(27377):[07:31:41.069670] Barrier WAIT on condition 0x5594964fece8 count=1
        THREAD(27378):[07:31:41.069610] Jobq report 0x7f9b78021370 (0x9) post
        THREAD(27378):[07:31:41.069728] Client spawn thread normal (sock=9)
        THREAD(27378):[07:31:41.069769] Client start sync enterred
        THREAD(27378):[07:31:41.069805] Barrier BROADCAST on condition 0x5594964fece8
        THREAD(27378):[07:31:41.069829] Barrier EXIT on condition 0x5594964fece8
        THREAD(27376):[07:31:41.069838] Barrier EXIT on condition 0x5594964fece8
        THREAD(27377):[07:31:41.069844] Barrier EXIT on condition 0x5594964fece8
        THREAD(27374):[07:31:41.069839] Barrier EXIT on condition 0x5594964fece8
        THREAD(27376):[07:31:41.069875] Client start sync exited
        THREAD(27374):[07:31:41.069926] Client start sync exited
        THREAD(27378):[07:31:41.069846] Client start sync exited
        THREAD(27377):[07:31:41.069897] Client start sync exited
        THREAD(27373):[07:31:41.073175] Jobq *ROOT* 0x7f9b80021350 (last=0x7f9b88021350)
        [  6] local 192.168.1.110 port 41794 connected with 192.168.1.111 port 5001 (ct=0.23 ms)
        [  8] local 192.168.1.110 port 41796 connected with 192.168.1.111 port 5001 (ct=0.17 ms)
        [  9] local 192.168.1.110 port 41798 connected with 192.168.1.111 port 5001 (ct=0.17 ms)
        [  5]  2.0- 1.0 sec  2.73 GBytes  -23414702080.00 bits/sec
        [SUM]  0.0- 1.0 sec  2.73 GBytes  23.4 Gbits/sec
        [  6]  0.0- 1.0 sec  2.72 GBytes  23.4 Gbits/sec
        [  8]  0.0- 1.0 sec  2.71 GBytes  23.3 Gbits/sec
        [  9]  0.0- 1.0 sec  2.72 GBytes  23.4 Gbits/sec
        [  5]  1.0- 2.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  1.0- 2.0 sec  10.9 GBytes  93.6 Gbits/sec
        [  6]  1.0- 2.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  1.0- 2.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  1.0- 2.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  2.0- 3.0 sec  11.0 GBytes  94.2 Gbits/sec
        [  6]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  2.0- 3.0 sec  2.74 GBytes  23.6 Gbits/sec
        [  5]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  3.0- 4.0 sec  11.0 GBytes  94.1 Gbits/sec
        [  6]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  4.0- 5.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  4.0- 5.0 sec  11.0 GBytes  94.1 Gbits/sec
        [  6]  4.0- 5.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  4.0- 5.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  4.0- 5.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  5.0- 6.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  5.0- 6.0 sec  11.0 GBytes  94.2 Gbits/sec
        [  6]  5.0- 6.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  5.0- 6.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  5.0- 6.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  6.0- 7.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  6.0- 7.0 sec  11.0 GBytes  94.2 Gbits/sec
        [  6]  6.0- 7.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  6.0- 7.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  6.0- 7.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  7.0- 8.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  7.0- 8.0 sec  11.0 GBytes  94.1 Gbits/sec
        [  6]  7.0- 8.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  7.0- 8.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  7.0- 8.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  8.0- 9.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  8.0- 9.0 sec  11.0 GBytes  94.2 Gbits/sec
        [  6]  8.0- 9.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  8.0- 9.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  8.0- 9.0 sec  2.74 GBytes  23.5 Gbits/sec
        THREAD(27377):[07:31:51.070154] Shutdown client's writes on tcp socket 8
        THREAD(27377):[07:31:51.070175] Reporting last packet for 0x7f9b84021350  qdepth=33
        THREAD(27374):[07:31:51.070178] Shutdown client's writes on tcp socket 5
        THREAD(27377):[07:31:51.070178] Traffic thread awaiting reporter to be done with 0x7f9b84021350 and cond 0x559496500168
        THREAD(27374):[07:31:51.070189] Reporting last packet for 0x7f9b88021350  qdepth=30
        THREAD(27374):[07:31:51.070193] Traffic thread awaiting reporter to be done with 0x7f9b88021350 and cond 0x5594964fe188
        THREAD(27378):[07:31:51.070340] Shutdown client's writes on tcp socket 9
        THREAD(27378):[07:31:51.070349] Reporting last packet for 0x7f9b78021370  qdepth=40
        THREAD(27378):[07:31:51.070354] Traffic thread awaiting reporter to be done with 0x7f9b78021370 and cond 0x559496501178
        THREAD(27376):[07:31:51.070422] Shutdown client's writes on tcp socket 6
        THREAD(27376):[07:31:51.070431] Reporting last packet for 0x7f9b80021350  qdepth=41
        THREAD(27376):[07:31:51.070434] Traffic thread awaiting reporter to be done with 0x7f9b80021350 and cond 0x5594964ffd38
        THREAD(27375):[07:31:51.071589] Init multiheader sum report 0x7f9b8c001150 id=-2
        THREAD(27375):[07:31:51.071618] Thread_run_wrapper(0x7f9b8c004450 mode=1) thread counts tot/trfc=7/5
        THREAD(27375):[07:31:51.071622] Copy thread settings (malloc) from/to=0x5594964fe930/0x7f9b8c003fd0 report/multi/bidir 0x7f9b8c001150/(nil)/(nil)
        THREAD(27375):[07:31:51.071625] Listener thread accepting for TCP (sock=3)
        THREAD(27375):[07:31:51.071648] Thread_run_wrapper(0x7f9b8c003fd0 mode=1) thread counts tot/trfc=8/6
        THREAD(27682):[07:31:51.071652] Server spawn settings=0x7f9b8c003fd0 multihdr=0x7f9b8c001150 sock=7
        THREAD(27375):[07:31:51.071653] Copy thread settings (malloc) from/to=0x5594964fe930/0x7f9b8c001940 report/multi/bidir 0x7f9b8c001150/(nil)/(nil)
        THREAD(27682):[07:31:51.071668] Server constructor with thread=0x7f9b8c003fd0 multihdr=0x7f9b8c001150(sock=7)
        THREAD(27375):[07:31:51.071670] Listener thread accepting for TCP (sock=3)
        THREAD(27681):[07:31:51.071655] Server spawn settings=0x7f9b8c004450 multihdr=0x7f9b8c001150 sock=4
        THREAD(27683):[07:31:51.071721] Server spawn settings=0x7f9b8c001940 multihdr=0x7f9b8c001150 sock=10
        THREAD(27375):[07:31:51.071718] Thread_run_wrapper(0x7f9b8c001940 mode=1) thread counts tot/trfc=9/7
        THREAD(27683):[07:31:51.071748] Server constructor with thread=0x7f9b8c001940 multihdr=0x7f9b8c001150(sock=10)
        THREAD(27375):[07:31:51.071750] Copy thread settings (malloc) from/to=0x5594964fe930/0x7f9b8c001ec0 report/multi/bidir 0x7f9b8c001150/(nil)/(nil)
        THREAD(27375):[07:31:51.071753] Listener thread accepting for TCP (sock=3)
        THREAD(27682):[07:31:51.071756] Job report 0x7f9b8c001150 uses multireport 0x7f9b8c001150 and bidirreport is (nil)
        THREAD(27682):[07:31:51.071764] Init 5000 element packet ring=0x7f9b740018d0 producer=0x7f9b8c0042e8 consumer=0x559495cfc3a0
        THREAD(27682):[07:31:51.071770] Sum multiheader 0x7f9b8c001150 ref=0->1
        THREAD(27682):[07:31:51.071775] Init data report 0x7f9b740012e0 size 1392 using packetring=0x7f9b740018d0 cond=0x7f9b8c0042e8
        THREAD(27682):[07:31:51.071780] Init connection report 0x7f9b740012e0
        THREAD(27682):[07:31:51.071785] Update connection report 0x7f9b740012e0 winreq=0 actual=131072
        THREAD(27682):[07:31:51.071789] Jobq report 0x7f9b740012e0 (0x9) post
        THREAD(27681):[07:31:51.071729] Server constructor with thread=0x7f9b8c004450 multihdr=0x7f9b8c001150(sock=4)
        THREAD(27375):[07:31:51.071822] Thread_run_wrapper(0x7f9b8c001ec0 mode=1) thread counts tot/trfc=10/8
        THREAD(27684):[07:31:51.071825] Server spawn settings=0x7f9b8c001ec0 multihdr=0x7f9b8c001150 sock=12
        THREAD(27375):[07:31:51.071827] Copy thread settings (malloc) from/to=0x5594964fe930/0x7f9b8c002440 report/multi/bidir 0x7f9b8c001150/(nil)/(nil)
        THREAD(27684):[07:31:51.071844] Server constructor with thread=0x7f9b8c001ec0 multihdr=0x7f9b8c001150(sock=12)
        THREAD(27375):[07:31:51.071847] Free thread settings=0x7f9b8c002440
        THREAD(27683):[07:31:51.071825] Job report 0x7f9b8c001150 uses multireport 0x7f9b8c001150 and bidirreport is (nil)
        THREAD(27375):[07:31:51.071854] Listener destructor close sock=3
        THREAD(27683):[07:31:51.071856] Init 5000 element packet ring=0x7f9b700018d0 producer=0x7f9b8c001c58 consumer=0x559495cfc3a0
        THREAD(27683):[07:31:51.071860] Sum multiheader 0x7f9b8c001150 ref=1->2
        THREAD(27375):[07:31:51.071862] Free thread settings=0x5594964fe930
        THREAD(27683):[07:31:51.071864] Init data report 0x7f9b700012e0 size 1392 using packetring=0x7f9b700018d0 cond=0x7f9b8c001c58
        THREAD(27683):[07:31:51.071870] Init connection report 0x7f9b700012e0
        THREAD(27683):[07:31:51.071874] Update connection report 0x7f9b700012e0 winreq=0 actual=131072
        THREAD(27683):[07:31:51.071877] Jobq report 0x7f9b700012e0 (0x9) post
        THREAD(27681):[07:31:51.071936] Job report 0x7f9b8c001150 uses multireport 0x7f9b8c001150 and bidirreport is (nil)
        THREAD(27684):[07:31:51.071940] Job report 0x7f9b8c001150 uses multireport 0x7f9b8c001150 and bidirreport is (nil)
        THREAD(27681):[07:31:51.071946] Init 5000 element packet ring=0x7f9b6c0018d0 producer=0x7f9b8c004768 consumer=0x559495cfc3a0
        THREAD(27684):[07:31:51.071949] Init 5000 element packet ring=0x7f9b640018d0 producer=0x7f9b8c0021d8 consumer=0x559495cfc3a0
        THREAD(27681):[07:31:51.071949] Sum multiheader 0x7f9b8c001150 ref=2->3
        THREAD(27681):[07:31:51.071959] Init data report 0x7f9b6c0012e0 size 1392 using packetring=0x7f9b6c0018d0 cond=0x7f9b8c004768
        THREAD(27684):[07:31:51.071961] Sum multiheader 0x7f9b8c001150 ref=3->4
        THREAD(27681):[07:31:51.071963] Init connection report 0x7f9b6c0012e0
        THREAD(27684):[07:31:51.071969] Init data report 0x7f9b640012e0 size 1392 using packetring=0x7f9b640018d0 cond=0x7f9b8c0021d8
        THREAD(27681):[07:31:51.071973] Update connection report 0x7f9b6c0012e0 winreq=0 actual=131072
        THREAD(27684):[07:31:51.071977] Init connection report 0x7f9b640012e0
        THREAD(27681):[07:31:51.071980] Jobq report 0x7f9b6c0012e0 (0x9) post
        THREAD(27684):[07:31:51.071996] Update connection report 0x7f9b640012e0 winreq=0 actual=131072
        THREAD(27684):[07:31:51.072001] Jobq report 0x7f9b640012e0 (0x9) post
        [  5]  9.0-10.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  9.0-10.0 sec  11.0 GBytes  94.2 Gbits/sec
        THREAD(27373):[07:31:51.072523] Jobq *ROOT* 0x7f9b740012e0 (last=0x7f9b80021350)
        [  7] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45072
        [ 10] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45074
        [  4] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45076
        [ 12] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45078
        [  6]  9.0-10.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  8]  9.0-10.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  9]  9.0-10.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  5]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(27373):[07:31:51.072606] Jobq *FREE* 0x7f9b88021350 (1) ((nil))
        THREAD(27373):[07:31:51.072612] Signal producer to free report 0x7f9b88021350 and cond 0x7f9b88021020
        THREAD(27374):[07:31:51.072618] Traffic thread thinks reporter is done with 0x7f9b88021350
        [  6]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(27374):[07:31:51.072627] Client destructor sock=5 report=0x7f9b88021350 server-reverse=false bidir=false
        THREAD(27373):[07:31:51.072631] Jobq *FREE* 0x7f9b80021350 (1) (0x7f9b84021350)
        THREAD(27373):[07:31:51.072635] Signal producer to free report 0x7f9b80021350 and cond 0x7f9b80021020
        THREAD(27374):[07:31:51.072637] Sum multiheader 0x5594964fece0 ref=4->3
        [  9]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(27374):[07:31:51.072641] Free packet ring=0x7f9b88020f80 producer=0x5594964fe188 (consumer=0x559495cfc3a0)
        THREAD(27376):[07:31:51.072645] Traffic thread thinks reporter is done with 0x7f9b80021350
        THREAD(27373):[07:31:51.072646] Jobq *FREE* 0x7f9b78021370 (1) ((nil))
        THREAD(27376):[07:31:51.072659] Client destructor sock=6 report=0x7f9b80021350 server-reverse=false bidir=false
        THREAD(27373):[07:31:51.072662] Signal producer to free report 0x7f9b78021370 and cond 0x7f9b78021a00
        THREAD(27374):[07:31:51.072671] Free report hdr=0x7f9b88021350 reporter thread suspend count=2463 packetring=0x7f9b88020f80 histo=(nil) frame histo=(nil)
        THREAD(27378):[07:31:51.072652] Traffic thread thinks reporter is done with 0x7f9b78021370
        [  8]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(27378):[07:31:51.072684] Client destructor sock=9 report=0x7f9b78021370 server-reverse=false bidir=false
        THREAD(27376):[07:31:51.072673] Sum multiheader 0x5594964fece0 ref=3->2
        THREAD(27374):[07:31:51.072679] Free thread settings=0x5594964fde70
        THREAD(27376):[07:31:51.072696] Free packet ring=0x7f9b80020f80 producer=0x5594964ffd38 (consumer=0x559495cfc3a0)
        THREAD(27378):[07:31:51.072697] Sum multiheader 0x5594964fece0 ref=2->1
        THREAD(27373):[07:31:51.072697] Jobq *FREE* 0x7f9b84021350 (1) ((nil))
        THREAD(27378):[07:31:51.072707] Free packet ring=0x7f9b78021960 producer=0x559496501178 (consumer=0x559495cfc3a0)
        THREAD(27373):[07:31:51.072712] Signal producer to free report 0x7f9b84021350 and cond 0x7f9b84021020
        THREAD(27376):[07:31:51.072723] Free report hdr=0x7f9b80021350 reporter thread suspend count=2463 packetring=0x7f9b80020f80 histo=(nil) frame histo=(nil)
        THREAD(27376):[07:31:51.072729] Free thread settings=0x5594964ffa20
        THREAD(27377):[07:31:51.072730] Traffic thread thinks reporter is done with 0x7f9b84021350
        THREAD(27377):[07:31:51.072742] Client destructor sock=8 report=0x7f9b84021350 server-reverse=false bidir=false
        THREAD(27378):[07:31:51.072742] Free report hdr=0x7f9b78021370 reporter thread suspend count=2463 packetring=0x7f9b78021960 histo=(nil) frame histo=(nil)
        THREAD(27377):[07:31:51.072753] Sum multiheader 0x5594964fece0 ref=1->0
        THREAD(27378):[07:31:51.072756] Free thread settings=0x559496500e60
        [SUM]  0.0-10.0 sec   110 GBytes  94.1 Gbits/sec
        THREAD(27377):[07:31:51.072766] Free sum multiheader 0x5594964fece0 per last reference
        THREAD(27377):[07:31:51.072772] Free packet ring=0x7f9b84020f80 producer=0x559496500168 (consumer=0x559495cfc3a0)
        THREAD(27377):[07:31:51.072825] Free report hdr=0x7f9b84021350 reporter thread suspend count=2463 packetring=0x7f9b84020f80 histo=(nil) frame histo=(nil)
        THREAD(27377):[07:31:51.072834] Free thread settings=0x5594964ffe50
        [ 12]  0.0- 1.0 sec  1.69 GBytes  14.5 Gbits/sec
        [  7]  0.0- 1.0 sec  1.65 GBytes  14.1 Gbits/sec
        [ 10]  0.0- 1.0 sec  1.60 GBytes  13.8 Gbits/sec
        [  4]  0.0- 1.0 sec  1.56 GBytes  13.4 Gbits/sec
        [SUM]  0.0- 1.0 sec  6.50 GBytes  55.8 Gbits/sec
        [ 12]  1.0- 2.0 sec  1.68 GBytes  14.5 Gbits/sec
        [  7]  1.0- 2.0 sec  1.64 GBytes  14.1 Gbits/sec
        [ 10]  1.0- 2.0 sec  1.59 GBytes  13.7 Gbits/sec
        [  4]  1.0- 2.0 sec  1.55 GBytes  13.3 Gbits/sec
        [SUM]  1.0- 2.0 sec  6.47 GBytes  55.6 Gbits/sec
        [ 12]  2.0- 3.0 sec  1.69 GBytes  14.5 Gbits/sec
        [  7]  2.0- 3.0 sec  1.64 GBytes  14.1 Gbits/sec
        [ 10]  2.0- 3.0 sec  1.60 GBytes  13.7 Gbits/sec
        [  4]  2.0- 3.0 sec  1.55 GBytes  13.4 Gbits/sec
        [SUM]  2.0- 3.0 sec  6.48 GBytes  55.7 Gbits/sec
        [ 12]  3.0- 4.0 sec  1.69 GBytes  14.5 Gbits/sec
        [  7]  3.0- 4.0 sec  1.63 GBytes  14.0 Gbits/sec
        [ 10]  3.0- 4.0 sec  1.60 GBytes  13.7 Gbits/sec
        [  4]  3.0- 4.0 sec  1.55 GBytes  13.3 Gbits/sec
        [SUM]  3.0- 4.0 sec  6.46 GBytes  55.5 Gbits/sec
        [ 12]  4.0- 5.0 sec  1.64 GBytes  14.1 Gbits/sec
        [  7]  4.0- 5.0 sec  1.59 GBytes  13.7 Gbits/sec
        [ 10]  4.0- 5.0 sec  1.55 GBytes  13.3 Gbits/sec
        [  4]  4.0- 5.0 sec  1.50 GBytes  12.9 Gbits/sec
        [SUM]  4.0- 5.0 sec  6.29 GBytes  54.1 Gbits/sec
        [ 12]  5.0- 6.0 sec  1.68 GBytes  14.5 Gbits/sec
        [  7]  5.0- 6.0 sec  1.63 GBytes  14.0 Gbits/sec
        [ 10]  5.0- 6.0 sec  1.58 GBytes  13.6 Gbits/sec
        [  4]  5.0- 6.0 sec  1.54 GBytes  13.3 Gbits/sec
        [SUM]  5.0- 6.0 sec  6.44 GBytes  55.3 Gbits/sec
        [ 12]  6.0- 7.0 sec  1.68 GBytes  14.4 Gbits/sec
        [  7]  6.0- 7.0 sec  1.63 GBytes  14.0 Gbits/sec
        [ 10]  6.0- 7.0 sec  1.58 GBytes  13.6 Gbits/sec
        [  4]  6.0- 7.0 sec  1.54 GBytes  13.3 Gbits/sec
        [SUM]  6.0- 7.0 sec  6.43 GBytes  55.2 Gbits/sec
        [ 12]  7.0- 8.0 sec  1.68 GBytes  14.4 Gbits/sec
        [  7]  7.0- 8.0 sec  1.63 GBytes  14.0 Gbits/sec
        [ 10]  7.0- 8.0 sec  1.58 GBytes  13.6 Gbits/sec
        [  4]  7.0- 8.0 sec  1.54 GBytes  13.3 Gbits/sec
        [SUM]  7.0- 8.0 sec  6.43 GBytes  55.3 Gbits/sec
        [ 12]  8.0- 9.0 sec  1.67 GBytes  14.3 Gbits/sec
        [  7]  8.0- 9.0 sec  1.62 GBytes  13.9 Gbits/sec
        [ 10]  8.0- 9.0 sec  1.57 GBytes  13.5 Gbits/sec
        [  4]  8.0- 9.0 sec  1.53 GBytes  13.2 Gbits/sec
        [SUM]  8.0- 9.0 sec  6.39 GBytes  54.9 Gbits/sec
        [ 12]  9.0-10.0 sec  1.66 GBytes  14.3 Gbits/sec
        [  7]  9.0-10.0 sec  1.64 GBytes  14.0 Gbits/sec
        [ 10]  9.0-10.0 sec  1.56 GBytes  13.4 Gbits/sec
        [  4]  9.0-10.0 sec  1.53 GBytes  13.1 Gbits/sec
        [SUM]  9.0-10.0 sec  6.39 GBytes  54.8 Gbits/sec
        THREAD(27683):[07:32:01.075331] Reporting last packet for 0x7f9b700012e0  qdepth=3928
        THREAD(27683):[07:32:01.075349] Traffic thread awaiting reporter to be done with 0x7f9b700012e0 and cond 0x7f9b8c001c58
        THREAD(27682):[07:32:01.075573] Reporting last packet for 0x7f9b740012e0  qdepth=4908
        THREAD(27682):[07:32:01.075583] Traffic thread awaiting reporter to be done with 0x7f9b740012e0 and cond 0x7f9b8c0042e8
        THREAD(27684):[07:32:01.075775] Reporting last packet for 0x7f9b640012e0  qdepth=4978
        THREAD(27684):[07:32:01.075785] Traffic thread awaiting reporter to be done with 0x7f9b640012e0 and cond 0x7f9b8c0021d8
        [ 12] 10.0-10.0 sec  7.43 MBytes  15.7 Gbits/sec
        [ 12]  0.0-10.0 sec  16.8 GBytes  14.4 Gbits/sec
        THREAD(27373):[07:32:01.077568] Jobq *FREE* 0x7f9b640012e0 (1) ((nil))
        THREAD(27373):[07:32:01.077575] Signal producer to free report 0x7f9b640012e0 and cond 0x7f9b64001970
        THREAD(27684):[07:32:01.077581] Traffic thread thinks reporter is done with 0x7f9b640012e0
        THREAD(27684):[07:32:01.077586] Server destructor sock=12 bidir=false
        THREAD(27684):[07:32:01.077589] Socket close sock=12 (server destructor)
        THREAD(27684):[07:32:01.077599] Sum multiheader 0x7f9b8c001150 ref=4->3
        THREAD(27684):[07:32:01.077603] Free packet ring=0x7f9b640018d0 producer=0x7f9b8c0021d8 (consumer=0x559495cfc3a0)
        WARN: Reporter thread may be too slow, await counter=2238, consider increasing NUM_REPORT_STRUCTS
        THREAD(27684):[07:32:01.077640] Free report hdr=0x7f9b640012e0 reporter thread suspend count=4721 packetring=0x7f9b640018d0 histo=(nil) frame histo=(nil)
        THREAD(27684):[07:32:01.077648] Free thread settings=0x7f9b8c001ec0
        [  7] 10.0-10.0 sec  7.28 MBytes  15.5 Gbits/sec
        [  7]  0.0-10.0 sec  16.3 GBytes  14.0 Gbits/sec
        THREAD(27373):[07:32:01.077662] Jobq *FREE* 0x7f9b740012e0 (1) (0x7f9b700012e0)
        THREAD(27373):[07:32:01.077666] Signal producer to free report 0x7f9b740012e0 and cond 0x7f9b74001970
        THREAD(27682):[07:32:01.077673] Traffic thread thinks reporter is done with 0x7f9b740012e0
        THREAD(27682):[07:32:01.077680] Server destructor sock=7 bidir=false
        THREAD(27682):[07:32:01.077684] Socket close sock=7 (server destructor)
        THREAD(27682):[07:32:01.077694] Sum multiheader 0x7f9b8c001150 ref=3->2
        THREAD(27682):[07:32:01.077699] Free packet ring=0x7f9b740018d0 producer=0x7f9b8c0042e8 (consumer=0x559495cfc3a0)
        WARN: Reporter thread may be too slow, await counter=2243, consider increasing NUM_REPORT_STRUCTS
        THREAD(27682):[07:32:01.077736] Free report hdr=0x7f9b740012e0 reporter thread suspend count=4721 packetring=0x7f9b740018d0 histo=(nil) frame histo=(nil)
        THREAD(27682):[07:32:01.077744] Free thread settings=0x7f9b8c003fd0
        [ 10] 10.0-10.0 sec  7.18 MBytes  16.6 Gbits/sec
        [ 10]  0.0-10.0 sec  15.8 GBytes  13.6 Gbits/sec
        THREAD(27373):[07:32:01.077822] Jobq *FREE* 0x7f9b700012e0 (1) (0x7f9b6c0012e0)
        THREAD(27373):[07:32:01.077826] Signal producer to free report 0x7f9b700012e0 and cond 0x7f9b70001970
        THREAD(27683):[07:32:01.077833] Traffic thread thinks reporter is done with 0x7f9b700012e0
        THREAD(27683):[07:32:01.077842] Server destructor sock=10 bidir=false
        THREAD(27683):[07:32:01.077846] Socket close sock=10 (server destructor)
        THREAD(27683):[07:32:01.077855] Sum multiheader 0x7f9b8c001150 ref=2->1
        THREAD(27683):[07:32:01.077858] Free packet ring=0x7f9b700018d0 producer=0x7f9b8c001c58 (consumer=0x559495cfc3a0)
        WARN: Reporter thread may be too slow, await counter=2242, consider increasing NUM_REPORT_STRUCTS
        THREAD(27683):[07:32:01.077892] Free report hdr=0x7f9b700012e0 reporter thread suspend count=4721 packetring=0x7f9b700018d0 histo=(nil) frame histo=(nil)
        THREAD(27683):[07:32:01.077898] Free thread settings=0x7f9b8c001940
        THREAD(27681):[07:32:01.077905] Reporting last packet for 0x7f9b6c0012e0  qdepth=171
        THREAD(27681):[07:32:01.077916] Traffic thread awaiting reporter to be done with 0x7f9b6c0012e0 and cond 0x7f9b8c004768
        [  4] 10.0-10.0 sec  8.44 MBytes  11.2 Gbits/sec
        [  4]  0.0-10.0 sec  15.4 GBytes  13.2 Gbits/sec
        THREAD(27373):[07:32:01.081898] Jobq *FREE* 0x7f9b6c0012e0 (1) ((nil))
        THREAD(27373):[07:32:01.081903] Signal producer to free report 0x7f9b6c0012e0 and cond 0x7f9b6c001970
        THREAD(27681):[07:32:01.081910] Traffic thread thinks reporter is done with 0x7f9b6c0012e0
        THREAD(27681):[07:32:01.081915] Server destructor sock=4 bidir=false
        THREAD(27681):[07:32:01.081918] Socket close sock=4 (server destructor)
        THREAD(27681):[07:32:01.081926] Sum multiheader 0x7f9b8c001150 ref=1->0
        [SUM]  0.0-10.0 sec  64.3 GBytes  55.2 Gbits/sec
        THREAD(27681):[07:32:01.081933] Free sum multiheader 0x7f9b8c001150 per last reference
        THREAD(27681):[07:32:01.081936] Free packet ring=0x7f9b6c0018d0 producer=0x7f9b8c004768 (consumer=0x559495cfc3a0)
        WARN: Reporter thread may be too slow, await counter=2242, consider increasing NUM_REPORT_STRUCTS
        THREAD(27681):[07:32:01.081969] Free report hdr=0x7f9b6c0012e0 reporter thread suspend count=4722 packetring=0x7f9b6c0018d0 histo=(nil) frame histo=(nil)
        THREAD(27681):[07:32:01.081979] Free thread settings=0x7f9b8c004450
        THREAD(27373):[07:32:02.082031] Jobq *WAIT* exit  (nil) 
        THREAD(27373):[07:32:02.082082] Reporter thread finished
        THREAD(27373):[07:32:02.082129] Free thread settings=0x5594965011f0
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ ./iperf -c 192.168.1.111 -i 1 -t 4 --NUM_REPORT_STRUCTS 50000 -r -P 4
        THREAD(28328):[07:32:13.081930] Init multiheader sum report 0x5587ea37fce0 id=-1
        THREAD(28328):[07:32:13.082027] Copy thread settings (malloc) from/to=0x5587ea37ee70/0x5587ea380a20 report/multi/bidir (nil)/0x5587ea37fce0/(nil)
        THREAD(28328):[07:32:13.082050] Copy thread settings (malloc) from/to=0x5587ea37ee70/0x5587ea380e50 report/multi/bidir (nil)/0x5587ea37fce0/(nil)
        THREAD(28328):[07:32:13.082070] Copy thread settings (malloc) from/to=0x5587ea37ee70/0x5587ea381e60 report/multi/bidir (nil)/0x5587ea37fce0/(nil)
        THREAD(28328):[07:32:13.082105] Copy thread settings (malloc) from/to=0x5587ea37ee70/0x5587ea3821f0 report/multi/bidir (nil)/0x5587ea37fce0/(nil)
        THREAD(28328):[07:32:13.082201] Thread_run_wrapper(0x5587ea3821f0 mode=4) thread counts tot/trfc=1/0
        THREAD(28329):[07:32:13.082261] Reporter thread started
        THREAD(28330):[07:32:13.082368] Client thread started in constructor (4003200/0)
        THREAD(28328):[07:32:13.082274] Thread_run_wrapper(0x5587ea37ee70 mode=2) thread counts tot/trfc=2/1
        THREAD(28328):[07:32:13.082548] Thread_run_wrapper(0x5587ea37f930 mode=7) thread counts tot/trfc=3/1
        THREAD(28328):[07:32:13.082639] Thread_run_wrapper(0x5587ea380a20 mode=2) thread counts tot/trfc=4/2
        THREAD(28331):[07:32:13.082663] Init settings report 0x7f138c001150
        THREAD(28328):[07:32:13.082708] Thread_run_wrapper(0x5587ea380e50 mode=2) thread counts tot/trfc=5/3
        THREAD(28332):[07:32:13.082729] Client thread started in constructor (4001200/0)
        THREAD(28331):[07:32:13.082738] Update connection report 0x7f138c001150 winreq=0 actual=131072
        THREAD(28333):[07:32:13.082797] Client thread started in constructor (4001200/0)
        THREAD(28334):[07:32:13.082875] Client thread started in constructor (4001200/0)
        THREAD(28331):[07:32:13.082816] Jobq report 0x7f138c001150 (0x4) post
        THREAD(28328):[07:32:13.082813] Thread_run_wrapper(0x5587ea381e60 mode=2) thread counts tot/trfc=6/4
        THREAD(28331):[07:32:13.083075] Copy thread settings (malloc) from/to=0x5587ea37f930/0x7f138c004450 report/multi/bidir 0x7f138c001150/(nil)/(nil)
        THREAD(28329):[07:32:13.083099] Reporter await done
        THREAD(28329):[07:32:13.083155] Jobq *ROOT* 0x7f138c001150 (last=(nil))
        ------------------------------------------------------------
        Server listening on TCP port 5001
        TCP window size:  128 KByte (default)
        ------------------------------------------------------------
        THREAD(28329):[07:32:13.083245] Jobq *FREE* 0x7f138c001150 (0) ((nil))
        THREAD(28329):[07:32:13.083264] Free report 0x7f138c001150 (flags = 0)
        THREAD(28330):[07:32:13.083978] Job report (nil) uses multireport 0x5587ea37fce0 and bidirreport is (nil)
        THREAD(28330):[07:32:13.084050] Init 50000 element packet ring=0x7f1390021350 producer=0x5587ea37f188 consumer=0x5587ea1de3a0
        [  4] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28330):[07:32:13.084083] Sum multiheader 0x5587ea37fce0 ref=0->1
        THREAD(28330):[07:32:13.084112] Init data report 0x7f1390020c60 size 1392 using packetring=0x7f1390021350 cond=0x5587ea37f188
        THREAD(28330):[07:32:13.084140] Init connection report 0x7f1390020c60
        THREAD(28330):[07:32:13.084156] Update connection report 0x7f1390020c60 winreq=0 actual=87040
        THREAD(28330):[07:32:13.084192] Init settings report 0x7f1390023020
        THREAD(28330):[07:32:13.084234] Update connection report 0x7f1390023020 winreq=0 actual=87040
        THREAD(28330):[07:32:13.084258] Jobq report 0x7f1390023020 (0x4) post
        THREAD(28330):[07:32:13.084291] Jobq report 0x7f1390020c60 (0x9) post
        THREAD(28330):[07:32:13.084319] Client spawn thread normal (sock=4)
        THREAD(28329):[07:32:13.084331] Jobq *WAIT* exit  0x7f1390023020 
        THREAD(28330):[07:32:13.084335] Client start sync enterred
        THREAD(28329):[07:32:13.084395] Jobq *ROOT* 0x7f1390023020 (last=(nil))
        ------------------------------------------------------------
        Client connecting to 192.168.1.111, TCP port 5001
        THREAD(28330):[07:32:13.084424] Barrier WAIT on condition 0x5587ea37fce8 count=3
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(28329):[07:32:13.084549] Jobq *FREE* 0x7f1390023020 (0) (0x7f1390020c60)
        THREAD(28329):[07:32:13.084573] Free report 0x7f1390023020 (flags = 0)
        [  4] local 192.168.1.110 port 41800 connected with 192.168.1.111 port 5001 (ct=0.23 ms)
        [ ID] Interval       Transfer     Bandwidth
        [  4]  0.0- 0.0 sec  0.00 Bytes  -nan bits/sec
        [  4]  0.0- 1.0 sec  0.00 Bytes  0.00 bits/sec
        [  4]  1.0- 2.0 sec  0.00 Bytes  0.00 bits/sec
        THREAD(28333):[07:32:13.084686] Job report (nil) uses multireport 0x5587ea37fce0 and bidirreport is (nil)
        THREAD(28333):[07:32:13.084755] Init 50000 element packet ring=0x7f1388020f80 producer=0x5587ea381168 consumer=0x5587ea1de3a0
        [  6] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28332):[07:32:13.084736] Job report (nil) uses multireport 0x5587ea37fce0 and bidirreport is (nil)
        THREAD(28333):[07:32:13.084799] Sum multiheader 0x5587ea37fce0 ref=1->2
        THREAD(28332):[07:32:13.084847] Init 50000 element packet ring=0x7f1384020f80 producer=0x5587ea380d38 consumer=0x5587ea1de3a0
        [  5] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28334):[07:32:13.084739] Job report (nil) uses multireport 0x5587ea37fce0 and bidirreport is (nil)
        THREAD(28332):[07:32:13.084906] Sum multiheader 0x5587ea37fce0 ref=2->3
        THREAD(28332):[07:32:13.084966] Init data report 0x7f1384021350 size 1392 using packetring=0x7f1384020f80 cond=0x5587ea380d38
        THREAD(28333):[07:32:13.084856] Init data report 0x7f1388021350 size 1392 using packetring=0x7f1388020f80 cond=0x5587ea381168
        THREAD(28334):[07:32:13.084970] Init 50000 element packet ring=0x7f137c021960 producer=0x5587ea382178 consumer=0x5587ea1de3a0
        THREAD(28333):[07:32:13.085045] Init connection report 0x7f1388021350
        [  7] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28332):[07:32:13.084988] Init connection report 0x7f1384021350
        THREAD(28334):[07:32:13.085117] Sum multiheader 0x5587ea37fce0 ref=3->4
        THREAD(28332):[07:32:13.085139] Update connection report 0x7f1384021350 winreq=0 actual=87040
        THREAD(28334):[07:32:13.085153] Init data report 0x7f137c021370 size 1392 using packetring=0x7f137c021960 cond=0x5587ea382178
        THREAD(28333):[07:32:13.085094] Update connection report 0x7f1388021350 winreq=0 actual=87040
        THREAD(28332):[07:32:13.085163] Jobq report 0x7f1384021350 (0x9) post
        THREAD(28334):[07:32:13.085188] Init connection report 0x7f137c021370
        THREAD(28332):[07:32:13.085241] Client spawn thread normal (sock=5)
        THREAD(28334):[07:32:13.085272] Update connection report 0x7f137c021370 winreq=0 actual=87040
        THREAD(28333):[07:32:13.085222] Jobq report 0x7f1388021350 (0x9) post
        THREAD(28332):[07:32:13.085290] Client start sync enterred
        THREAD(28333):[07:32:13.085335] Client spawn thread normal (sock=6)
        THREAD(28332):[07:32:13.085351] Barrier WAIT on condition 0x5587ea37fce8 count=2
        THREAD(28333):[07:32:13.085368] Client start sync enterred
        THREAD(28334):[07:32:13.085312] Jobq report 0x7f137c021370 (0x9) post
        THREAD(28333):[07:32:13.085384] Barrier WAIT on condition 0x5587ea37fce8 count=1
        THREAD(28334):[07:32:13.085406] Client spawn thread normal (sock=7)
        THREAD(28334):[07:32:13.085430] Client start sync enterred
        THREAD(28334):[07:32:13.085462] Barrier BROADCAST on condition 0x5587ea37fce8
        THREAD(28334):[07:32:13.085484] Barrier EXIT on condition 0x5587ea37fce8
        THREAD(28332):[07:32:13.085497] Barrier EXIT on condition 0x5587ea37fce8
        THREAD(28330):[07:32:13.085510] Barrier EXIT on condition 0x5587ea37fce8
        THREAD(28332):[07:32:13.085527] Client start sync exited
        THREAD(28330):[07:32:13.085543] Client start sync exited
        THREAD(28333):[07:32:13.085516] Barrier EXIT on condition 0x5587ea37fce8
        THREAD(28334):[07:32:13.085500] Client start sync exited
        THREAD(28333):[07:32:13.085585] Client start sync exited
        THREAD(28329):[07:32:13.088773] Jobq *ROOT* 0x7f1384021350 (last=0x7f1390020c60)
        [  5] local 192.168.1.110 port 41804 connected with 192.168.1.111 port 5001 (ct=0.17 ms)
        [  6] local 192.168.1.110 port 41802 connected with 192.168.1.111 port 5001 (ct=0.21 ms)
        [  7] local 192.168.1.110 port 41806 connected with 192.168.1.111 port 5001 (ct=0.17 ms)
        [  4]  2.0- 1.0 sec  2.61 GBytes  -22420652032.00 bits/sec
        [SUM]  0.0- 1.0 sec  2.61 GBytes  22.4 Gbits/sec
        [  5]  0.0- 1.0 sec  2.77 GBytes  23.8 Gbits/sec
        [  6]  0.0- 1.0 sec  2.75 GBytes  23.6 Gbits/sec
        [  7]  0.0- 1.0 sec  2.77 GBytes  23.8 Gbits/sec
        [  4]  1.0- 2.0 sec  2.71 GBytes  23.3 Gbits/sec
        [SUM]  1.0- 2.0 sec  11.0 GBytes  94.5 Gbits/sec
        [  5]  1.0- 2.0 sec  2.75 GBytes  23.6 Gbits/sec
        [  6]  1.0- 2.0 sec  2.75 GBytes  23.6 Gbits/sec
        [  7]  1.0- 2.0 sec  2.75 GBytes  23.6 Gbits/sec
        [  4]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  2.0- 3.0 sec  11.0 GBytes  94.4 Gbits/sec
        [  5]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  6]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  7]  2.0- 3.0 sec  2.74 GBytes  23.5 Gbits/sec
        THREAD(28330):[07:32:17.085617] Shutdown client's writes on tcp socket 4
        THREAD(28330):[07:32:17.085637] Reporting last packet for 0x7f1390020c60  qdepth=81
        THREAD(28330):[07:32:17.085640] Traffic thread awaiting reporter to be done with 0x7f1390020c60 and cond 0x5587ea37f188
        THREAD(28333):[07:32:17.085708] Shutdown client's writes on tcp socket 6
        THREAD(28333):[07:32:17.085718] Reporting last packet for 0x7f1388021350  qdepth=73
        THREAD(28334):[07:32:17.085720] Shutdown client's writes on tcp socket 7
        THREAD(28333):[07:32:17.085722] Traffic thread awaiting reporter to be done with 0x7f1388021350 and cond 0x5587ea381168
        THREAD(28334):[07:32:17.085733] Reporting last packet for 0x7f137c021370  qdepth=70
        THREAD(28334):[07:32:17.085741] Traffic thread awaiting reporter to be done with 0x7f137c021370 and cond 0x5587ea382178
        THREAD(28332):[07:32:17.086067] Shutdown client's writes on tcp socket 5
        THREAD(28332):[07:32:17.086077] Reporting last packet for 0x7f1384021350  qdepth=73
        THREAD(28332):[07:32:17.086081] Traffic thread awaiting reporter to be done with 0x7f1384021350 and cond 0x5587ea380d38
        [  4]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [SUM]  3.0- 4.0 sec  11.0 GBytes  94.2 Gbits/sec
        [  5]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  6]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  7]  3.0- 4.0 sec  2.74 GBytes  23.5 Gbits/sec
        [  4]  0.0- 4.0 sec  10.8 GBytes  23.2 Gbits/sec
        THREAD(28329):[07:32:17.086524] Jobq *FREE* 0x7f1390020c60 (1) ((nil))
        THREAD(28329):[07:32:17.086531] Signal producer to free report 0x7f1390020c60 and cond 0x7f13900213f0
        [  5]  0.0- 4.0 sec  11.0 GBytes  23.6 Gbits/sec
        THREAD(28329):[07:32:17.086539] Jobq *FREE* 0x7f1384021350 (1) (0x7f1388021350)
        THREAD(28329):[07:32:17.086542] Signal producer to free report 0x7f1384021350 and cond 0x7f1384021020
        [  7]  0.0- 4.0 sec  11.0 GBytes  23.6 Gbits/sec
        THREAD(28332):[07:32:17.086547] Traffic thread thinks reporter is done with 0x7f1384021350
        THREAD(28329):[07:32:17.086549] Jobq *FREE* 0x7f137c021370 (1) ((nil))
        THREAD(28330):[07:32:17.086553] Traffic thread thinks reporter is done with 0x7f1390020c60
        THREAD(28332):[07:32:17.086553] Client destructor sock=5 report=0x7f1384021350 server-reverse=false bidir=false
        THREAD(28330):[07:32:17.086566] Client destructor sock=4 report=0x7f1390020c60 server-reverse=false bidir=false
        THREAD(28332):[07:32:17.086576] Sum multiheader 0x5587ea37fce0 ref=4->3
        THREAD(28334):[07:32:17.086576] Traffic thread thinks reporter is done with 0x7f137c021370
        THREAD(28330):[07:32:17.086586] Sum multiheader 0x5587ea37fce0 ref=3->2
        THREAD(28332):[07:32:17.086582] Free packet ring=0x7f1384020f80 producer=0x5587ea380d38 (consumer=0x5587ea1de3a0)
        THREAD(28329):[07:32:17.086557] Signal producer to free report 0x7f137c021370 and cond 0x7f137c021a00
        [  6]  0.0- 4.0 sec  11.0 GBytes  23.6 Gbits/sec
        THREAD(28334):[07:32:17.086592] Client destructor sock=7 report=0x7f137c021370 server-reverse=false bidir=false
        THREAD(28334):[07:32:17.086637] Sum multiheader 0x5587ea37fce0 ref=2->1
        THREAD(28334):[07:32:17.086644] Free packet ring=0x7f137c021960 producer=0x5587ea382178 (consumer=0x5587ea1de3a0)
        THREAD(28329):[07:32:17.086622] Jobq *FREE* 0x7f1388021350 (1) ((nil))
        THREAD(28329):[07:32:17.086684] Signal producer to free report 0x7f1388021350 and cond 0x7f1388021020
        THREAD(28333):[07:32:17.086694] Traffic thread thinks reporter is done with 0x7f1388021350
        THREAD(28333):[07:32:17.086699] Client destructor sock=6 report=0x7f1388021350 server-reverse=false bidir=false
        THREAD(28333):[07:32:17.086708] Sum multiheader 0x5587ea37fce0 ref=1->0
        THREAD(28330):[07:32:17.086596] Free packet ring=0x7f1390021350 producer=0x5587ea37f188 (consumer=0x5587ea1de3a0)
        [SUM]  0.0- 4.0 sec  43.8 GBytes  94.0 Gbits/sec
        THREAD(28333):[07:32:17.086723] Free sum multiheader 0x5587ea37fce0 per last reference
        THREAD(28333):[07:32:17.086727] Free packet ring=0x7f1388020f80 producer=0x5587ea381168 (consumer=0x5587ea1de3a0)
        THREAD(28332):[07:32:17.086755] Free report hdr=0x7f1384021350 reporter thread suspend count=979 packetring=0x7f1384020f80 histo=(nil) frame histo=(nil)
        THREAD(28332):[07:32:17.086766] Free thread settings=0x5587ea380a20
        THREAD(28334):[07:32:17.086933] Free report hdr=0x7f137c021370 reporter thread suspend count=979 packetring=0x7f137c021960 histo=(nil) frame histo=(nil)
        THREAD(28334):[07:32:17.086944] Free thread settings=0x5587ea381e60
        THREAD(28331):[07:32:17.087046] Listener thread accepting for TCP (sock=3)
        THREAD(28331):[07:32:17.087063] Init multiheader sum report 0x7f138c001150 id=-2
        THREAD(28330):[07:32:17.087138] Free report hdr=0x7f1390020c60 reporter thread suspend count=979 packetring=0x7f1390021350 histo=(nil) frame histo=(nil)
        THREAD(28330):[07:32:17.087149] Free thread settings=0x5587ea37ee70
        THREAD(28333):[07:32:17.087294] Free report hdr=0x7f1388021350 reporter thread suspend count=979 packetring=0x7f1388020f80 histo=(nil) frame histo=(nil)
        THREAD(28333):[07:32:17.087303] Free thread settings=0x5587ea380e50
        THREAD(28331):[07:32:17.087359] Thread_run_wrapper(0x7f138c004450 mode=1) thread counts tot/trfc=3/1
        THREAD(28452):[07:32:17.087362] Server spawn settings=0x7f138c004450 multihdr=0x7f138c001150 sock=4
        THREAD(28331):[07:32:17.087378] Copy thread settings (malloc) from/to=0x5587ea37f930/0x7f138c003fd0 report/multi/bidir 0x7f138c001150/(nil)/(nil)
        THREAD(28452):[07:32:17.087383] Server constructor with thread=0x7f138c004450 multihdr=0x7f138c001150(sock=4)
        THREAD(28331):[07:32:17.087389] Listener thread accepting for TCP (sock=3)
        THREAD(28331):[07:32:17.087409] Thread_run_wrapper(0x7f138c003fd0 mode=1) thread counts tot/trfc=4/2
        THREAD(28331):[07:32:17.087414] Copy thread settings (malloc) from/to=0x5587ea37f930/0x7f138c001810 report/multi/bidir 0x7f138c001150/(nil)/(nil)
        THREAD(28331):[07:32:17.087418] Listener thread accepting for TCP (sock=3)
        THREAD(28453):[07:32:17.087419] Server spawn settings=0x7f138c003fd0 multihdr=0x7f138c001150 sock=6
        THREAD(28453):[07:32:17.087448] Server constructor with thread=0x7f138c003fd0 multihdr=0x7f138c001150(sock=6)
        THREAD(28331):[07:32:17.087432] Thread_run_wrapper(0x7f138c001810 mode=1) thread counts tot/trfc=5/3
        THREAD(28454):[07:32:17.087449] Server spawn settings=0x7f138c001810 multihdr=0x7f138c001150 sock=7
        THREAD(28331):[07:32:17.087465] Copy thread settings (malloc) from/to=0x5587ea37f930/0x7f138c001c60 report/multi/bidir 0x7f138c001150/(nil)/(nil)
        THREAD(28454):[07:32:17.087471] Server constructor with thread=0x7f138c001810 multihdr=0x7f138c001150(sock=7)
        THREAD(28331):[07:32:17.087475] Listener thread accepting for TCP (sock=3)
        THREAD(28331):[07:32:17.087487] Thread_run_wrapper(0x7f138c001c60 mode=1) thread counts tot/trfc=6/4
        THREAD(28455):[07:32:17.087490] Server spawn settings=0x7f138c001c60 multihdr=0x7f138c001150 sock=10
        THREAD(28455):[07:32:17.087506] Server constructor with thread=0x7f138c001c60 multihdr=0x7f138c001150(sock=10)
        THREAD(28331):[07:32:17.087491] Copy thread settings (malloc) from/to=0x5587ea37f930/0x7f138c0020b0 report/multi/bidir 0x7f138c001150/(nil)/(nil)
        THREAD(28452):[07:32:17.087512] Job report 0x7f138c001150 uses multireport 0x7f138c001150 and bidirreport is (nil)
        THREAD(28331):[07:32:17.087514] Free thread settings=0x7f138c0020b0
        THREAD(28331):[07:32:17.087522] Listener destructor close sock=3
        THREAD(28452):[07:32:17.087525] Init 50000 element packet ring=0x7f13880017f0 producer=0x7f138c004768 consumer=0x5587ea1de3a0
        [  4] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28331):[07:32:17.087529] Free thread settings=0x5587ea37f930
        THREAD(28452):[07:32:17.087533] Sum multiheader 0x7f138c001150 ref=0->1
        THREAD(28452):[07:32:17.087541] Init data report 0x7f1388001200 size 1392 using packetring=0x7f13880017f0 cond=0x7f138c004768
        THREAD(28452):[07:32:17.087545] Init connection report 0x7f1388001200
        THREAD(28452):[07:32:17.087548] Update connection report 0x7f1388001200 winreq=0 actual=131072
        THREAD(28452):[07:32:17.087552] Jobq report 0x7f1388001200 (0x9) post
        THREAD(28329):[07:32:17.087559] Jobq *WAIT* exit  0x7f1388001200 
        THREAD(28329):[07:32:17.087570] Jobq *ROOT* 0x7f1388001200 (last=(nil))
        [  4] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45082
        THREAD(28453):[07:32:17.087605] Job report 0x7f138c001150 uses multireport 0x7f138c001150 and bidirreport is (nil)
        THREAD(28454):[07:32:17.087611] Job report 0x7f138c001150 uses multireport 0x7f138c001150 and bidirreport is (nil)
        THREAD(28455):[07:32:17.087613] Job report 0x7f138c001150 uses multireport 0x7f138c001150 and bidirreport is (nil)
        THREAD(28453):[07:32:17.087618] Init 50000 element packet ring=0x7f1390022cc0 producer=0x7f138c0042e8 consumer=0x5587ea1de3a0
        [  6] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28455):[07:32:17.087629] Init 50000 element packet ring=0x7f13840017f0 producer=0x7f138c001f78 consumer=0x5587ea1de3a0
        [ 10] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28454):[07:32:17.087625] Init 50000 element packet ring=0x7f137c022bd0 producer=0x7f138c001b28 consumer=0x5587ea1de3a0
        [  7] NUM_REPORT_STRUCTS override from 5000 to 50000
        THREAD(28453):[07:32:17.087631] Sum multiheader 0x7f138c001150 ref=1->2
        THREAD(28453):[07:32:17.087650] Init data report 0x7f13900226d0 size 1392 using packetring=0x7f1390022cc0 cond=0x7f138c0042e8
        THREAD(28455):[07:32:17.087651] Sum multiheader 0x7f138c001150 ref=2->3
        THREAD(28453):[07:32:17.087655] Init connection report 0x7f13900226d0
        THREAD(28455):[07:32:17.087659] Init data report 0x7f1384001200 size 1392 using packetring=0x7f13840017f0 cond=0x7f138c001f78
        THREAD(28453):[07:32:17.087661] Update connection report 0x7f13900226d0 winreq=0 actual=131072
        THREAD(28455):[07:32:17.087664] Init connection report 0x7f1384001200
        THREAD(28453):[07:32:17.087668] Jobq report 0x7f13900226d0 (0x9) post
        THREAD(28455):[07:32:17.087672] Update connection report 0x7f1384001200 winreq=0 actual=131072
        THREAD(28455):[07:32:17.087676] Jobq report 0x7f1384001200 (0x9) post
        THREAD(28454):[07:32:17.087694] Sum multiheader 0x7f138c001150 ref=3->4
        THREAD(28454):[07:32:17.087705] Init data report 0x7f137c0225e0 size 1392 using packetring=0x7f137c022bd0 cond=0x7f138c001b28
        THREAD(28454):[07:32:17.087709] Init connection report 0x7f137c0225e0
        THREAD(28454):[07:32:17.087712] Update connection report 0x7f137c0225e0 winreq=0 actual=131072
        THREAD(28454):[07:32:17.087715] Jobq report 0x7f137c0225e0 (0x9) post
        THREAD(28329):[07:32:17.091842] Jobq *ROOT* 0x7f13900226d0 (last=0x7f1388001200)
        [  6] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45080
        [ 10] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45084
        [  7] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 45086
        [  4]  0.0- 1.0 sec  2.67 GBytes  22.9 Gbits/sec
        [  6]  0.0- 1.0 sec  1.83 GBytes  15.7 Gbits/sec
        [ 10]  0.0- 1.0 sec  1.76 GBytes  15.1 Gbits/sec
        [  7]  0.0- 1.0 sec  2.56 GBytes  22.0 Gbits/sec
        [SUM]  0.0- 1.0 sec  8.82 GBytes  75.8 Gbits/sec
        [  4]  1.0- 2.0 sec  2.56 GBytes  22.0 Gbits/sec
        [  6]  1.0- 2.0 sec  2.12 GBytes  18.2 Gbits/sec
        [ 10]  1.0- 2.0 sec  1.97 GBytes  16.9 Gbits/sec
        [  7]  1.0- 2.0 sec  2.50 GBytes  21.5 Gbits/sec
        [SUM]  1.0- 2.0 sec  9.15 GBytes  78.6 Gbits/sec
        [  4]  2.0- 3.0 sec  2.52 GBytes  21.6 Gbits/sec
        [  6]  2.0- 3.0 sec  2.08 GBytes  17.8 Gbits/sec
        [ 10]  2.0- 3.0 sec  2.10 GBytes  18.0 Gbits/sec
        [  7]  2.0- 3.0 sec  2.53 GBytes  21.7 Gbits/sec
        [SUM]  2.0- 3.0 sec  9.22 GBytes  79.2 Gbits/sec
        [  4]  3.0- 4.0 sec  2.54 GBytes  21.8 Gbits/sec
        [  6]  3.0- 4.0 sec  1.97 GBytes  16.9 Gbits/sec
        [ 10]  3.0- 4.0 sec  2.12 GBytes  18.2 Gbits/sec
        [  7]  3.0- 4.0 sec  2.57 GBytes  22.1 Gbits/sec
        [SUM]  3.0- 4.0 sec  9.21 GBytes  79.1 Gbits/sec
        THREAD(28452):[07:32:21.089541] Reporting last packet for 0x7f1388001200  qdepth=1251
        THREAD(28452):[07:32:21.089556] Traffic thread awaiting reporter to be done with 0x7f1388001200 and cond 0x7f138c004768
        THREAD(28455):[07:32:21.089866] Reporting last packet for 0x7f1384001200  qdepth=2026
        THREAD(28455):[07:32:21.089877] Traffic thread awaiting reporter to be done with 0x7f1384001200 and cond 0x7f138c001f78
        THREAD(28453):[07:32:21.089965] Reporting last packet for 0x7f13900226d0  qdepth=2299
        THREAD(28453):[07:32:21.089975] Traffic thread awaiting reporter to be done with 0x7f13900226d0 and cond 0x7f138c0042e8
        THREAD(28454):[07:32:21.090021] Reporting last packet for 0x7f137c0225e0  qdepth=2444
        THREAD(28454):[07:32:21.090030] Traffic thread awaiting reporter to be done with 0x7f137c0225e0 and cond 0x7f138c001b28
        [  4]  4.0- 4.0 sec  7.02 MBytes  23.7 Gbits/sec
        [  4]  0.0- 4.0 sec  10.3 GBytes  22.1 Gbits/sec
        THREAD(28329):[07:32:21.093132] Jobq *FREE* 0x7f1388001200 (1) ((nil))
        THREAD(28329):[07:32:21.093139] Signal producer to free report 0x7f1388001200 and cond 0x7f1388001890
        [  6]  4.0- 4.0 sec  6.89 MBytes  22.5 Gbits/sec
        [  6]  0.0- 4.0 sec  8.00 GBytes  17.2 Gbits/sec
        THREAD(28452):[07:32:21.093174] Traffic thread thinks reporter is done with 0x7f1388001200
        THREAD(28452):[07:32:21.093191] Server destructor sock=4 bidir=false
        THREAD(28452):[07:32:21.093195] Socket close sock=4 (server destructor)
        THREAD(28329):[07:32:21.093185] Jobq *FREE* 0x7f13900226d0 (1) (0x7f1384001200)
        THREAD(28329):[07:32:21.093203] Signal producer to free report 0x7f13900226d0 and cond 0x7f1390022d60
        THREAD(28452):[07:32:21.093207] Sum multiheader 0x7f138c001150 ref=4->3
        THREAD(28452):[07:32:21.093214] Free packet ring=0x7f13880017f0 producer=0x7f138c004768 (consumer=0x5587ea1de3a0)
        THREAD(28452):[07:32:21.093218] Free report hdr=0x7f1388001200 reporter thread suspend count=1801 packetring=0x7f13880017f0 histo=(nil) frame histo=(nil)
        THREAD(28452):[07:32:21.093226] Free thread settings=0x7f138c004450
        THREAD(28453):[07:32:21.093218] Traffic thread thinks reporter is done with 0x7f13900226d0
        THREAD(28453):[07:32:21.093236] Server destructor sock=6 bidir=false
        THREAD(28453):[07:32:21.093240] Socket close sock=6 (server destructor)
        [  7]  4.0- 4.0 sec  7.61 MBytes  24.6 Gbits/sec
        THREAD(28453):[07:32:21.093249] Sum multiheader 0x7f138c001150 ref=3->2
        THREAD(28453):[07:32:21.093255] Free packet ring=0x7f1390022cc0 producer=0x7f138c0042e8 (consumer=0x5587ea1de3a0)
        [  7]  0.0- 4.0 sec  10.2 GBytes  21.8 Gbits/sec
        THREAD(28329):[07:32:21.093264] Jobq *FREE* 0x7f137c0225e0 (1) ((nil))
        THREAD(28453):[07:32:21.093258] Free report hdr=0x7f13900226d0 reporter thread suspend count=1801 packetring=0x7f1390022cc0 histo=(nil) frame histo=(nil)
        THREAD(28453):[07:32:21.093274] Free thread settings=0x7f138c003fd0
        THREAD(28329):[07:32:21.093267] Signal producer to free report 0x7f137c0225e0 and cond 0x7f137c022c70
        THREAD(28454):[07:32:21.093282] Traffic thread thinks reporter is done with 0x7f137c0225e0
        THREAD(28454):[07:32:21.093300] Server destructor sock=7 bidir=false
        THREAD(28454):[07:32:21.093304] Socket close sock=7 (server destructor)
        THREAD(28454):[07:32:21.093312] Sum multiheader 0x7f138c001150 ref=2->1
        THREAD(28454):[07:32:21.093316] Free packet ring=0x7f137c022bd0 producer=0x7f138c001b28 (consumer=0x5587ea1de3a0)
        THREAD(28454):[07:32:21.093321] Free report hdr=0x7f137c0225e0 reporter thread suspend count=1801 packetring=0x7f137c022bd0 histo=(nil) frame histo=(nil)
        [ 10]  4.0- 4.0 sec  6.24 MBytes  21.9 Gbits/sec
        THREAD(28454):[07:32:21.093329] Free thread settings=0x7f138c001810
        [ 10]  0.0- 4.0 sec  7.96 GBytes  17.1 Gbits/sec
        THREAD(28329):[07:32:21.093339] Jobq *FREE* 0x7f1384001200 (1) ((nil))
        THREAD(28329):[07:32:21.093343] Signal producer to free report 0x7f1384001200 and cond 0x7f1384001890
        THREAD(28455):[07:32:21.093352] Traffic thread thinks reporter is done with 0x7f1384001200
        THREAD(28455):[07:32:21.093360] Server destructor sock=10 bidir=false
        THREAD(28455):[07:32:21.093364] Socket close sock=10 (server destructor)
        THREAD(28455):[07:32:21.093372] Sum multiheader 0x7f138c001150 ref=1->0
        [SUM]  0.0- 4.0 sec  36.4 GBytes  78.2 Gbits/sec
        THREAD(28455):[07:32:21.093379] Free sum multiheader 0x7f138c001150 per last reference
        THREAD(28455):[07:32:21.093383] Free packet ring=0x7f13840017f0 producer=0x7f138c001f78 (consumer=0x5587ea1de3a0)
        THREAD(28455):[07:32:21.093385] Free report hdr=0x7f1384001200 reporter thread suspend count=1801 packetring=0x7f13840017f0 histo=(nil) frame histo=(nil)
        THREAD(28455):[07:32:21.093390] Free thread settings=0x7f138c001c60
        THREAD(28329):[07:32:22.093468] Jobq *WAIT* exit  (nil) 
        THREAD(28329):[07:32:22.093517] Reporter thread finished
        THREAD(28329):[07:32:22.093539] Free thread settings=0x5587ea3821f0
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E10:~/Desktop/iperf/dec2/iperf2-code/src$ 
        

        transcript from the server:

        tech1@E11:~/Desktop/iperf/dec2/iperf2-code/src$ 
        tech1@E11:~/Desktop/iperf/dec2/iperf2-code/src$ ./iperf -v
        iperf version 2.0.14a (1 Dec 2019) pthreads
        tech1@E11:~/Desktop/iperf/dec2/iperf2-code/src$ ./iperf -s
        THREAD(8166):[07:31:29.514238] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x55a87d3d1200 report/multi/bidir (nil)/(nil)/(nil)
        THREAD(8166):[07:31:29.514425] Thread_run_wrapper(0x55a87d3d1200 mode=3) thread counts tot/trfc=1/0
        THREAD(8167):[07:31:29.514487] Reporter thread started
        THREAD(8166):[07:31:29.514505] Thread_run_wrapper(0x55a87d3d0e70 mode=7) thread counts tot/trfc=2/0
        THREAD(8168):[07:31:29.514637] Init settings report 0x7f1c98020b90
        THREAD(8168):[07:31:29.514693] Update connection report 0x7f1c98020b90 winreq=0 actual=131072
        THREAD(8168):[07:31:29.514712] Jobq report 0x7f1c98020b90 (0x4) post
        THREAD(8167):[07:31:29.514712] Reporter await done
        THREAD(8168):[07:31:29.514754] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98023810 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(8167):[07:31:29.514817] Jobq *ROOT* 0x7f1c98020b90 (last=(nil))
        ------------------------------------------------------------
        Server listening on TCP port 5001
        THREAD(8168):[07:31:29.514864] Listener thread accepting for TCP (sock=3)
        TCP window size:  128 KByte (default)
        ------------------------------------------------------------
        THREAD(8167):[07:31:29.514976] Jobq *FREE* 0x7f1c98020b90 (0) ((nil))
        THREAD(8167):[07:31:29.515011] Free report 0x7f1c98020b90 (flags = 0)
        THREAD(8167):[07:31:30.515152] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:31.515316] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:32.515481] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:33.515644] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:34.515808] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:35.515975] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:36.516140] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:37.516305] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:38.516473] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:39.516637] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:31:40.516809] Jobq *WAIT* exit  (nil) 
        THREAD(8168):[07:31:41.070108] Init multiheader sum report 0x7f1c98020fc0 id=-1
        THREAD(8168):[07:31:41.070266] Thread_run_wrapper(0x7f1c98023810 mode=1) thread counts tot/trfc=3/1
        THREAD(8168):[07:31:41.070308] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98021710 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(8499):[07:31:41.070314] Server spawn settings=0x7f1c98023810 multihdr=0x7f1c98020fc0 sock=4
        THREAD(8168):[07:31:41.070354] Listener thread accepting for TCP (sock=3)
        THREAD(8499):[07:31:41.070420] Server constructor with thread=0x7f1c98023810 multihdr=0x7f1c98020fc0(sock=4)
        THREAD(8168):[07:31:41.070566] Thread_run_wrapper(0x7f1c98021710 mode=1) thread counts tot/trfc=4/2
        THREAD(8168):[07:31:41.070599] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98022040 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(8168):[07:31:41.070616] Listener thread accepting for TCP (sock=3)
        THREAD(8500):[07:31:41.070620] Server spawn settings=0x7f1c98021710 multihdr=0x7f1c98020fc0 sock=5
        THREAD(8500):[07:31:41.070717] Server constructor with thread=0x7f1c98021710 multihdr=0x7f1c98020fc0(sock=5)
        THREAD(8168):[07:31:41.070721] Thread_run_wrapper(0x7f1c98022040 mode=1) thread counts tot/trfc=5/3
        THREAD(8168):[07:31:41.070779] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98022970 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(8501):[07:31:41.070784] Server spawn settings=0x7f1c98022040 multihdr=0x7f1c98020fc0 sock=7
        THREAD(8499):[07:31:41.070781] Job report 0x7f1c98020b90 uses multireport 0x7f1c98020fc0 and bidirreport is (nil)
        THREAD(8168):[07:31:41.070809] Listener thread accepting for TCP (sock=3)
        THREAD(8500):[07:31:41.071030] Job report 0x7f1c98020b90 uses multireport 0x7f1c98020fc0 and bidirreport is (nil)
        THREAD(8500):[07:31:41.071074] Init 5000 element packet ring=0x7f1c8c0212a0 producer=0x7f1c98021a28 consumer=0x55a87b7093a0
        THREAD(8501):[07:31:41.070911] Server constructor with thread=0x7f1c98022040 multihdr=0x7f1c98020fc0(sock=7)
        THREAD(8499):[07:31:41.070987] Init 5000 element packet ring=0x7f1c940212a0 producer=0x7f1c98023b28 consumer=0x55a87b7093a0
        THREAD(8500):[07:31:41.071097] Sum multiheader 0x7f1c98020fc0 ref=0->1
        THREAD(8168):[07:31:41.071179] Thread_run_wrapper(0x7f1c98022970 mode=1) thread counts tot/trfc=6/4
        THREAD(8500):[07:31:41.071227] Init data report 0x7f1c8c020d20 size 1392 using packetring=0x7f1c8c0212a0 cond=0x7f1c98021a28
        THREAD(8168):[07:31:41.071250] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c980232a0 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(8502):[07:31:41.071227] Server spawn settings=0x7f1c98022970 multihdr=0x7f1c98020fc0 sock=6
        THREAD(8502):[07:31:41.071361] Server constructor with thread=0x7f1c98022970 multihdr=0x7f1c98020fc0(sock=6)
        THREAD(8499):[07:31:41.071265] Sum multiheader 0x7f1c98020fc0 ref=1->2
        THREAD(8499):[07:31:41.071435] Init data report 0x7f1c94020d20 size 1392 using packetring=0x7f1c940212a0 cond=0x7f1c98023b28
        THREAD(8499):[07:31:41.071464] Init connection report 0x7f1c94020d20
        THREAD(8500):[07:31:41.071282] Init connection report 0x7f1c8c020d20
        THREAD(8500):[07:31:41.071524] Update connection report 0x7f1c8c020d20 winreq=0 actual=131072
        THREAD(8499):[07:31:41.071495] Update connection report 0x7f1c94020d20 winreq=0 actual=131072
        THREAD(8500):[07:31:41.071556] Jobq report 0x7f1c8c020d20 (0x9) post
        THREAD(8168):[07:31:41.071310] Listener thread accepting for TCP (sock=3)
        THREAD(8499):[07:31:41.071577] Jobq report 0x7f1c94020d20 (0x9) post
        THREAD(8167):[07:31:41.071608] Jobq *WAIT* exit  0x7f1c8c020d20 
        THREAD(8167):[07:31:41.071664] Jobq *ROOT* 0x7f1c8c020d20 (last=(nil))
        THREAD(8502):[07:31:41.071668] Job report 0x7f1c98020b90 uses multireport 0x7f1c98020fc0 and bidirreport is (nil)
        THREAD(8501):[07:31:41.071745] Job report 0x7f1c98020b90 uses multireport 0x7f1c98020fc0 and bidirreport is (nil)
        THREAD(8502):[07:31:41.071812] Init 5000 element packet ring=0x7f1c840212a0 producer=0x7f1c98022c88 consumer=0x55a87b7093a0
        [  5] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41794
        THREAD(8502):[07:31:41.071860] Sum multiheader 0x7f1c98020fc0 ref=2->3
        THREAD(8501):[07:31:41.071899] Init 5000 element packet ring=0x7f1c900212a0 producer=0x7f1c98022358 consumer=0x55a87b7093a0
        THREAD(8502):[07:31:41.071928] Init data report 0x7f1c84020d20 size 1392 using packetring=0x7f1c840212a0 cond=0x7f1c98022c88
        THREAD(8501):[07:31:41.071967] Sum multiheader 0x7f1c98020fc0 ref=3->4
        THREAD(8502):[07:31:41.071994] Init connection report 0x7f1c84020d20
        THREAD(8501):[07:31:41.072031] Init data report 0x7f1c90020d20 size 1392 using packetring=0x7f1c900212a0 cond=0x7f1c98022358
        THREAD(8502):[07:31:41.072061] Update connection report 0x7f1c84020d20 winreq=0 actual=131072
        THREAD(8501):[07:31:41.072076] Init connection report 0x7f1c90020d20
        THREAD(8502):[07:31:41.072093] Jobq report 0x7f1c84020d20 (0x9) post
        THREAD(8501):[07:31:41.072128] Update connection report 0x7f1c90020d20 winreq=0 actual=131072
        THREAD(8501):[07:31:41.072175] Jobq report 0x7f1c90020d20 (0x9) post
        THREAD(8499):[07:31:51.070850] Reporting last packet for 0x7f1c94020d20  qdepth=1
        THREAD(8499):[07:31:51.070865] Traffic thread awaiting reporter to be done with 0x7f1c94020d20 and cond 0x7f1c98023b28
        THREAD(8502):[07:31:51.071023] Reporting last packet for 0x7f1c84020d20  qdepth=1
        THREAD(8502):[07:31:51.071034] Traffic thread awaiting reporter to be done with 0x7f1c84020d20 and cond 0x7f1c98022c88
        THREAD(8501):[07:31:51.071045] Reporting last packet for 0x7f1c90020d20  qdepth=1
        THREAD(8501):[07:31:51.071057] Traffic thread awaiting reporter to be done with 0x7f1c90020d20 and cond 0x7f1c98022358
        THREAD(8500):[07:31:51.071077] Reporting last packet for 0x7f1c8c020d20  qdepth=1
        THREAD(8500):[07:31:51.071087] Traffic thread awaiting reporter to be done with 0x7f1c8c020d20 and cond 0x7f1c98021a28
        [ ID] Interval       Transfer     Bandwidth
        [  5]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(8167):[07:31:51.071100] Jobq *FREE* 0x7f1c8c020d20 (1) ((nil))
        THREAD(8167):[07:31:51.071108] Signal producer to free report 0x7f1c8c020d20 and cond 0x7f1c8c021340
        THREAD(8167):[07:31:51.071113] Jobq *ROOT* 0x7f1c94020d20 (last=(nil))
        [  4] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41792
        THREAD(8500):[07:31:51.071115] Traffic thread thinks reporter is done with 0x7f1c8c020d20
        [  4]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(8500):[07:31:51.071125] Server destructor sock=5 bidir=false
        THREAD(8167):[07:31:51.071130] Jobq *FREE* 0x7f1c94020d20 (1) (0x7f1c84020d20)
        THREAD(8500):[07:31:51.071134] Socket close sock=5 (server destructor)
        THREAD(8167):[07:31:51.071139] Signal producer to free report 0x7f1c94020d20 and cond 0x7f1c94021340
        [  7] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41796
        THREAD(8500):[07:31:51.071150] Sum multiheader 0x7f1c98020fc0 ref=4->3
        [  7]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8500):[07:31:51.071165] Free packet ring=0x7f1c8c0212a0 producer=0x7f1c98021a28 (consumer=0x55a87b7093a0)
        THREAD(8499):[07:31:51.071150] Traffic thread thinks reporter is done with 0x7f1c94020d20
        THREAD(8167):[07:31:51.071172] Jobq *FREE* 0x7f1c90020d20 (1) ((nil))
        THREAD(8499):[07:31:51.071175] Server destructor sock=4 bidir=false
        THREAD(8500):[07:31:51.071177] Free report hdr=0x7f1c8c020d20 reporter thread suspend count=1 packetring=0x7f1c8c0212a0 histo=(nil) frame histo=(nil)
        THREAD(8167):[07:31:51.071179] Signal producer to free report 0x7f1c90020d20 and cond 0x7f1c90021340
        THREAD(8499):[07:31:51.071183] Socket close sock=4 (server destructor)
        [  6] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41798
        THREAD(8501):[07:31:51.071194] Traffic thread thinks reporter is done with 0x7f1c90020d20
        [  6]  0.0-10.0 sec  27.4 GBytes  23.5 Gbits/sec
        THREAD(8501):[07:31:51.071200] Server destructor sock=7 bidir=false
        THREAD(8499):[07:31:51.071199] Sum multiheader 0x7f1c98020fc0 ref=3->2
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8501):[07:31:51.071208] Socket close sock=7 (server destructor)
        THREAD(8500):[07:31:51.071209] Thread_run_wrapper(0x7f1c98021aa0 mode=2) thread counts tot/trfc=6/4
        THREAD(8499):[07:31:51.071209] Free packet ring=0x7f1c940212a0 producer=0x7f1c98023b28 (consumer=0x55a87b7093a0)
        THREAD(8501):[07:31:51.071217] Sum multiheader 0x7f1c98020fc0 ref=2->1
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8800):[07:31:51.071218] Client thread started in constructor (3202/0)
        THREAD(8500):[07:31:51.071218] Free thread settings=0x7f1c98021710
        THREAD(8167):[07:31:51.071210] Jobq *FREE* 0x7f1c84020d20 (1) ((nil))
        THREAD(8499):[07:31:51.071227] Free report hdr=0x7f1c94020d20 reporter thread suspend count=1 packetring=0x7f1c940212a0 histo=(nil) frame histo=(nil)
        THREAD(8501):[07:31:51.071229] Free packet ring=0x7f1c900212a0 producer=0x7f1c98022358 (consumer=0x55a87b7093a0)
        THREAD(8167):[07:31:51.071240] Signal producer to free report 0x7f1c84020d20 and cond 0x7f1c84021340
        THREAD(8502):[07:31:51.071252] Traffic thread thinks reporter is done with 0x7f1c84020d20
        THREAD(8501):[07:31:51.071254] Free report hdr=0x7f1c90020d20 reporter thread suspend count=1 packetring=0x7f1c900212a0 histo=(nil) frame histo=(nil)
        THREAD(8502):[07:31:51.071259] Server destructor sock=6 bidir=false
        THREAD(8499):[07:31:51.071266] Thread_run_wrapper(0x7f1c98020b90 mode=2) thread counts tot/trfc=5/3
        THREAD(8502):[07:31:51.071266] Socket close sock=6 (server destructor)
        THREAD(8499):[07:31:51.071273] Free thread settings=0x7f1c98023810
        THREAD(8501):[07:31:51.071276] Thread_run_wrapper(0x7f1c980223d0 mode=2) thread counts tot/trfc=6/4
        THREAD(8502):[07:31:51.071280] Sum multiheader 0x7f1c98020fc0 ref=1->0
        [SUM]  0.0-10.0 sec   110 GBytes  94.1 Gbits/sec
        THREAD(8502):[07:31:51.071290] Free sum multiheader 0x7f1c98020fc0 per last reference
        THREAD(8501):[07:31:51.071281] Free thread settings=0x7f1c98022040
        THREAD(8802):[07:31:51.071281] Client thread started in constructor (3202/0)
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8502):[07:31:51.071324] Free packet ring=0x7f1c840212a0 producer=0x7f1c98022c88 (consumer=0x55a87b7093a0)
        THREAD(8502):[07:31:51.071332] Free report hdr=0x7f1c84020d20 reporter thread suspend count=1 packetring=0x7f1c840212a0 histo=(nil) frame histo=(nil)
        THREAD(8502):[07:31:51.071346] Thread_run_wrapper(0x7f1c98022d00 mode=2) thread counts tot/trfc=6/4
        THREAD(8803):[07:31:51.071350] Client thread started in constructor (3202/0)
        THREAD(8502):[07:31:51.071351] Free thread settings=0x7f1c98022970
        THREAD(8801):[07:31:51.071296] Client thread started in constructor (3202/0)
        THREAD(8800):[07:31:51.071701] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(8802):[07:31:51.071702] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(8803):[07:31:51.071702] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(8800):[07:31:51.071713] Init 5000 element packet ring=0x7f1c88020f10 producer=0x7f1c98021db8 consumer=0x55a87b7093a0
        THREAD(8802):[07:31:51.071721] Init 5000 element packet ring=0x7f1c8c020bb0 producer=0x7f1c980226e8 consumer=0x55a87b7093a0
        THREAD(8803):[07:31:51.071725] Init 5000 element packet ring=0x7f1c90020ed0 producer=0x7f1c98023018 consumer=0x55a87b7093a0
        THREAD(8802):[07:31:51.071729] Init data report 0x7f1c8c021360 size 1392 using packetring=0x7f1c8c020bb0 cond=0x7f1c980226e8
        THREAD(8800):[07:31:51.071724] Init data report 0x7f1c88021350 size 1392 using packetring=0x7f1c88020f10 cond=0x7f1c98021db8
        THREAD(8803):[07:31:51.071732] Init data report 0x7f1c90021450 size 1392 using packetring=0x7f1c90020ed0 cond=0x7f1c98023018
        THREAD(8802):[07:31:51.071736] Init connection report 0x7f1c8c021360
        THREAD(8800):[07:31:51.071740] Init connection report 0x7f1c88021350
        THREAD(8802):[07:31:51.071749] Update connection report 0x7f1c8c021360 winreq=0 actual=87040
        THREAD(8800):[07:31:51.071753] Update connection report 0x7f1c88021350 winreq=0 actual=87040
        THREAD(8803):[07:31:51.071744] Init connection report 0x7f1c90021450
        THREAD(8803):[07:31:51.071762] Update connection report 0x7f1c90021450 winreq=0 actual=87040
        THREAD(8800):[07:31:51.071761] Init settings report 0x7f1c880c7920
        THREAD(8802):[07:31:51.071760] Init settings report 0x7f1c8c0c7930
        THREAD(8803):[07:31:51.071769] Init settings report 0x7f1c900c7a20
        THREAD(8800):[07:31:51.071768] Update connection report 0x7f1c880c7920 winreq=0 actual=87040
        THREAD(8803):[07:31:51.071774] Update connection report 0x7f1c900c7a20 winreq=0 actual=87040
        THREAD(8802):[07:31:51.071772] Update connection report 0x7f1c8c0c7930 winreq=0 actual=87040
        THREAD(8800):[07:31:51.071778] Jobq report 0x7f1c880c7920 (0x4) post
        THREAD(8802):[07:31:51.071787] Jobq report 0x7f1c8c0c7930 (0x4) post
        THREAD(8800):[07:31:51.071791] Jobq report 0x7f1c88021350 (0x9) post
        THREAD(8167):[07:31:51.071793] Jobq *WAIT* exit  0x7f1c880c7920 
        THREAD(8803):[07:31:51.071782] Jobq report 0x7f1c900c7a20 (0x4) post
        THREAD(8801):[07:31:51.071773] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(8167):[07:31:51.071800] Jobq *ROOT* 0x7f1c880c7920 (last=(nil))
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        THREAD(8801):[07:31:51.071813] Init 5000 element packet ring=0x7f1c94020bb0 producer=0x7f1c98020ea8 consumer=0x55a87b7093a0
        THREAD(8800):[07:31:51.071817] Client spawn thread normal (sock=4)
        THREAD(8803):[07:31:51.071818] Jobq report 0x7f1c90021450 (0x9) post
        THREAD(8801):[07:31:51.071821] Init data report 0x7f1c94021980 size 1392 using packetring=0x7f1c94020bb0 cond=0x7f1c98020ea8
        THREAD(8800):[07:31:51.071824] Client start sync enterred
        THREAD(8801):[07:31:51.071829] Init connection report 0x7f1c94021980
        THREAD(8802):[07:31:51.071815] Jobq report 0x7f1c8c021360 (0x9) post
        THREAD(8800):[07:31:51.071832] Client start sync exited
        THREAD(8803):[07:31:51.071827] Client spawn thread normal (sock=7)
        THREAD(8801):[07:31:51.071834] Update connection report 0x7f1c94021980 winreq=0 actual=87040
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(8801):[07:31:51.071850] Init settings report 0x7f1c940c7f50
        THREAD(8802):[07:31:51.071839] Client spawn thread normal (sock=5)
        THREAD(8803):[07:31:51.071844] Client start sync enterred
        THREAD(8167):[07:31:51.071862] Jobq *FREE* 0x7f1c880c7920 (0) ((nil))
        THREAD(8801):[07:31:51.071856] Update connection report 0x7f1c940c7f50 winreq=0 actual=87040
        THREAD(8167):[07:31:51.071867] Free report 0x7f1c880c7920 (flags = 0)
        THREAD(8801):[07:31:51.071869] Jobq report 0x7f1c940c7f50 (0x4) post
        THREAD(8167):[07:31:51.071871] Jobq *ROOT* 0x7f1c8c0c7930 (last=(nil))
        THREAD(8803):[07:31:51.071865] Client start sync exited
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        TCP window size: 85.0 KByte (default)THREAD(8802):[07:31:51.071860] Client start sync enterred
        
        ------------------------------------------------------------
        THREAD(8801):[07:31:51.071876] Jobq report 0x7f1c94021980 (0x9) post
        THREAD(8167):[07:31:51.071889] Jobq *FREE* 0x7f1c8c0c7930 (0) (0x7f1c88021350)
        THREAD(8801):[07:31:51.071892] Client spawn thread normal (sock=8)
        THREAD(8167):[07:31:51.071894] Free report 0x7f1c8c0c7930 (flags = 0)
        THREAD(8802):[07:31:51.071884] Client start sync exited
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(8801):[07:31:51.071897] Client start sync enterred
        THREAD(8167):[07:31:51.071911] Jobq *FREE* 0x7f1c900c7a20 (0) (0x7f1c90021450)
        THREAD(8801):[07:31:51.071913] Client start sync exited
        THREAD(8167):[07:31:51.071916] Free report 0x7f1c900c7a20 (flags = 0)
        [  5] local 192.168.1.111 port 45074 connected with 192.168.1.110 port 5001 (ct=0.07 ms)
        THREAD(8803):[07:32:01.071890] Shutdown client's writes on tcp socket 7
        THREAD(8802):[07:32:01.071908] Shutdown client's writes on tcp socket 5
        THREAD(8803):[07:32:01.071911] Reporting last packet for 0x7f1c90021450  qdepth=1
        THREAD(8802):[07:32:01.071921] Reporting last packet for 0x7f1c8c021360  qdepth=1
        THREAD(8803):[07:32:01.071928] Traffic thread awaiting reporter to be done with 0x7f1c90021450 and cond 0x7f1c98023018
        THREAD(8802):[07:32:01.071931] Traffic thread awaiting reporter to be done with 0x7f1c8c021360 and cond 0x7f1c980226e8
        [  5]  0.0-10.0 sec  15.8 GBytes  13.6 Gbits/sec
        THREAD(8167):[07:32:01.071941] Jobq *FREE* 0x7f1c8c021360 (1) ((nil))
        THREAD(8167):[07:32:01.071948] Signal producer to free report 0x7f1c8c021360 and cond 0x7f1c8c020c50
        THREAD(8167):[07:32:01.071953] Jobq *ROOT* 0x7f1c940c7f50 (last=0x7f1c88021350)
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        TCP window size: 85.0 KByteTHREAD(8802):[07:32:01.071954] Traffic thread thinks reporter is done with 0x7f1c8c021360
         (default)
        ------------------------------------------------------------
        THREAD(8802):[07:32:01.071971] Client destructor sock=5 report=0x7f1c8c021360 server-reverse=false bidir=false
        THREAD(8167):[07:32:01.071975] Jobq *FREE* 0x7f1c940c7f50 (0) (0x7f1c94021980)
        THREAD(8167):[07:32:01.071982] Free report 0x7f1c940c7f50 (flags = 0)
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        [  4] local 192.168.1.111 port 45072 connected with 192.168.1.110 port 5001 (ct=0.06 ms)
        THREAD(8802):[07:32:01.071988] Free packet ring=0x7f1c8c020bb0 producer=0x7f1c980226e8 (consumer=0x55a87b7093a0)
        THREAD(8802):[07:32:01.071993] Free report hdr=0x7f1c8c021360 reporter thread suspend count=1 packetring=0x7f1c8c020bb0 histo=(nil) frame histo=(nil)
        THREAD(8802):[07:32:01.071999] Free thread settings=0x7f1c980223d0
        THREAD(8801):[07:32:01.073390] Shutdown client's writes on tcp socket 8
        THREAD(8801):[07:32:01.073399] Reporting last packet for 0x7f1c94021980  qdepth=1
        THREAD(8801):[07:32:01.073403] Traffic thread awaiting reporter to be done with 0x7f1c94021980 and cond 0x7f1c98020ea8
        THREAD(8800):[07:32:01.073463] Shutdown client's writes on tcp socket 4
        THREAD(8800):[07:32:01.073473] Reporting last packet for 0x7f1c88021350  qdepth=1
        THREAD(8800):[07:32:01.073477] Traffic thread awaiting reporter to be done with 0x7f1c88021350 and cond 0x7f1c98021db8
        [  4]  0.0-10.0 sec  16.3 GBytes  14.0 Gbits/sec
        THREAD(8167):[07:32:01.073488] Jobq *FREE* 0x7f1c88021350 (1) (0x7f1c90021450)
        THREAD(8167):[07:32:01.073493] Signal producer to free report 0x7f1c88021350 and cond 0x7f1c88020fb0
        [  8] local 192.168.1.111 port 45078 connected with 192.168.1.110 port 5001 (ct=0.02 ms)
        [  8]  0.0-10.0 sec  16.8 GBytes  14.4 Gbits/sec
        THREAD(8167):[07:32:01.073504] Jobq *FREE* 0x7f1c94021980 (1) (0x7f1c90021450)
        THREAD(8167):[07:32:01.073506] Signal producer to free report 0x7f1c94021980 and cond 0x7f1c94020c50
        [  7] local 192.168.1.111 port 45076 connected with 192.168.1.110 port 5001 (ct=0.02 ms)
        THREAD(8801):[07:32:01.073511] Traffic thread thinks reporter is done with 0x7f1c94021980
        THREAD(8801):[07:32:01.073517] Client destructor sock=8 report=0x7f1c94021980 server-reverse=false bidir=false
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8801):[07:32:01.073526] Free packet ring=0x7f1c94020bb0 producer=0x7f1c98020ea8 (consumer=0x55a87b7093a0)
        THREAD(8801):[07:32:01.073531] Free report hdr=0x7f1c94021980 reporter thread suspend count=1 packetring=0x7f1c94020bb0 histo=(nil) frame histo=(nil)
        THREAD(8801):[07:32:01.073538] Free thread settings=0x7f1c98020b90
        THREAD(8800):[07:32:01.073538] Traffic thread thinks reporter is done with 0x7f1c88021350
        THREAD(8800):[07:32:01.073550] Client destructor sock=4 report=0x7f1c88021350 server-reverse=false bidir=false
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8800):[07:32:01.073558] Free packet ring=0x7f1c88020f10 producer=0x7f1c98021db8 (consumer=0x55a87b7093a0)
        THREAD(8800):[07:32:01.073562] Free report hdr=0x7f1c88021350 reporter thread suspend count=1 packetring=0x7f1c88020f10 histo=(nil) frame histo=(nil)
        THREAD(8800):[07:32:01.073567] Free thread settings=0x7f1c98021aa0
        [  7]  0.0-10.0 sec  15.4 GBytes  13.3 Gbits/sec
        THREAD(8167):[07:32:01.077572] Jobq *FREE* 0x7f1c90021450 (1) ((nil))
        THREAD(8167):[07:32:01.077578] Signal producer to free report 0x7f1c90021450 and cond 0x7f1c90020f70
        THREAD(8803):[07:32:01.077584] Traffic thread thinks reporter is done with 0x7f1c90021450
        THREAD(8803):[07:32:01.077591] Client destructor sock=7 report=0x7f1c90021450 server-reverse=false bidir=false
        WARN: this test was likley CPU bound (or may not be detecting the underlying network devices)
        THREAD(8803):[07:32:01.077600] Free packet ring=0x7f1c90020ed0 producer=0x7f1c98023018 (consumer=0x55a87b7093a0)
        THREAD(8803):[07:32:01.077604] Free report hdr=0x7f1c90021450 reporter thread suspend count=2 packetring=0x7f1c90020ed0 histo=(nil) frame histo=(nil)
        THREAD(8803):[07:32:01.077610] Free thread settings=0x7f1c98022d00
        THREAD(8167):[07:32:02.077704] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:03.077878] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:04.078049] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:05.078215] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:06.078383] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:07.078554] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:08.078726] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:09.078896] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:10.079067] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:11.079238] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:12.079412] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:13.079584] Jobq *WAIT* exit  (nil) 
        THREAD(8168):[07:32:13.085692] Init multiheader sum report 0x7f1c98022970 id=-2
        THREAD(8168):[07:32:13.085837] Thread_run_wrapper(0x7f1c980232a0 mode=1) thread counts tot/trfc=3/1
        THREAD(8168):[07:32:13.085876] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98022040 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(9456):[07:32:13.085893] Server spawn settings=0x7f1c980232a0 multihdr=0x7f1c98022970 sock=10
        THREAD(8168):[07:32:13.085901] Listener thread accepting for TCP (sock=3)
        THREAD(9456):[07:32:13.085974] Server constructor with thread=0x7f1c980232a0 multihdr=0x7f1c98022970(sock=10)
        THREAD(8168):[07:32:13.086095] Thread_run_wrapper(0x7f1c98022040 mode=1) thread counts tot/trfc=4/2
        THREAD(9457):[07:32:13.086120] Server spawn settings=0x7f1c98022040 multihdr=0x7f1c98022970 sock=4
        THREAD(8168):[07:32:13.086133] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98020b90 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(9457):[07:32:13.086192] Server constructor with thread=0x7f1c98022040 multihdr=0x7f1c98022970(sock=4)
        THREAD(8168):[07:32:13.086228] Listener thread accepting for TCP (sock=3)
        THREAD(9456):[07:32:13.086282] Job report 0x7f1c98020b90 uses multireport 0x7f1c98022970 and bidirreport is (nil)
        THREAD(8168):[07:32:13.086344] Thread_run_wrapper(0x7f1c98020b90 mode=1) thread counts tot/trfc=5/3
        THREAD(8168):[07:32:13.086370] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98021350 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(8168):[07:32:13.086389] Listener thread accepting for TCP (sock=3)
        THREAD(9458):[07:32:13.086401] Server spawn settings=0x7f1c98020b90 multihdr=0x7f1c98022970 sock=6
        THREAD(8168):[07:32:13.086458] Thread_run_wrapper(0x7f1c98021350 mode=1) thread counts tot/trfc=6/4
        THREAD(9459):[07:32:13.086486] Server spawn settings=0x7f1c98021350 multihdr=0x7f1c98022970 sock=7
        THREAD(9457):[07:32:13.086544] Job report 0x7f1c98020b90 uses multireport 0x7f1c98022970 and bidirreport is (nil)
        THREAD(9458):[07:32:13.086463] Server constructor with thread=0x7f1c98020b90 multihdr=0x7f1c98022970(sock=6)
        THREAD(8168):[07:32:13.086495] Copy thread settings (malloc) from/to=0x55a87d3d0e70/0x7f1c98023c10 report/multi/bidir 0x7f1c98020b90/(nil)/(nil)
        THREAD(9459):[07:32:13.086584] Server constructor with thread=0x7f1c98021350 multihdr=0x7f1c98022970(sock=7)
        THREAD(8168):[07:32:13.086710] Listener thread accepting for TCP (sock=3)
        THREAD(9458):[07:32:13.087040] Job report 0x7f1c98020b90 uses multireport 0x7f1c98022970 and bidirreport is (nil)
        THREAD(9456):[07:32:13.087051] Init 5000 element packet ring=0x7f1c90020cc0 producer=0x7f1c980235b8 consumer=0x55a87b7093a0
        THREAD(9459):[07:32:13.087082] Job report 0x7f1c98020b90 uses multireport 0x7f1c98022970 and bidirreport is (nil)
        THREAD(9456):[07:32:13.087099] Sum multiheader 0x7f1c98022970 ref=0->1
        THREAD(9456):[07:32:13.087158] Init data report 0x7f1c90021360 size 1392 using packetring=0x7f1c90020cc0 cond=0x7f1c980235b8
        THREAD(9456):[07:32:13.087189] Init connection report 0x7f1c90021360
        THREAD(9456):[07:32:13.087209] Update connection report 0x7f1c90021360 winreq=0 actual=131072
        THREAD(9456):[07:32:13.087227] Jobq report 0x7f1c90021360 (0x9) post
        THREAD(8167):[07:32:13.087302] Jobq *WAIT* exit  0x7f1c90021360 
        THREAD(9457):[07:32:13.087400] Init 5000 element packet ring=0x7f1c88021730 producer=0x7f1c98022358 consumer=0x55a87b7093a0
        THREAD(8167):[07:32:13.087382] Jobq *ROOT* 0x7f1c90021360 (last=(nil))
        THREAD(9457):[07:32:13.087429] Sum multiheader 0x7f1c98022970 ref=1->2
        [ 10] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41800
        THREAD(9457):[07:32:13.087449] Init data report 0x7f1c880211b0 size 1392 using packetring=0x7f1c88021730 cond=0x7f1c98022358
        THREAD(9457):[07:32:13.087508] Init connection report 0x7f1c880211b0
        THREAD(9457):[07:32:13.087528] Update connection report 0x7f1c880211b0 winreq=0 actual=131072
        THREAD(9457):[07:32:13.087541] Jobq report 0x7f1c880211b0 (0x9) post
        THREAD(9458):[07:32:13.087957] Init 5000 element packet ring=0x7f1c94021f00 producer=0x7f1c98020ea8 consumer=0x55a87b7093a0
        THREAD(9458):[07:32:13.087990] Sum multiheader 0x7f1c98022970 ref=2->3
        THREAD(9458):[07:32:13.088005] Init data report 0x7f1c94021980 size 1392 using packetring=0x7f1c94021f00 cond=0x7f1c98020ea8
        THREAD(9458):[07:32:13.088019] Init connection report 0x7f1c94021980
        THREAD(9458):[07:32:13.088034] Update connection report 0x7f1c94021980 winreq=0 actual=131072
        THREAD(9458):[07:32:13.088059] Jobq report 0x7f1c94021980 (0x9) post
        THREAD(9459):[07:32:13.088034] Init 5000 element packet ring=0x7f1c8c0218e0 producer=0x7f1c98021668 consumer=0x55a87b7093a0
        THREAD(9459):[07:32:13.088130] Sum multiheader 0x7f1c98022970 ref=3->4
        THREAD(9459):[07:32:13.088155] Init data report 0x7f1c8c021360 size 1392 using packetring=0x7f1c8c0218e0 cond=0x7f1c98021668
        THREAD(9459):[07:32:13.088173] Init connection report 0x7f1c8c021360
        THREAD(9459):[07:32:13.088193] Update connection report 0x7f1c8c021360 winreq=0 actual=131072
        THREAD(9459):[07:32:13.088211] Jobq report 0x7f1c8c021360 (0x9) post
        THREAD(9459):[07:32:17.086471] Reporting last packet for 0x7f1c8c021360  qdepth=1
        THREAD(9459):[07:32:17.086488] Traffic thread awaiting reporter to be done with 0x7f1c8c021360 and cond 0x7f1c98021668
        THREAD(9457):[07:32:17.086485] Reporting last packet for 0x7f1c880211b0  qdepth=1
        THREAD(9457):[07:32:17.086500] Traffic thread awaiting reporter to be done with 0x7f1c880211b0 and cond 0x7f1c98022358
        THREAD(9456):[07:32:17.086625] Reporting last packet for 0x7f1c90021360  qdepth=1
        THREAD(9456):[07:32:17.086634] Traffic thread awaiting reporter to be done with 0x7f1c90021360 and cond 0x7f1c980235b8
        [ 10]  0.0- 4.0 sec  10.8 GBytes  23.2 Gbits/sec
        THREAD(8167):[07:32:17.086643] Jobq *FREE* 0x7f1c90021360 (1) ((nil))
        THREAD(8167):[07:32:17.086651] Signal producer to free report 0x7f1c90021360 and cond 0x7f1c90020d60
        THREAD(8167):[07:32:17.086657] Jobq *ROOT* 0x7f1c880211b0 (last=(nil))
        THREAD(9456):[07:32:17.086658] Traffic thread thinks reporter is done with 0x7f1c90021360
        [  4] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41802
        THREAD(9456):[07:32:17.086668] Server destructor sock=10 bidir=false
        [  4]  0.0- 4.0 sec  11.0 GBytes  23.6 Gbits/sec
        THREAD(9456):[07:32:17.086676] Socket close sock=10 (server destructor)
        THREAD(8167):[07:32:17.086680] Jobq *FREE* 0x7f1c880211b0 (1) (0x7f1c94021980)
        THREAD(8167):[07:32:17.086686] Signal producer to free report 0x7f1c880211b0 and cond 0x7f1c880217d0
        THREAD(9456):[07:32:17.086688] Sum multiheader 0x7f1c98022970 ref=4->3
        [  7] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41806
        THREAD(9456):[07:32:17.086693] Free packet ring=0x7f1c90020cc0 producer=0x7f1c980235b8 (consumer=0x55a87b7093a0)
        [  7]  0.0- 4.0 sec  11.0 GBytes  23.6 Gbits/sec
        THREAD(9457):[07:32:17.086693] Traffic thread thinks reporter is done with 0x7f1c880211b0
        THREAD(9456):[07:32:17.086698] Free report hdr=0x7f1c90021360 reporter thread suspend count=3 packetring=0x7f1c90020cc0 histo=(nil) frame histo=(nil)
        THREAD(9457):[07:32:17.086706] Server destructor sock=4 bidir=false
        THREAD(8167):[07:32:17.086700] Jobq *FREE* 0x7f1c8c021360 (1) ((nil))
        THREAD(8167):[07:32:17.086715] Signal producer to free report 0x7f1c8c021360 and cond 0x7f1c8c021980
        THREAD(9457):[07:32:17.086716] Socket close sock=4 (server destructor)
        THREAD(9459):[07:32:17.086724] Traffic thread thinks reporter is done with 0x7f1c8c021360
        THREAD(9456):[07:32:17.086727] Thread_run_wrapper(0x7f1c98023810 mode=2) thread counts tot/trfc=6/4
        [  6] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 41804
        THREAD(9459):[07:32:17.086729] Server destructor sock=7 bidir=false
        THREAD(9580):[07:32:17.086731] Client thread started in constructor (3202/0)
        THREAD(9458):[07:32:17.086736] Reporting last packet for 0x7f1c94021980  qdepth=1
        THREAD(9457):[07:32:17.086732] Sum multiheader 0x7f1c98022970 ref=3->2
        THREAD(9458):[07:32:17.086747] Traffic thread awaiting reporter to be done with 0x7f1c94021980 and cond 0x7f1c98020ea8
        THREAD(9457):[07:32:17.086751] Free packet ring=0x7f1c88021730 producer=0x7f1c98022358 (consumer=0x55a87b7093a0)
        [  6]  0.0- 4.0 sec  11.0 GBytes  23.6 Gbits/sec
        THREAD(9459):[07:32:17.086739] Socket close sock=7 (server destructor)
        THREAD(8167):[07:32:17.086759] Jobq *FREE* 0x7f1c94021980 (1) ((nil))
        THREAD(9457):[07:32:17.086756] Free report hdr=0x7f1c880211b0 reporter thread suspend count=3 packetring=0x7f1c88021730 histo=(nil) frame histo=(nil)
        THREAD(9459):[07:32:17.086767] Sum multiheader 0x7f1c98022970 ref=2->1
        THREAD(8167):[07:32:17.086764] Signal producer to free report 0x7f1c94021980 and cond 0x7f1c94021fa0
        THREAD(9456):[07:32:17.086733] Free thread settings=0x7f1c980232a0
        THREAD(9459):[07:32:17.086772] Free packet ring=0x7f1c8c0218e0 producer=0x7f1c98021668 (consumer=0x55a87b7093a0)
        THREAD(9458):[07:32:17.086777] Traffic thread thinks reporter is done with 0x7f1c94021980
        THREAD(9459):[07:32:17.086782] Free report hdr=0x7f1c8c021360 reporter thread suspend count=3 packetring=0x7f1c8c0218e0 histo=(nil) frame histo=(nil)
        THREAD(9458):[07:32:17.086786] Server destructor sock=6 bidir=false
        THREAD(9457):[07:32:17.086788] Thread_run_wrapper(0x7f1c980223d0 mode=2) thread counts tot/trfc=6/4
        THREAD(9581):[07:32:17.086792] Client thread started in constructor (3202/0)
        THREAD(9459):[07:32:17.086799] Thread_run_wrapper(0x7f1c980216e0 mode=2) thread counts tot/trfc=6/4
        THREAD(9458):[07:32:17.086793] Socket close sock=6 (server destructor)
        THREAD(9457):[07:32:17.086796] Free thread settings=0x7f1c98022040
        THREAD(9459):[07:32:17.086804] Free thread settings=0x7f1c98021350
        THREAD(9582):[07:32:17.086808] Client thread started in constructor (3202/0)
        THREAD(9458):[07:32:17.086809] Sum multiheader 0x7f1c98022970 ref=1->0
        [SUM]  0.0- 4.0 sec  43.8 GBytes  94.0 Gbits/sec
        THREAD(9458):[07:32:17.086823] Free sum multiheader 0x7f1c98022970 per last reference
        THREAD(9458):[07:32:17.086826] Free packet ring=0x7f1c94021f00 producer=0x7f1c98020ea8 (consumer=0x55a87b7093a0)
        THREAD(9458):[07:32:17.086829] Free report hdr=0x7f1c94021980 reporter thread suspend count=3 packetring=0x7f1c94021f00 histo=(nil) frame histo=(nil)
        THREAD(9458):[07:32:17.086841] Thread_run_wrapper(0x7f1c98020f20 mode=2) thread counts tot/trfc=6/4
        THREAD(9583):[07:32:17.086843] Client thread started in constructor (3202/0)
        THREAD(9458):[07:32:17.086844] Free thread settings=0x7f1c98020b90
        THREAD(9581):[07:32:17.087101] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(9580):[07:32:17.087109] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(9581):[07:32:17.087127] Init 5000 element packet ring=0x7f1c90021900 producer=0x7f1c980226e8 consumer=0x55a87b7093a0
        THREAD(9580):[07:32:17.087127] Init 5000 element packet ring=0x7f1c84020f10 producer=0x7f1c98023b28 consumer=0x55a87b7093a0
        THREAD(9581):[07:32:17.087144] Init data report 0x7f1c90021380 size 1392 using packetring=0x7f1c90021900 cond=0x7f1c980226e8
        THREAD(9580):[07:32:17.087156] Init data report 0x7f1c84021450 size 1392 using packetring=0x7f1c84020f10 cond=0x7f1c98023b28
        THREAD(9581):[07:32:17.087159] Init connection report 0x7f1c90021380
        THREAD(9580):[07:32:17.087164] Init connection report 0x7f1c84021450
        THREAD(9581):[07:32:17.087167] Update connection report 0x7f1c90021380 winreq=0 actual=87040
        THREAD(9580):[07:32:17.087171] Update connection report 0x7f1c84021450 winreq=0 actual=87040
        THREAD(9581):[07:32:17.087175] Init settings report 0x7f1c900c7a80
        THREAD(9581):[07:32:17.087178] Update connection report 0x7f1c900c7a80 winreq=0 actual=87040
        THREAD(9580):[07:32:17.087180] Init settings report 0x7f1c840c7a20
        THREAD(9581):[07:32:17.087181] Jobq report 0x7f1c900c7a80 (0x4) post
        THREAD(9580):[07:32:17.087186] Update connection report 0x7f1c840c7a20 winreq=0 actual=87040
        THREAD(9581):[07:32:17.087190] Jobq report 0x7f1c90021380 (0x9) post
        THREAD(8167):[07:32:17.087191] Jobq *WAIT* exit  0x7f1c900c7a80 
        THREAD(9580):[07:32:17.087191] Jobq report 0x7f1c840c7a20 (0x4) post
        THREAD(8167):[07:32:17.087196] Jobq *ROOT* 0x7f1c900c7a80 (last=(nil))
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        THREAD(9581):[07:32:17.087206] Client spawn thread normal (sock=4)
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(9580):[07:32:17.087209] Jobq report 0x7f1c84021450 (0x9) post
        THREAD(9581):[07:32:17.087210] Client start sync enterred
        THREAD(9580):[07:32:17.087218] Client spawn thread normal (sock=5)
        THREAD(8167):[07:32:17.087213] Jobq *FREE* 0x7f1c900c7a80 (0) ((nil))
        THREAD(9580):[07:32:17.087224] Client start sync enterred
        THREAD(8167):[07:32:17.087227] Free report 0x7f1c900c7a80 (flags = 0)
        THREAD(9581):[07:32:17.087220] Client start sync exited
        THREAD(9580):[07:32:17.087229] Client start sync exited
        THREAD(8167):[07:32:17.087230] Jobq *ROOT* 0x7f1c90021380 (last=(nil))
        THREAD(9583):[07:32:17.087234] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        [  4] local 192.168.1.111 port 45082 connected with 192.168.1.110 port 5001 (ct=0.03 ms)
        THREAD(9582):[07:32:17.087240] Job report 0x7f1c98020b90 uses multireport (nil) and bidirreport is (nil)
        THREAD(9583):[07:32:17.087262] Init 5000 element packet ring=0x7f1c8c021fc0 producer=0x7f1c98021238 consumer=0x55a87b7093a0
        THREAD(9582):[07:32:17.087264] Init 5000 element packet ring=0x7f1c7c020f10 producer=0x7f1c980219f8 consumer=0x55a87b7093a0
        THREAD(9583):[07:32:17.087266] Init data report 0x7f1c8c021360 size 1392 using packetring=0x7f1c8c021fc0 cond=0x7f1c98021238
        THREAD(9582):[07:32:17.087271] Init data report 0x7f1c7c021350 size 1392 using packetring=0x7f1c7c020f10 cond=0x7f1c980219f8
        THREAD(9583):[07:32:17.087277] Init connection report 0x7f1c8c021360
        THREAD(9582):[07:32:17.087280] Init connection report 0x7f1c7c021350
        THREAD(9583):[07:32:17.087284] Update connection report 0x7f1c8c021360 winreq=0 actual=87040
        THREAD(9582):[07:32:17.087288] Update connection report 0x7f1c7c021350 winreq=0 actual=87040
        THREAD(9583):[07:32:17.087293] Init settings report 0x7f1c8c0c80d0
        THREAD(9582):[07:32:17.087297] Init settings report 0x7f1c7c0c7920
        THREAD(9583):[07:32:17.087297] Update connection report 0x7f1c8c0c80d0 winreq=0 actual=87040
        THREAD(9582):[07:32:17.087303] Update connection report 0x7f1c7c0c7920 winreq=0 actual=87040
        THREAD(9583):[07:32:17.087304] Jobq report 0x7f1c8c0c80d0 (0x4) post
        THREAD(9582):[07:32:17.087322] Jobq report 0x7f1c7c0c7920 (0x4) post
        THREAD(9583):[07:32:17.087324] Jobq report 0x7f1c8c021360 (0x9) post
        THREAD(9582):[07:32:17.087328] Jobq report 0x7f1c7c021350 (0x9) post
        THREAD(9583):[07:32:17.087332] Client spawn thread normal (sock=7)
        THREAD(9582):[07:32:17.087336] Client spawn thread normal (sock=6)
        THREAD(9583):[07:32:17.087338] Client start sync enterred
        THREAD(9582):[07:32:17.087342] Client start sync enterred
        THREAD(9583):[07:32:17.087344] Client start sync exited
        THREAD(9582):[07:32:17.087346] Client start sync exited
        THREAD(9580):[07:32:21.087243] Shutdown client's writes on tcp socket 5
        THREAD(9580):[07:32:21.087265] Reporting last packet for 0x7f1c84021450  qdepth=1
        THREAD(9580):[07:32:21.087268] Traffic thread awaiting reporter to be done with 0x7f1c84021450 and cond 0x7f1c98023b28
        THREAD(9581):[07:32:21.087476] Shutdown client's writes on tcp socket 4
        THREAD(9581):[07:32:21.087486] Reporting last packet for 0x7f1c90021380  qdepth=1
        THREAD(9581):[07:32:21.087489] Traffic thread awaiting reporter to be done with 0x7f1c90021380 and cond 0x7f1c980226e8
        [  4]  0.0- 4.0 sec  10.3 GBytes  22.1 Gbits/sec
        THREAD(8167):[07:32:21.087496] Jobq *FREE* 0x7f1c90021380 (1) (0x7f1c840c7a20)
        THREAD(8167):[07:32:21.087503] Signal producer to free report 0x7f1c90021380 and cond 0x7f1c900219a0
        [  5] local 192.168.1.111 port 45080 connected with 192.168.1.110 port 5001 (ct=0.03 ms)
        THREAD(9581):[07:32:21.087509] Traffic thread thinks reporter is done with 0x7f1c90021380
        THREAD(9581):[07:32:21.087514] Client destructor sock=4 report=0x7f1c90021380 server-reverse=false bidir=false
        [  5]  0.0- 4.0 sec  8.00 GBytes  17.2 Gbits/sec
        THREAD(8167):[07:32:21.087521] Jobq *FREE* 0x7f1c84021450 (1) ((nil))
        THREAD(9581):[07:32:21.087523] Free packet ring=0x7f1c90021900 producer=0x7f1c980226e8 (consumer=0x55a87b7093a0)
        THREAD(8167):[07:32:21.087524] Signal producer to free report 0x7f1c84021450 and cond 0x7f1c84020fb0
        THREAD(9581):[07:32:21.087528] Free report hdr=0x7f1c90021380 reporter thread suspend count=3 packetring=0x7f1c90021900 histo=(nil) frame histo=(nil)
        THREAD(8167):[07:32:21.087532] Jobq *ROOT* 0x7f1c8c0c80d0 (last=0x7f1c840c7a20)
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(9580):[07:32:21.087533] Traffic thread thinks reporter is done with 0x7f1c84021450
        THREAD(9581):[07:32:21.087536] Free thread settings=0x7f1c980223d0
        THREAD(8167):[07:32:21.087547] Jobq *FREE* 0x7f1c8c0c80d0 (0) (0x7f1c7c0c7920)
        THREAD(9580):[07:32:21.087553] Client destructor sock=5 report=0x7f1c84021450 server-reverse=false bidir=false
        THREAD(8167):[07:32:21.087558] Free report 0x7f1c8c0c80d0 (flags = 0)
        [  7] local 192.168.1.111 port 45086 connected with 192.168.1.110 port 5001 (ct=0.02 ms)
        THREAD(9580):[07:32:21.087566] Free packet ring=0x7f1c84020f10 producer=0x7f1c98023b28 (consumer=0x55a87b7093a0)
        THREAD(9580):[07:32:21.087573] Free report hdr=0x7f1c84021450 reporter thread suspend count=3 packetring=0x7f1c84020f10 histo=(nil) frame histo=(nil)
        THREAD(9580):[07:32:21.087581] Free thread settings=0x7f1c98023810
        THREAD(9582):[07:32:21.087601] Shutdown client's writes on tcp socket 6
        THREAD(9582):[07:32:21.087609] Reporting last packet for 0x7f1c7c021350  qdepth=1
        THREAD(9582):[07:32:21.087612] Traffic thread awaiting reporter to be done with 0x7f1c7c021350 and cond 0x7f1c980219f8
        THREAD(9583):[07:32:21.087827] Shutdown client's writes on tcp socket 7
        THREAD(9583):[07:32:21.087836] Reporting last packet for 0x7f1c8c021360  qdepth=1
        [  7]  0.0- 4.0 sec  10.2 GBytes  21.8 Gbits/sec
        THREAD(9583):[07:32:21.087839] Traffic thread awaiting reporter to be done with 0x7f1c8c021360 and cond 0x7f1c98021238
        THREAD(8167):[07:32:21.087843] Jobq *FREE* 0x7f1c8c021360 (1) (0x7f1c7c021350)
        THREAD(9583):[07:32:21.087847] Traffic thread thinks reporter is done with 0x7f1c8c021360
        THREAD(8167):[07:32:21.087848] Signal producer to free report 0x7f1c8c021360 and cond 0x7f1c8c022060
        THREAD(9583):[07:32:21.087850] Client destructor sock=7 report=0x7f1c8c021360 server-reverse=false bidir=false
        ------------------------------------------------------------
        Client connecting to P'�, TCP port 5001
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(9583):[07:32:21.087855] Free packet ring=0x7f1c8c021fc0 producer=0x7f1c98021238 (consumer=0x55a87b7093a0)
        THREAD(8167):[07:32:21.087859] Jobq *FREE* 0x7f1c840c7a20 (0) ((nil))
        THREAD(9583):[07:32:21.087862] Free report hdr=0x7f1c8c021360 reporter thread suspend count=3 packetring=0x7f1c8c021fc0 histo=(nil) frame histo=(nil)
        THREAD(8167):[07:32:21.087864] Free report 0x7f1c840c7a20 (flags = 0)
        ------------------------------------------------------------
        Client connecting to 192.168.1.110, TCP port 5001
        TCP window size: 85.0 KByte (default)
        ------------------------------------------------------------
        THREAD(9583):[07:32:21.087869] Free thread settings=0x7f1c98020f20
        THREAD(8167):[07:32:21.087878] Jobq *FREE* 0x7f1c7c0c7920 (0) (0x7f1c7c021350)
        THREAD(8167):[07:32:21.087883] Free report 0x7f1c7c0c7920 (flags = 0)
        [  6] local 192.168.1.111 port 45084 connected with 192.168.1.110 port 5001 (ct=0.04 ms)
        [  6]  0.0- 4.0 sec  7.96 GBytes  17.1 Gbits/sec
        THREAD(8167):[07:32:21.091946] Jobq *FREE* 0x7f1c7c021350 (1) ((nil))
        THREAD(8167):[07:32:21.091950] Signal producer to free report 0x7f1c7c021350 and cond 0x7f1c7c020fb0
        THREAD(9582):[07:32:21.091956] Traffic thread thinks reporter is done with 0x7f1c7c021350
        THREAD(9582):[07:32:21.091963] Client destructor sock=6 report=0x7f1c7c021350 server-reverse=false bidir=false
        THREAD(9582):[07:32:21.091970] Free packet ring=0x7f1c7c020f10 producer=0x7f1c980219f8 (consumer=0x55a87b7093a0)
        THREAD(9582):[07:32:21.091974] Free report hdr=0x7f1c7c021350 reporter thread suspend count=4 packetring=0x7f1c7c020f10 histo=(nil) frame histo=(nil)
        THREAD(9582):[07:32:21.091979] Free thread settings=0x7f1c980216e0
        THREAD(8167):[07:32:22.092066] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:23.092234] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:24.092404] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:25.092528] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:26.092679] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:27.092848] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:28.093006] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:29.093169] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:30.093336] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:31.093506] Jobq *WAIT* exit  (nil) 
        ^CTHREAD(8167):[07:32:32.093677] Jobq *WAIT* exit  (nil) 
        THREAD(8167):[07:32:32.093727] reporter thread job queue request lock (with 3 second wait)
        THREAD(8167):[07:32:32.093746] reporter thread job queue unlock
        THREAD(8167):[07:32:32.093757] Reporter thread finished
        THREAD(8167):[07:32:32.093776] Free thread settings=0x55a87d3d1200
        tech1@E11:~/Desktop/iperf/dec2/iperf2-code/src$ 
        
         

        Last edit: Chris Preimesberger 2019-12-05
    • Chris Preimesberger

      Answering chronoligically here:

      Can you try your 2.0.14a using --reverse?

      Using the --reverse option on the 2.0.14a 21 November code resulted in limited throughput int he client-to-server direction, and no transfer in the server-to-client direction. Here's a transcript showing my results for "-r" and "--reverse":

      > 
      > tech1@E10:~/Desktop/iperf/iperf2-code$ iperf -c 192.168.1.111 -i1 -r
      > ------------------------------------------------------------
      > Server listening on TCP port 5001
      > TCP window size:  128 KByte (default)
      > ------------------------------------------------------------
      > ------------------------------------------------------------
      > Client connecting to 192.168.1.111, TCP port 5001
      > TCP window size: 85.0 KByte (default)
      > ------------------------------------------------------------
      > [  5] local 192.168.1.110 port 41656 connected with 192.168.1.111 port 5001 (ct=0.27 ms)
      > [ ID] Interval       Transfer     Bandwidth
      > [  5]  0.0- 1.0 sec  6.03 GBytes  51.8 Gbits/sec
      > [  5]  1.0- 2.0 sec  6.28 GBytes  53.9 Gbits/sec
      > [  5]  2.0- 3.0 sec  6.11 GBytes  52.5 Gbits/sec
      > [  5]  3.0- 4.0 sec  5.81 GBytes  49.9 Gbits/sec
      > [  5]  4.0- 5.0 sec  6.02 GBytes  51.7 Gbits/sec
      > [  5]  5.0- 6.0 sec  6.27 GBytes  53.8 Gbits/sec
      > [  5]  6.0- 7.0 sec  6.06 GBytes  52.0 Gbits/sec
      > [  5]  7.0- 8.0 sec  6.27 GBytes  53.9 Gbits/sec
      > [  5]  8.0- 9.0 sec  6.26 GBytes  53.7 Gbits/sec
      > [  5]  9.0-10.0 sec  6.22 GBytes  53.4 Gbits/sec
      > [  5]  0.0-10.0 sec  61.3 GBytes  52.7 Gbits/sec
      > [  4] local 192.168.1.110 port 5001 connected with 192.168.1.111 port 44962
      > [  4]  0.0- 1.0 sec  1.54 GBytes  13.3 Gbits/sec
      > [  4]  1.0- 2.0 sec  1.42 GBytes  12.2 Gbits/sec
      > [  4]  2.0- 3.0 sec  1.46 GBytes  12.6 Gbits/sec
      > [  4]  3.0- 4.0 sec  1.46 GBytes  12.5 Gbits/sec
      > [  4]  4.0- 5.0 sec  1.44 GBytes  12.4 Gbits/sec
      > [  4]  5.0- 6.0 sec  1.45 GBytes  12.4 Gbits/sec
      > [  4]  6.0- 7.0 sec  1.50 GBytes  12.9 Gbits/sec
      > [  4]  7.0- 8.0 sec  1.54 GBytes  13.3 Gbits/sec
      > [  4]  8.0- 9.0 sec  1.51 GBytes  13.0 Gbits/sec
      > [  4]  9.0-10.0 sec  1.58 GBytes  13.6 Gbits/sec
      > [  4] 10.0-10.0 sec  7.14 MBytes  5.51 Gbits/sec
      > [  4]  0.0-10.0 sec  14.9 GBytes  12.8 Gbits/sec
      > WARN: Reporter thread may be too slow, await counter=1884, consider increasing NUM_REPORT_STRUCTS
      > tech1@E10:~/Desktop/iperf/iperf2-code$ iperf -c 192.168.1.111 -i1 --reverse
      > ------------------------------------------------------------
      > Client connecting to 192.168.1.111, TCP port 5001
      > TCP window size: 85.0 KByte (default)
      > ------------------------------------------------------------
      > [  3] local 192.168.1.110 port 41658 connected with 192.168.1.111 port 5001 (ct=0.29 ms)
      > [  3] local 192.168.1.110 port 41658 connected with 192.168.1.111 port 5001 (reverse)
      > [ ID] Interval       Transfer     Bandwidth
      > [  3]  0.0- 1.0 sec   112 MBytes   943 Mbits/sec
      > [  3]  1.0- 2.0 sec   112 MBytes   944 Mbits/sec
      > [  3]  2.0- 3.0 sec   112 MBytes   943 Mbits/sec
      > [  3]  3.0- 4.0 sec   112 MBytes   944 Mbits/sec
      > [  3]  4.0- 5.0 sec   112 MBytes   943 Mbits/sec
      > [  3]  5.0- 6.0 sec   112 MBytes   944 Mbits/sec
      > [  3]  6.0- 7.0 sec   112 MBytes   944 Mbits/sec
      > [  3]  7.0- 8.0 sec   112 MBytes   943 Mbits/sec
      > [  3]  8.0- 9.0 sec   112 MBytes   944 Mbits/sec
      > [  3]  9.0-10.0 sec   112 MBytes   943 Mbits/sec
      > [  3] 10.0-10.0 sec   256 KBytes  1.54 Gbits/sec
      > [  3]  0.0-10.0 sec  1.10 GBytes   943 Mbits/sec
      > tech1@E10:~/Desktop/iperf/iperf2-code$ iperf -c 192.168.1.111 -i1 --reverse -P4
      > ------------------------------------------------------------
      > Client connecting to 192.168.1.111, TCP port 5001
      > TCP window size: 85.0 KByte (default)
      > ------------------------------------------------------------
      > [  5] local 192.168.1.110 port 41664 connected with 192.168.1.111 port 5001 (ct=0.19 ms)
      > [  3] local 192.168.1.110 port 41660 connected with 192.168.1.111 port 5001 (ct=0.26 ms)
      > [  4] local 192.168.1.110 port 41662 connected with 192.168.1.111 port 5001 (ct=0.24 ms)
      > [  7] local 192.168.1.110 port 41666 connected with 192.168.1.111 port 5001 (ct=0.21 ms)
      > [  3] local 192.168.1.110 port 41660 connected with 192.168.1.111 port 5001 (reverse)
      > [  4] local 192.168.1.110 port 41662 connected with 192.168.1.111 port 5001 (reverse)
      > [  5] local 192.168.1.110 port 41664 connected with 192.168.1.111 port 5001 (reverse)
      > [  7] local 192.168.1.110 port 41666 connected with 192.168.1.111 port 5001 (reverse)
      > [ ID] Interval       Transfer     Bandwidth
      > [  3]  0.0- 1.0 sec   112 MBytes   943 Mbits/sec
      > [  4]  0.0- 1.0 sec   112 MBytes   943 Mbits/sec
      > [  5]  0.0- 1.0 sec   112 MBytes   943 Mbits/sec
      > [  7]  0.0- 1.0 sec   112 MBytes   943 Mbits/sec
      > [SUM]  0.0- 1.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  1.0- 2.0 sec   112 MBytes   944 Mbits/sec
      > [  4]  1.0- 2.0 sec   112 MBytes   944 Mbits/sec
      > [  5]  1.0- 2.0 sec   112 MBytes   944 Mbits/sec
      > [  7]  1.0- 2.0 sec   112 MBytes   944 Mbits/sec
      > [SUM]  1.0- 2.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  2.0- 3.0 sec   112 MBytes   943 Mbits/sec
      > [  4]  2.0- 3.0 sec   112 MBytes   943 Mbits/sec
      > [  5]  2.0- 3.0 sec   112 MBytes   943 Mbits/sec
      > [  7]  2.0- 3.0 sec   112 MBytes   943 Mbits/sec
      > [SUM]  2.0- 3.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  3.0- 4.0 sec   112 MBytes   944 Mbits/sec
      > [  4]  3.0- 4.0 sec   112 MBytes   944 Mbits/sec
      > [  5]  3.0- 4.0 sec   112 MBytes   944 Mbits/sec
      > [  7]  3.0- 4.0 sec   112 MBytes   944 Mbits/sec
      > [SUM]  3.0- 4.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  4.0- 5.0 sec   112 MBytes   943 Mbits/sec
      > [  4]  4.0- 5.0 sec   112 MBytes   944 Mbits/sec
      > [  5]  4.0- 5.0 sec   112 MBytes   943 Mbits/sec
      > [  7]  4.0- 5.0 sec   112 MBytes   944 Mbits/sec
      > [SUM]  4.0- 5.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  5.0- 6.0 sec   112 MBytes   944 Mbits/sec
      > [  4]  5.0- 6.0 sec   112 MBytes   943 Mbits/sec
      > [  5]  5.0- 6.0 sec   112 MBytes   944 Mbits/sec
      > [  7]  5.0- 6.0 sec   112 MBytes   943 Mbits/sec
      > [SUM]  5.0- 6.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  6.0- 7.0 sec   112 MBytes   944 Mbits/sec
      > [  4]  6.0- 7.0 sec   112 MBytes   944 Mbits/sec
      > [  5]  6.0- 7.0 sec   112 MBytes   944 Mbits/sec
      > [  7]  6.0- 7.0 sec   112 MBytes   944 Mbits/sec
      > [SUM]  6.0- 7.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  7.0- 8.0 sec   112 MBytes   943 Mbits/sec
      > [  4]  7.0- 8.0 sec   112 MBytes   943 Mbits/sec
      > [  5]  7.0- 8.0 sec   112 MBytes   943 Mbits/sec
      > [  7]  7.0- 8.0 sec   112 MBytes   943 Mbits/sec
      > [SUM]  7.0- 8.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  8.0- 9.0 sec   112 MBytes   944 Mbits/sec
      > [  4]  8.0- 9.0 sec   112 MBytes   944 Mbits/sec
      > [  5]  8.0- 9.0 sec   112 MBytes   944 Mbits/sec
      > [  7]  8.0- 9.0 sec   112 MBytes   944 Mbits/sec
      > [SUM]  8.0- 9.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3]  9.0-10.0 sec   112 MBytes   943 Mbits/sec
      > [  4]  9.0-10.0 sec   112 MBytes   943 Mbits/sec
      > [  5]  9.0-10.0 sec   112 MBytes   943 Mbits/sec
      > [  7]  9.0-10.0 sec   112 MBytes   943 Mbits/sec
      > [SUM]  9.0-10.0 sec   450 MBytes  3.77 Gbits/sec
      > [  3] 10.0-10.0 sec   256 KBytes  1.53 Gbits/sec
      > [  3]  0.0-10.0 sec  1.10 GBytes   943 Mbits/sec
      > [  4] 10.0-10.0 sec   256 KBytes  1.73 Gbits/sec
      > [  4]  0.0-10.0 sec  1.10 GBytes   943 Mbits/sec
      > [  7] 10.0-10.0 sec   256 KBytes  1.66 Gbits/sec
      > [  7]  0.0-10.0 sec  1.10 GBytes   943 Mbits/sec
      > [  5] 10.0-10.0 sec   256 KBytes  1.61 Gbits/sec
      > [  5]  0.0-10.0 sec  1.10 GBytes   943 Mbits/sec
      > [SUM]  0.0-10.0 sec  4.39 GBytes  3.77 Gbits/sec
      > tech1@E10:~/Desktop/iperf/iperf2-code$ iperf -v
      > iperf version 2.0.14a (21 Nov 2019) pthreads
      > tech1@E10:~/Desktop/iperf/iperf2-code$ 
      > 
      
       

      Last edit: Chris Preimesberger 2019-12-05
      • Robert McMahon

        Robert McMahon - 2019-12-02

        Thanks Chris, let me dig into this a bit. I really appreciate your help here.

        Bob

         
  • Robert McMahon

    Robert McMahon - 2019-12-01

    FYI, I added a man page entry as well:

    --NUM_REPORT_STRUCTS <count>
         Override  the  default  shared  memory size between the traffic thread(s) and reporter thread in order to mitigate mutex lock contentions. The default value of 5000 should be sufficient for 1Gb/s networks. Increase this upon seeing the WARNing message of reporter thread too slow. If the WARNing message isn't seen, then increasing this won't have any significant effect (other than to use some additional memory.)
    

    Also, -P on the server won't have any significant effect per the traffic. It's a way to have the server die after a traffic test completes. My suggestion is to use -t to kill servers and don't use -P on the server at all.

    Bob

     
  • Chris Preimesberger

    Hi Bob,

    Thank you for all of your holiday weekend work on this. I'm really impressed with the level of support you've been providing, and I'm eager to follow your suggestions. Sadly, I won’t have access to the 100GbE test setup until Monday, so I can't provide any updates until then... In lieu of a true technical update for this ticket, I would like to express gratitude for your years of developing iperf, and let you know that I find your work invaluable. Thank you.

    I’ll be sure to provide updates when I can.

    Chris

     
  • Chris Preimesberger

    I started wondering if there's a way I could provide useful feedback from home, without real 100GbE interfaces to play on, and I thought of an alternative of just running variants of these commands on the same machine to get very high (100Gb+) throughput:
    iperf -s
    iperf -c localhost

    Would this be a valid/useful way to test your changes until I can get back in the office?

    I've compiled 2.0.14a, both with and without "./configure --enable-thread-debug", and for some reason I would consistently get a segmentation fault on the server instance upon the 2nd time my client connected to it (please see attached transcrits from the client and server). going back to iperf v2.0.10 from my distro resolved the seg-faults.

     
  • Robert McMahon

    Robert McMahon - 2019-12-04

    Just an update, I've gotten a few 100G systems and am actively working on this. Please be patient.

    Bob

     
    👍
    1
    • Robert McMahon

      Robert McMahon - 2019-12-05

      Ok, I think I have a working version as of 12/3. I may do some more tuning after more testing.

      Bob

       
  • Chris Preimesberger

    Nice!! I'm now getting wire-speed in both directions every time with the -r option.

    tech1@E11:~/Desktop/iperf/iperf2-code/src$ ./iperf -v
    iperf version 2.0.14a (3 Dec 2019) pthreads
    tech1@E11:~/Desktop/iperf/iperf2-code/src$ 
    tech1@E11:~/Desktop/iperf/iperf2-code/src$ 
    tech1@E11:~/Desktop/iperf/iperf2-code/src$ ./iperf -c 192.168.1.110 -r -P3
    ------------------------------------------------------------
    Server listening on TCP port 5001
    TCP window size:  128 KByte (default)
    ------------------------------------------------------------
    [  5] local 192.168.1.111 port 60216 connected with 192.168.1.110 port 5001 (ct=0.21 ms)
    ------------------------------------------------------------
    Client connecting to 192.168.1.110, TCP port 5001
    TCP window size: 85.0 KByte (default)
    ------------------------------------------------------------
    [  7] local 192.168.1.111 port 60218 connected with 192.168.1.110 port 5001 (ct=0.19 ms)
    [  6] local 192.168.1.111 port 60214 connected with 192.168.1.110 port 5001 (ct=0.28 ms)
    [ ID] Interval       Transfer     Bandwidth
    [  5]  0.0-10.0 sec  36.5 GBytes  31.4 Gbits/sec
    [  7]  0.0-10.0 sec  36.5 GBytes  31.4 Gbits/sec
    [  6]  0.0-10.0 sec  36.5 GBytes  31.4 Gbits/sec
    [SUM]  0.0-10.0 sec   110 GBytes  94.1 Gbits/sec
    [  4] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 47628
    [  5] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 47630
    [  6] local 192.168.1.111 port 5001 connected with 192.168.1.110 port 47632
    [  6]  0.0-10.0 sec  36.6 GBytes  31.4 Gbits/sec
    [  4]  0.0-10.0 sec  36.6 GBytes  31.4 Gbits/sec
    [  5]  0.0-10.0 sec  36.3 GBytes  31.2 Gbits/sec
    [SUM]  0.0-10.0 sec   110 GBytes  94.1 Gbits/sec
    tech1@E11:~/Desktop/iperf/iperf2-code/src$ 
    
     
    • Robert McMahon

      Robert McMahon - 2019-12-05

      Thanks for finding and posting this. Please co let me know if you run into anymore issues.

      Bob

       
  • Chris Preimesberger

    Thank you for the fast fix. I'm content with closing this ticket as resolved.

     
    • Robert McMahon

      Robert McMahon - 2019-12-06

      Thank you for reporting it. I'll close the ticket. Please do file new ones when you find something that seems to be working incorrectly. This feedback helps all who rely on these tools.

      Bob

       
  • Robert McMahon

    Robert McMahon - 2019-12-06
    • status: open --> closed
     

Log in to post a comment.

MongoDB Logo MongoDB