ndt-users list created

[Chris Welti <>]

Hi Rich,

After removing the "-i eth0" option the test completes without error. Thanks 
for the tip! :)
Now, if only IPv6 would work....

I always get protocol errors on the client side when I don't use the "--ipv4" 
option on the server.
It seems the java client tries to connect via IPv4 (why it doesn't try IPv6 
is beyond me, as under options "prefer IPv6" is selected) and the server runs 
ONLY on ipv6. Shouldn't it listen on both IPv4 and IPv6 when no option is 
set? Or is there no dual mode and I need to start web100 servers for both 
IPv4 and IPv6?

Using web100clt to debug this issue:

welti@ezmp3:~$
 web100clt -n lsmp2 -p 3001
Testing network path for configuration and performance problems  --  Using 
IPv6 address
Checking for Middleboxes . . . . . . . . . . . . . . . . . .  Done
checking for firewalls . . . . . . . . . . . . . . . . . . .  Done
running 10s outbound test (client to server) . . . . .  967.11 Mb/s
running 10s inbound test (server to client) . . . . . . 985.42 Mb/s
Your host is connected to a Cable/DSL modem
Server 'lsmp2' is not behind a firewall. [Connection to the ephemeral port 
was successful]
Client is not behind a firewall. [Connection to the ephemeral port was 
successful]
Packet size is preserved End-to-End
Server IP addresses are preserved End-to-End
Client IP addresses are preserved End-to-End

welti@ezmp3:~$
 web100clt -n lsmp2 -p 3001 -4
Testing network path for configuration and performance problems  --  Using 
IPv4 address
Checking for Middleboxes . . . . . . . . . . . . . . . . . .  Protocol error!
Middlebox test FAILED!
checking for firewalls . . . . . . . . . . . . . . . . . . .  Protocol error!
Simple firewall test FAILED!
Protocol error!
C2S throughput test FAILED!
Protocol error!
S2C throughput test FAILED!
Protocol error!

Also, server side debug for an incoming IPv4 connection when NOT running in 
explicit IPv4 mode:
: 
root@lsmp2[welti];
 /usr/local/sbin/web100srv -a -dddddddd
ANL/Internet2 NDT ver 3.5.6
        Variables file = /usr/local/ndt/web100_variables
        log file = /usr/local/ndt/web100srv.log
        Admin file = /usr/local/ndt/admin.html
        Debug level set to 8

Send buffer initialized to 4194304, Receive buffer initialized to 174760
server ready on port 3001
web100_init() read 69 variables from file
Web100 variables line received

Initial counter Values Totalcnt = 0, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 1, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 1, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 2, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 2, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 3, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [3, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 3, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 4, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [3, 0, 0, 0, 0, 0, 1, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 4, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 5, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [3, 0, 0, 0, 0, 0, 2, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 5, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 6, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [3, 0, 0, 0, 0, 0, 3, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 6, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 7, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [4, 0, 0, 0, 0, 0, 3, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 7, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 8, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [4, 0, 0, 0, 0, 0, 4, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 8, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 9, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [4, 0, 0, 0, 0, 0, 5, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 9, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 10, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [5, 0, 0, 0, 0, 0, 5, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 10, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 11, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [6, 0, 0, 0, 0, 0, 5, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 11, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 12, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [7, 0, 0, 0, 0, 0, 5, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 12, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 13, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [7, 0, 0, 0, 0, 0, 6, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 13, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 14, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [7, 0, 0, 0, 0, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 14, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 15, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [8, 0, 0, 0, 0, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 15, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 16, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [9, 0, 0, 0, 0, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 16, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 17, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [10, 0, 0, 0, 0, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 17, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 18, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [11, 0, 0, 0, 0, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 18, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 19, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [12, 0, 0, 0, 0, 0, 7, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 19, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 20, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [12, 0, 0, 0, 0, 0, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 20, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 21, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [12, 0, 1, 0, 0, 0, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 21, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 22, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [12, 0, 1, 0, 0, 1, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 22, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 23, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [12, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 23, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 24, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [13, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 24, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 25, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [14, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 25, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 26, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [15, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 26, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 27, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [16, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 27, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 28, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [17, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 28, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 29, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [18, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 29, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 30, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [19, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 30, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 31, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [20, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 31, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 32, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [21, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 32, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 33, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [22, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 33, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 34, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [23, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 34, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 35, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [24, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 35, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 36, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [25, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 36, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 37, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [26, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 37, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 38, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [27, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 38, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 39, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [28, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 39, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 40, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [29, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 40, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 41, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [30, 0, 1, 0, 0, 2, 8, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 41, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 42, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [30, 0, 1, 0, 0, 2, 9, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 42, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 43, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [31, 0, 1, 0, 0, 2, 9, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 43, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 44, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [31, 0, 1, 0, 0, 2, 10, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 44, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 45, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [31, 0, 1, 0, 0, 2, 11, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Web100 variables line received

Initial counter Values Totalcnt = 45, Total Mismatch = 0, Total Bad Cables = 0
Updated counter values Totalcnt = 46, Total Mismatch = 0, Total Bad Cables = 0
Individual counts = [31, 1, 1, 0, 0, 2, 11, 0, 0, 0, 0, 0, 0, 0, 0, 0]
Signal 17 received by process 25367
successfully locked '/tmp/view.string' for updating
sending '985417,0,972950,36,46,0,0,31,1,1,0,0,2,11,0,0,0,0,0,0,0,0,0,Sep 11 
11:39:20,Sep  1 15:32:35' to tmp file
Generated iflist with device=eth0 and if_speed=7
Generated iflist with device=eth1 and if_speed=7
nothing in queue
Timer not running, waiting for new connection
New connection received, waiting for accept() to complete
New connection received from [130.59.4.118].
Child thinks pipe() returned fd0=7, fd1=8 for pid=0
Parent process spawned child = 25370
Parent thinks pipe() returned fd0=7, fd1=8
<<< recv_msg: type=2, len=1
initialize_tests returned old/new client = 1, test_suite = 
Incrementing waiting variable now = 1
Telling client 25370 testing will begin now
>>> send_msg: type=1, len=1
Got 'go' signal from parent, ready to start testing
extracting test_suite ' ' and t_opts '10' from buff 'go 16 '
Child process 25370 started
>>> send_msg: type=2, len=6
run_test() routine, asking for test_suite =  
>>> send_msg: type=2, len=1
Starting test suite:
Finished testing C2S = 0.00 Mbps, S2C = 0.00 Mbps
CWND limited test = 0.00 while unlimited = 0.00
Better throughput when CWND is limited, may be duplex mismatch
>>> send_msg: type=8, len=42
>>> send_msg: type=8, len=73
>>> send_msg: type=8, len=69
>>> send_msg: type=8, len=68
>>> send_msg: type=8, len=68
>>> send_msg: type=8, len=46
>>> send_msg: type=9, len=0
Signal 11 received by process 25370
DEBUG, caught SIGSEGV signal and terminated process (25370)
Signal 17 received by process 25367
Queue pointer = 25370, testing = 1, waiting = 1, zombie_check = 0
Received SIGCHLD signal for active web100srv process [25367]
wait3() returned 0 for PID=25370
wexitstatus = '0'
Attempting to clean up child 25370, head pid = 25370
Child process 25370 causing head pointer modification
Removing Child from head, decrementing waiting now = 0
Timer not running, waiting for new connection

Regards,
Chris


Richard Carlson wrote:
> Hi Chris & Christoph;
> 
> Sorry I was unavailable yesterday. 
> 
> I'm still not sure what is going on here.  According to the logs the
> pkt-pair child successfully collects the data and then it generates a
> SIGSEGV signal (reference an invalid memory location).  This causes the
> child process to die, and in the s2c case, the server is still
> communicating with the client so we don't complete things properly.  
> 
> I'll try updating my copy of the libpcap package to see if that has any
> effect.  The only other suggestions I can make are:
> 
> The last command in the src/web100-pcap.c file has a log message at
> debug level 8.  Please either run the server with this debug level or
> change the code to make this a lower debug level (change the 8 to a 5)
> and run with that debug level.  This should tell me if the error is
> between that comment and the previous one.
> 
> Chris - I noticed that you added the -i eth0 option to the command line.
>  One of the changes to this code is to allow the server to automatically
> determine which interface the client connected to.  If you remove this
> -i option you should collect pkt-pair data.
> 
> Rich
> 
> On Sep 2, 2009, at 10:21 AM, Galuschka Christoph wrote:
> 
>> Here you go:
>>>>
>> linux-72yn:/usr/src/ndt-3.5.6 # /usr/local/sbin/web100srv -dddddd
>> ANL/Internet2 NDT ver 3.5.6
>>        Variables file = /usr/local/ndt/web100_variables
>>        log file = /usr/local/ndt/web100srv.log
>>        Debug level set to 6
>>
>> Send buffer initialized to 16384, Receive buffer initialized to 87380
>> server ready on port 3001
>> web100_init() read 69 variables from file
>> nothing in queue
>> Timer not running, waiting for new connection
>> New connection received, waiting for accept() to complete
>> New connection received from [10.110.109.104].
>> Parent process spawned child = 2035
>> Parent thinks pipe() returned fd0=8, fd1=9Child thinks pipe() returned
>> fd0=8, fd1=9 for pid=0
>>
>> <<< recv_msg: type=2, len=1
>> initialize_tests returned old/new client = 1, test_suite = 1 8 2
>> Incrementing waiting variable now = 1
>> Telling client 2035 testing will begin now
>>>>> send_msg: type=1, len=1
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> Got 'go' signal from parent, ready to start testing
>> extracting test_suite ' 1 8 2' and t_opts '1b' from buff 'go 27 1 8 2'
>> Child process 2035 started
>>>>> send_msg: type=2, len=6
>> run_test() routine, asking for test_suite =  1 8 2
>>>>> send_msg: type=2, len=6
>> Starting test suite:
>>> Middlebox test
>>> Simple firewall test
>>> C2S throughput test
>> <-- Middlebox test -->
>> KillHung(): returned non-0 response, nothing to kill or kill failed
>>
>> Send buffer initialized to 16384, Receive buffer initialized to 87380
>>  -- port: 3003
>>>>> send_msg: type=3, len=4
>> Looking for Web100 data on socketid 8
>> Server: 10.11.215.13;3003 Client: 10.110.109.104;4982 1456;6;6;
>> Sending 1456 Byte packets over the network
>> Setting Cwnd Limit to 2912 octets
>> Signal 17 received by process 2035
>> now = 1251904626 Process started at 1251904623, run time = 3
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>>>>> send_msg: type=5, len=37
>> now = 1251904629 Process started at 1251904623, run time = 6
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> now = 1251904632 Process started at 1251904623, run time = 9
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> now = 1251904635 Process started at 1251904623, run time = 12
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> <<< recv_msg: type=5, len=18
>> CWND limited throughput = 15737 kbps (15737.052192066805)
>>>>> send_msg: type=6, len=0
>> <-------------------->
>> <-- Simple firewall test -->
>>
>> Send buffer initialized to 16384, Receive buffer initialized to 87380
>>  -- port: 51503
>>  -- time: 1
>>>>> send_msg: type=3, len=7
>> <<< recv_msg: type=5, len=4
>>  -- oport: 4984
>>>>> send_msg: type=4, len=0
>>
>> Send buffer initialized to 16384, Receive buffer initialized to 87380
>>>>> send_msg: type=5, len=20
>> <<< recv_msg: type=5, len=20
>>>>> send_msg: type=5, len=1
>>>>> send_msg: type=6, len=0
>> <-------------------------->
>> <-- C2S throughput test -->
>>
>> Send buffer initialized to 16384, Receive buffer initialized to 87380
>>  -- port: 3002
>> listening for Inet connection on testOptions->c2ssockfd, fd=3
>> Sending 'GO' signal, to tell client to head for the next test
>>>>> send_msg: type=3, len=4
>> C2S test Child thinks pipe() returned fd0=10, fd1=11
>> Unknown address family=17 found
>> Unknown address family=17 found
>> IPv4 interface found address=10.11.215.13
>> IPv4 address match, setting device to 'eth2'
>> Opening network interface 'eth2' for packet-pair timing
>> pcap_open_live() returned pointer 0x80889d8
>> installing pkt filter for 'host 10.110.109.104 and port 4986'
>> Initial pkt src data = 806b5c4
>> C2S test Parent thinks pipe() returned fd0=10, fd1=11
>> now = 1251904638 Process started at 1251904623, run time = 15
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>>>>> send_msg: type=4, len=0
>> New IPv4 packet trace started -- initializing counters
>> now = 1251904641 Process started at 1251904623, run time = 18
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> now = 1251904644 Process started at 1251904623, run time = 21
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> now = 1251904647 Process started at 1251904623, run time = 24
>> Timer expired while waiting for a new connection
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Waiting for new connection, timer running
>> 702209 kbps outbound
>>>>> send_msg: type=5, len=6
>> Signal USR1(10) sent to child [2038]
>> Signal 10 received by process 2038
>> DEBUG, caught SIGUSR1, setting sig1 flag to force exit
>> Received SIGUSRx signal terminating data collection loop for pid=2038
>> Sending pkt-pair data back to parent on pipe 10, 11
>> fwd.saddr = 686d6e0a:4986, rev.saddr = dd70b0a:3002
>> 09:17:19.933771   10.110.109.104:4986 --> 10.11.215.13:3002 Collected
>> pkt-pair data max = 343617
>> wrote 128 bytes: link counters are '  1 0 2 17 5143 4107 115602 1250
>> 132855 343617 1 1 256.73 0 0 0 1 0 7'
>> #$#$#$#$ pcap routine says window increases = 0, decreases = 0, no
>> change = 0
>> 09:17:19.933771   10.11.215.13:3002 --> 10.110.109.104:4986 Collected
>> pkt-pair data max = 95356
>> wrote 128 bytes: link counters are '  0 0 2 2 78 880 24922 95356 5809
>> 14311 2 0 876.74 935 47 140380 0 1 7'
>> #$#$#$#$ pcap routine says window increases = 935, decreases = 47, no
>> change = 140380
>> 128 bytes read '  1 0 2 17 5143 4107 115602 1250 132855 343617 1 1
>> 256.73 0 0 0 1 0 7' from monitor pipe
>> 128 bytes read '  0 0 2 2 78 880 24922 95356 5809 14311 2 0 876.74 935
>> 47 140380 0 1 7' from monitor pipe
>>>>> send_msg: type=6, len=0
>> Finished reading pkt-pair data from network, process 2038 should
>> terminate now
>> Signal 11 received by process 2038
>> DEBUG, caught SIGSEGV signal and terminated process (2038)
>> Signal 17 received by process 2035
>> <------------------------->
>> Finished testing C2S = 702.21 Mbps, S2C = -0.00 Mbps
>> Client --> Server data detects link = OC-12
>> Client <-- Server Ack's detect link = Gigabit Ethernet
>> CWND limited test = 15737.05 while unlimited = -0.02
>> Better throughput when CWND is limited, may be duplex mismatch
>>>>> send_msg: type=8, len=42
>>>>> send_msg: type=8, len=73
>>>>> send_msg: type=8, len=69
>>>>> send_msg: type=8, len=68
>>>>> send_msg: type=8, len=72
>>>>> send_msg: type=8, len=46
>>>>> send_msg: type=9, len=0
>> Opened
>> '/usr/local/ndt/serverdata/2009/09/02/20090902T15:17:03.603531000Z_10.110.109.104:4981.meta'
>> metadata log file
>> Successfully returned from run_test() routine
>> Signal 17 received by process 2034
>> now = 1251904649 Process started at 1251904623, run time = 26
>> Select exited with rc = -1
>> Queue pointer = 2035, testing = 1, waiting = 1, zombie_check = 0
>> Received SIGCHLD signal for active web100srv process [2034]
>> wait3() returned 0 for PID=2035
>> wexitstatus = '0'
>> Attempting to clean up child 2035, head pid = 2035
>> Child process 2035 causing head pointer modification
>> Removing Child from head, decrementing waiting now = 0
>> Timer not running, waiting for new connection
>>>>
>>
>> Regards
>> Christoph
>>
>> ------------------------------------------------
>> Ing. Christoph Galuschka
>>
>> TIWAG-Tiroler Wasserkraft AG
>> Bereich IT/Betrieb und Services
>> Eduard-Wallnöfer-Platz 2
>> 6010 Innsbruck
>> T: +43 (0)50607 21832
>> F: +43 (0)50607 41832
>> www.tiroler-wasserkraft.at <http://www.tiroler-wasserkraft.at>
>> ------------------------------------------------
>> Firmenbuchgericht Innsbruck, FN 44133b
>> Sitz der Gesellschaft: Innsbruck
>> DVR: 0164089
>>
>>
>> -----Ursprüngliche Nachricht-----
>> Von: Richard Carlson 
>> [mailto:]
>> Gesendet: Mittwoch, 02. September 2009 17:01
>> An: Chris Welti
>> Cc: Galuschka Christoph; 
>> 
>> Betreff: Re: Error running web100 3.5.0
>>
>> Hi Chris;
>>
>> Drat.  OK, please run the server in debug mode level 6 (-dddddd) and  
>> send me that output.  That may tell me something.
>>
>> Rich
>>
>> On Sep 2, 2009, at 9:00 AM, Chris Welti wrote:
>>
>>>>
>>>
>>
>> Richard Carlson
>> 
>> 1000 Oakbrook Dr
>> Ann Arbor, MI  48104
>>
>> P: 734-352-7043
>> C: 630-251-4572
>>
> 
> Richard Carlson
> 
>  
> <mailto:>
> 1000 Oakbrook Dr
> Ann Arbor, MI  48104
> 
> P: 734-352-7043
> C: 630-251-4572
>