entering main() The number of msgs sent is set to 10 msgSize is set to 1000 Lower bound of probing bandwidth is set to 1000 Upper bound of probing bandwidth is set to 1e+06 HostName=128.236.1.7 entering setupICMPacket() entering a2sockaddr() entering printsockaddr() sockaddr_in: Domain=2, Hostname=mercury.usafa.af.mil, Port=0, Address=128.236.1.7, entering timesubbwrangeInit() bwrUpperBound=1e+06, bwrLowerBound=1000 bwr.upperBound=1e+06, bwr.lowerBound=1000 entering sendProbingMsg() entering setupNextIteration() sendingTime[1]=0.010000 msgSize=1000 bytes !! setup iteration 0, bwr.lb=1000.000000, bwr.ub=1000000.000000 eqTgap: sendingTime[2]=0.081429, sendingTimeGap[1]=71.428571, bandwidth[1]=112000.000000 eqTgap: sendingTime[3]=0.117303, sendingTimeGap[2]=35.874439, bandwidth[2]=223000.000000 eqTgap: sendingTime[4]=0.141255, sendingTimeGap[3]=23.952096, bandwidth[3]=334000.000000 eqTgap: sendingTime[5]=0.159233, sendingTimeGap[4]=17.977528, bandwidth[4]=445000.000000 eqTgap: sendingTime[6]=0.173621, sendingTimeGap[5]=14.388489, bandwidth[5]=556000.000000 eqTgap: sendingTime[7]=0.185615, sendingTimeGap[6]=11.994003, bandwidth[6]=667000.000000 eqTgap: sendingTime[8]=0.195898, sendingTimeGap[7]=10.282776, bandwidth[7]=778000.000000 eqTgap: sendingTime[9]=0.204897, sendingTimeGap[8]=8.998875, bandwidth[8]=889000.000000 eqTgap: sendingTime[10]=0.212897, sendingTimeGap[9]=8.000000, bandwidth[9]=1000000.000000 entering waitRelativeTime() sendProbingMsg: i=1, time=10000 entering sendMsg() sendMsg(): ready to send icmp msg reqID=1, this_time=10000 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=1, this_time=10000 entering waitRelativeTime() sendProbingMsg: i=2, time=81428 entering sendMsg() sendMsg(): ready to send icmp msg reqID=2, this_time=81428 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=2, this_time=81428 entering waitRelativeTime() sendProbingMsg: i=3, time=117303 entering sendMsg() sendMsg(): ready to send icmp msg reqID=3, this_time=117303 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=3, this_time=117303 entering waitRelativeTime() sendProbingMsg: i=4, time=141255 entering sendMsg() sendMsg(): ready to send icmp msg reqID=4, this_time=141255 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=4, this_time=141255 entering waitRelativeTime() sendProbingMsg: i=5, time=159232 entering sendMsg() sendMsg(): ready to send icmp msg reqID=5, this_time=159232 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=5, this_time=159232 entering waitRelativeTime() sendProbingMsg: i=6, time=173621 entering sendMsg() sendMsg(): ready to send icmp msg reqID=6, this_time=173621 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=6, this_time=173621 entering waitRelativeTime() sendProbingMsg: i=7, time=185615 entering sendMsg() sendMsg(): ready to send icmp msg reqID=7, this_time=185615 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=7, this_time=185615 entering waitRelativeTime() sendProbingMsg: i=8, time=195897 entering sendMsg() sendMsg(): ready to send icmp msg reqID=8, this_time=195897 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=8, this_time=195897 entering waitRelativeTime() sendProbingMsg: i=9, time=204896 entering sendMsg() sendMsg(): ready to send icmp msg reqID=9, this_time=204896 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=9, this_time=204896 entering waitRelativeTime() sendProbingMsg: i=10, time=212896 entering sendMsg() sendMsg(): ready to send icmp msg reqID=10, this_time=212896 entering send_icmp() entering tvsub() entering in_cksum() sendMsg(): icmp msg sent, reqID=10, this_time=212896 wait 10000usec, diff=73447usec, sTime=0.010000, stv=1007750431.816379 wait 71428usec, diff=34100usec, sTime=0.081429, stv=1007750431.889826 wait 35874usec, diff=24798usec, sTime=0.117303, stv=1007750431.923926 wait 23952usec, diff=18602usec, sTime=0.141255, stv=1007750431.948724 wait 17977usec, diff=12674usec, sTime=0.159233, stv=1007750431.967326 wait 14388usec, diff=12144usec, sTime=0.173621, stv=1007750431.980000 wait 11994usec, diff=10131usec, sTime=0.185615, stv=1007750431.992144 wait 10282usec, diff=8999usec, sTime=0.195898, stv=1007750432.2275 wait 8998usec, diff=8953usec, sTime=0.204897, stv=1007750432.11274 sendProbingMsg() entering departPackets() departPackets(): starttv=1007750431.806379 depart[1]=10057, stv[1]=1007750431.816379 depart[2]=83472, stv[2]=1007750431.889826 depart[3]=117572, stv[3]=1007750431.923926 depart[4]=142367, stv[4]=1007750431.948724 depart[5]=160968, stv[5]=1007750431.967326 depart[6]=173641, stv[6]=1007750431.980000 depart[7]=185786, stv[7]=1007750431.992144 depart[8]=195915, stv[8]=1007750432.2275 depart[9]=204913, stv[9]=1007750432.11274 depart[10]=213868, stv[10]=1007750432.20227 Actual depart time gap[1]=73415, sendingTimeGap[1]=73.447108 Actual depart time gap[2]=34100, sendingTimeGap[2]=34.099936 Actual depart time gap[3]=24795, sendingTimeGap[3]=24.798036 Actual depart time gap[4]=18601, sendingTimeGap[4]=18.602014 Actual depart time gap[5]=12673, sendingTimeGap[5]=12.673974 Actual depart time gap[6]=12145, sendingTimeGap[6]=12.143970 Actual depart time gap[7]=10129, sendingTimeGap[7]=10.131001 Actual depart time gap[8]=8998, sendingTimeGap[8]=8.998990 Actual depart time gap[9]=8955, sendingTimeGap[9]=8.952975 entering findinfo entering main() The number of msgs sent is set to 10 msgSize is set to 1000 Lower bound of probing bandwidth is set to 1000 Upper bound of probing bandwidth is set to 1e+06 HostName=128.236.1.7 entering setupICMPacket() entering a2sockaddr() entering printsockaddr() sockaddr_in: Domain=2, Hostname=mercury.usafa.af.mil, Port=0, Address=128.236.1.7, entering timesubbwrangeInit() bwrUpperBound=1e+06, bwrLowerBound=1000 bwr.upperBound=1e+06, bwr.lowerBound=1000 entering receivingProbingMsg() entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=31449, icmp_seq=1, icmp_id=5251, time=522067228 1.packet_id=1, n=2, recv_time=0, n_outstanding=9 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=23568, icmp_seq=2, icmp_id=5251, time=522067228 2.packet_id=2, n=3, recv_time=0, n_outstanding=8 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=55002, icmp_seq=3, icmp_id=5251, time=522067228 3.packet_id=3, n=4, recv_time=0, n_outstanding=7 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=30206, icmp_seq=4, icmp_id=5251, time=522067228 4.packet_id=4, n=5, recv_time=0, n_outstanding=6 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=11604, icmp_seq=5, icmp_id=5251, time=522067228 5.packet_id=5, n=6, recv_time=0, n_outstanding=5 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=64465, icmp_seq=6, icmp_id=5251, time=522067228 6.packet_id=6, n=7, recv_time=0, n_outstanding=4 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=52319, icmp_seq=7, icmp_id=5251, time=522067228 7.packet_id=7, n=8, recv_time=0, n_outstanding=3 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=42189, icmp_seq=8, icmp_id=5251, time=522067228 8.packet_id=8, n=9, recv_time=0, n_outstanding=2 entering recv_icmp() entering pr_addr() 1008 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=33190, icmp_seq=9, icmp_id=5251, time=522067228 9.packet_id=9, n=10, recv_time=0, n_outstanding=1 entering recv_icmp() entering pr_addr() 8 bytes (not including ip header 60 bytes) from mercury.usafa.af.mil (128.236.1.7): msg received in hexadecimal: entering print_ip_msg() entering print_icmp_msg() icmp msg content: icmp_type=0, icmp_code=0, icmp_cksum=60274, icmp_seq=10, icmp_id=5251, time=0 10.packet_id=10, n=11, recv_time=0, n_outstanding=0 entering packetAnalysis() entering findinfo packetAnalysis(): starttv=1007750431.806379 sendingTime[1]=1007750431.816379, receivingTime[1]=1007750431.862374 sendingTime[2]=1007750431.889826, receivingTime[2]=1007750431.896113 sendingTime[3]=1007750431.923926, receivingTime[3]=1007750431.930852 sendingTime[4]=1007750431.948724, receivingTime[4]=1007750431.955004 sendingTime[5]=1007750431.967326, receivingTime[5]=1007750431.973602 sendingTime[6]=1007750431.980000, receivingTime[6]=1007750431.986002 sendingTime[7]=1007750431.992144, receivingTime[7]=1007750431.998401 sendingTime[8]=1007750432.002275, receivingTime[8]=1007750432.007702 sendingTime[9]=1007750432.011274, receivingTime[9]=1007750432.017001 sendingTime[10]=1007750432.020227, receivingTime[10]=1007750432.023585 sendingTimeGap[1]=0.073447, receivingTimeGap[1]=0.033739 sendingTimeGap[2]=0.034100, receivingTimeGap[2]=0.034739 sendingTimeGap[3]=0.024798, receivingTimeGap[3]=0.024152 sendingTimeGap[4]=0.018602, receivingTimeGap[4]=0.018598 sendingTimeGap[5]=0.012674, receivingTimeGap[5]=0.012400 sendingTimeGap[6]=0.012144, receivingTimeGap[6]=0.012399 sendingTimeGap[7]=0.010131, receivingTimeGap[7]=0.009301 sendingTimeGap[8]=0.008999, receivingTimeGap[8]=0.009299 sendingTimeGap[9]=0.008953, receivingTimeGap[9]=0.006584 entering findBWRange() bandwidthReq[1]=1000.000000 bandwidthReq[2]=108921.919305 bandwidthReq[3]=234604.542547 bandwidthReq[4]=322606.198413 bandwidthReq[5]=430060.969592 bandwidthReq[6]=631214.801020 bandwidthReq[7]=658763.180886 bandwidthReq[8]=789655.398011 bandwidthReq[9]=888988.647353 sendingTime[1]=1007750431.816379, receivingTime[1]=1007750431.862374 sendingTime[2]=1007750431.889826, receivingTime[2]=1007750431.896113 sendingTime[3]=1007750431.923926, receivingTime[3]=1007750431.930852 sendingTime[4]=1007750431.948724, receivingTime[4]=1007750431.955004 sendingTime[5]=1007750431.967326, receivingTime[5]=1007750431.973602 sendingTime[6]=1007750431.980000, receivingTime[6]=1007750431.986002 sendingTime[7]=1007750431.992144, receivingTime[7]=1007750431.998401 sendingTime[8]=1007750432.002275, receivingTime[8]=1007750432.007702 sendingTime[9]=1007750432.011274, receivingTime[9]=1007750432.017001 sendingTime[10]=1007750432.020227, receivingTime[10]=1007750432.023585 i=1, absRcvTimeGap[1]=0.000000, absSendTimeGap[1]=0.000000, absGapDifference[1]=0.000000 i=1, absRcvTimeGap[2]=0.033739, absSendTimeGap[2]=0.073447, absGapDifference[2]=-0.039708 i=1, absRcvTimeGap[3]=0.068478, absSendTimeGap[3]=0.107547, absGapDifference[3]=-0.039069 i=1, absRcvTimeGap[4]=0.092630, absSendTimeGap[4]=0.132345, absGapDifference[4]=-0.039715 i=1, absRcvTimeGap[5]=0.111228, absSendTimeGap[5]=0.150947, absGapDifference[5]=-0.039719 i=1, absRcvTimeGap[6]=0.123628, absSendTimeGap[6]=0.163621, absGapDifference[6]=-0.039993 i=1, absRcvTimeGap[7]=0.136027, absSendTimeGap[7]=0.175765, absGapDifference[7]=-0.039738 i=1, absRcvTimeGap[8]=0.145328, absSendTimeGap[8]=0.185896, absGapDifference[8]=-0.040568 i=1, absRcvTimeGap[9]=0.154627, absSendTimeGap[9]=0.194895, absGapDifference[9]=-0.040268 i=2, absRcvTimeGap[1]=-0.033739, absSendTimeGap[1]=-0.073447, absGapDifference[1]=0.039708 i=2, absRcvTimeGap[2]=0.000000, absSendTimeGap[2]=0.000000, absGapDifference[2]=0.000000 i=2, absRcvTimeGap[3]=0.034739, absSendTimeGap[3]=0.034100, absGapDifference[3]=0.000639 i=2, absRcvTimeGap[4]=0.058891, absSendTimeGap[4]=0.058898, absGapDifference[4]=-0.000007 i=2, absRcvTimeGap[5]=0.077489, absSendTimeGap[5]=0.077500, absGapDifference[5]=-0.000011 i=2, absRcvTimeGap[6]=0.089889, absSendTimeGap[6]=0.090174, absGapDifference[6]=-0.000285 i=2, absRcvTimeGap[7]=0.102288, absSendTimeGap[7]=0.102318, absGapDifference[7]=-0.000030 i=2, absRcvTimeGap[8]=0.111589, absSendTimeGap[8]=0.112449, absGapDifference[8]=-0.000860 i=2, absRcvTimeGap[9]=0.120888, absSendTimeGap[9]=0.121448, absGapDifference[9]=-0.000560 i=3, absRcvTimeGap[1]=-0.068478, absSendTimeGap[1]=-0.107547, absGapDifference[1]=0.039069 i=3, absRcvTimeGap[2]=-0.034739, absSendTimeGap[2]=-0.034100, absGapDifference[2]=-0.000639 i=3, absRcvTimeGap[3]=0.000000, absSendTimeGap[3]=0.000000, absGapDifference[3]=0.000000 i=3, absRcvTimeGap[4]=0.024152, absSendTimeGap[4]=0.024798, absGapDifference[4]=-0.000646 i=3, absRcvTimeGap[5]=0.042750, absSendTimeGap[5]=0.043400, absGapDifference[5]=-0.000650 i=3, absRcvTimeGap[6]=0.055150, absSendTimeGap[6]=0.056074, absGapDifference[6]=-0.000924 i=3, absRcvTimeGap[7]=0.067549, absSendTimeGap[7]=0.068218, absGapDifference[7]=-0.000669 i=3, absRcvTimeGap[8]=0.076850, absSendTimeGap[8]=0.078349, absGapDifference[8]=-0.001499 i=3, absRcvTimeGap[9]=0.086149, absSendTimeGap[9]=0.087348, absGapDifference[9]=-0.001199 i=4, absRcvTimeGap[1]=-0.092630, absSendTimeGap[1]=-0.132345, absGapDifference[1]=0.039715 i=4, absRcvTimeGap[2]=-0.058891, absSendTimeGap[2]=-0.058898, absGapDifference[2]=0.000007 i=4, absRcvTimeGap[3]=-0.024152, absSendTimeGap[3]=-0.024798, absGapDifference[3]=0.000646 i=4, absRcvTimeGap[4]=0.000000, absSendTimeGap[4]=0.000000, absGapDifference[4]=0.000000 i=4, absRcvTimeGap[5]=0.018598, absSendTimeGap[5]=0.018602, absGapDifference[5]=-0.000004 i=4, absRcvTimeGap[6]=0.030998, absSendTimeGap[6]=0.031276, absGapDifference[6]=-0.000278 i=4, absRcvTimeGap[7]=0.043397, absSendTimeGap[7]=0.043420, absGapDifference[7]=-0.000023 i=4, absRcvTimeGap[8]=0.052698, absSendTimeGap[8]=0.053551, absGapDifference[8]=-0.000853 i=4, absRcvTimeGap[9]=0.061997, absSendTimeGap[9]=0.062550, absGapDifference[9]=-0.000553 i=5, absRcvTimeGap[1]=-0.111228, absSendTimeGap[1]=-0.150947, absGapDifference[1]=0.039719 i=5, absRcvTimeGap[2]=-0.077489, absSendTimeGap[2]=-0.077500, absGapDifference[2]=0.000011 i=5, absRcvTimeGap[3]=-0.042750, absSendTimeGap[3]=-0.043400, absGapDifference[3]=0.000650 i=5, absRcvTimeGap[4]=-0.018598, absSendTimeGap[4]=-0.018602, absGapDifference[4]=0.000004 i=5, absRcvTimeGap[5]=0.000000, absSendTimeGap[5]=0.000000, absGapDifference[5]=0.000000 i=5, absRcvTimeGap[6]=0.012400, absSendTimeGap[6]=0.012674, absGapDifference[6]=-0.000274 i=5, absRcvTimeGap[7]=0.024799, absSendTimeGap[7]=0.024818, absGapDifference[7]=-0.000019 i=5, absRcvTimeGap[8]=0.034100, absSendTimeGap[8]=0.034949, absGapDifference[8]=-0.000849 i=5, absRcvTimeGap[9]=0.043399, absSendTimeGap[9]=0.043948, absGapDifference[9]=-0.000549 i=6, absRcvTimeGap[1]=-0.123628, absSendTimeGap[1]=-0.163621, absGapDifference[1]=0.039993 i=6, absRcvTimeGap[2]=-0.089889, absSendTimeGap[2]=-0.090174, absGapDifference[2]=0.000285 i=6, absRcvTimeGap[3]=-0.055150, absSendTimeGap[3]=-0.056074, absGapDifference[3]=0.000924 i=6, absRcvTimeGap[4]=-0.030998, absSendTimeGap[4]=-0.031276, absGapDifference[4]=0.000278 i=6, absRcvTimeGap[5]=-0.012400, absSendTimeGap[5]=-0.012674, absGapDifference[5]=0.000274 i=6, absRcvTimeGap[6]=0.000000, absSendTimeGap[6]=0.000000, absGapDifference[6]=0.000000 i=6, absRcvTimeGap[7]=0.012399, absSendTimeGap[7]=0.012144, absGapDifference[7]=0.000255 i=6, absRcvTimeGap[8]=0.021700, absSendTimeGap[8]=0.022275, absGapDifference[8]=-0.000575 i=6, absRcvTimeGap[9]=0.030999, absSendTimeGap[9]=0.031274, absGapDifference[9]=-0.000275 i=7, absRcvTimeGap[1]=-0.136027, absSendTimeGap[1]=-0.175765, absGapDifference[1]=0.039738 i=7, absRcvTimeGap[2]=-0.102288, absSendTimeGap[2]=-0.102318, absGapDifference[2]=0.000030 i=7, absRcvTimeGap[3]=-0.067549, absSendTimeGap[3]=-0.068218, absGapDifference[3]=0.000669 i=7, absRcvTimeGap[4]=-0.043397, absSendTimeGap[4]=-0.043420, absGapDifference[4]=0.000023 i=7, absRcvTimeGap[5]=-0.024799, absSendTimeGap[5]=-0.024818, absGapDifference[5]=0.000019 i=7, absRcvTimeGap[6]=-0.012399, absSendTimeGap[6]=-0.012144, absGapDifference[6]=-0.000255 i=7, absRcvTimeGap[7]=0.000000, absSendTimeGap[7]=0.000000, absGapDifference[7]=0.000000 i=7, absRcvTimeGap[8]=0.009301, absSendTimeGap[8]=0.010131, absGapDifference[8]=-0.000830 i=7, absRcvTimeGap[9]=0.018600, absSendTimeGap[9]=0.019130, absGapDifference[9]=-0.000530 i=8, absRcvTimeGap[1]=-0.145328, absSendTimeGap[1]=-0.185896, absGapDifference[1]=0.040568 i=8, absRcvTimeGap[2]=-0.111589, absSendTimeGap[2]=-0.112449, absGapDifference[2]=0.000860 i=8, absRcvTimeGapLower bound of probing bandwidth is set to 1000 Upper bound of probing bandwidth is set to 1e+06 The number of msgs sent is set to 10 msgSize is set to 1000 iteration is set to 1 hostname=128.236.1.7 cmd=./abwm3 -l 1000.000000 -u 1000000.000000 -n 10 -s 1000 128.236.1.7 iteration 1: abw=0.000000, lbw=1000.000000, ubw=1000000.000000, reportNotValid final estimate abw = 0.000000