reSIProcate

Mailing Lists

Source Code

Google Search:



< Previous by Date Date Index Next by Date >
< Previous in Thread Thread Index  

Re: [reSIProcate-users] help with resiprocate log

Looks like that logging is misleading; the 180 is in fact missing a Contact header, which is another piece of information required to set up dialog state. The logging should be fixed. As for the ACK, it looks like it is failing to go out due to a DNS server timeout, although it shouldn't even be touching DNS since the Contact header in the 200 uses an ip-address. I'm not sure what is going on there, but if you can get us some DEBUG logs of this behavior, that would help. 

Best regards,
Byron Campen


Hi,
I'm trying to understand the log of an attempted call from Resiprocate to a Cisco device. Attached is the wireshark capture of the call and the corresponding Resiprocate log file (unfortunately its only at the info level - I can try and reproduce it at a higher level if necessary.
Anyway, there are two main things that puzzle me in the Resiprocate log file:
The first is that following the "180 Ringing" message from Cisco, the log shows: 
"Cannot create a dialog, no Contact or To tag in 1xx."
Which is strange since in the Wireshark capture it can be seen that the To tag does exist in the 180 message.
The next thing that I found strange is the fact that although from the log file it seems as though an ACK is sent back to the Cisco:
"InviteSession.cxx:2817 | Sending SipReq: ACK 102@xxxxxxxxxxxxxxx:5060"
There is no indication that this actually happens from looking at the Wireshark capture. There might be other issues here as well but I find these two the most puzzling. Any help would be appreciated.
The third file is a capture of the same call using SJPhone to Cisco in which there seems to be no problem 

Thanks,
Amnon
<SJphoneToCisco.pcap><resip2cisco.pcap>INFO | 20080306-154359.333 | Resiprogate | RESIP:TRANSPORT | 716 | UdpTransport.cxx:42 | Creating UDP transport host= port=5060 ipv4=1 INFO | 20080306-154459.309 | Resiprogate | RESIP:TRANSACTION | 3736 | TuSelector.cxx:70 | Stats message WARNING | 20080306-154459.309 | Resiprogate | RESIP:STATS | 3736 | StatisticsMessage.cxx:152 | RESIP:TRANSACTION 
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 0 TIMERS 0
Transaction summary: reqi 0 reqo 0 rspi 0 rspo 0
Details: INVi 0/S0/F0 INVo 0/S0/F0 ACKi 0 ACKo 0 BYEi 0/S0/F0 BYEo 0/S0/F0 CANi 0/S0/F0 CANo 0/S0/F0 MSGi 0/S0/F0 MSGo 0/S0/F0 OPTi 0/ S0/F0 OPTo 0/S0/F0 REGi 0/S0/F0 REGo 0/S0/F0 PUBi 0/S0/F0 PUBo 0/S0/ F0 SUBi 0/S0/F0 SUBo 0/S0/F0 NOTi 0/S0/F0 NOTo 0/S0/F0 Retransmissions: INVx 0 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 0 finx 0 nonx 0 PUBx 0 SUBx 0 NOTx 0 INFO | 20080306-154559.326 | Resiprogate | RESIP:TRANSACTION | 3736 | TuSelector.cxx:70 | Stats message WARNING | 20080306-154559.326 | Resiprogate | RESIP:STATS | 3736 | StatisticsMessage.cxx:152 | RESIP:TRANSACTION 
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 0 TIMERS 0
Transaction summary: reqi 0 reqo 0 rspi 0 rspo 0
Details: INVi 0/S0/F0 INVo 0/S0/F0 ACKi 0 ACKo 0 BYEi 0/S0/F0 BYEo 0/S0/F0 CANi 0/S0/F0 CANo 0/S0/F0 MSGi 0/S0/F0 MSGo 0/S0/F0 OPTi 0/ S0/F0 OPTo 0/S0/F0 REGi 0/S0/F0 REGo 0/S0/F0 PUBi 0/S0/F0 PUBo 0/S0/ F0 SUBi 0/S0/F0 SUBo 0/S0/F0 NOTi 0/S0/F0 NOTo 0/S0/F0 Retransmissions: INVx 0 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 0 finx 0 nonx 0 PUBx 0 SUBx 0 NOTx 0 INFO | 20080306-154631.482 | Resiprogate | RESIP:DNS | 776 | DnsUtil.cxx:145 | local hostname does not contain a domain part hypergateway499 INFO | 20080306-154631.592 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 100 tid=8b1a0f66fc49052c cseq=INVITE / 1 from(wire) INFO | 20080306-154631.592 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 180 tid=8b1a0f66fc49052c cseq=INVITE / 1 from(wire) INFO | 20080306-154631.592 | Resiprogate | RESIP:DUM | 716 | DialogSet.cxx:751 | Cannot create a dialog, no Contact or To tag in 1xx. INFO | 20080306-154634.897 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154634.917 | Resiprogate | RESIP:DUM | 716 | InviteSession.cxx:2499 | Transition UAC_Start -> InviteSession::Connected INFO | 20080306-154634.917 | Resiprogate | RESIP:DUM | 716 | InviteSession.cxx:2817 | Sending SipReq: ACK 102@xxxxxxxxxxxxxxx:5060 tid=6c5042173e5a4c4a cseq=ACK contact=HG4000@xxxxxxxxxxxxxxx / 1 from(tu) INFO | 20080306-154635.387 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154636.349 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154638.362 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) ERR | 20080306-154639.003 | Resiprogate | RESIP:DNS | 3736 | DnsStub.cxx:450 | Unknown error Timeout while contacting DNS servers for INFO | 20080306-154639.003 | Resiprogate | RESIP:TRANSACTION | 3736 | TransactionState.cxx:1376 | Ran out of dns entries for . Send 503 INFO | 20080306-154639.013 | Resiprogate | RESIP:DNS | 3736 | DnsUtil.cxx:145 | local hostname does not contain a domain part hypergateway499 INFO | 20080306-154639.063 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 503 tid=6c5042173e5a4c4a cseq=ACK / 1 from(wire) INFO | 20080306-154640.375 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154642.397 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154644.360 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154646.363 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipResp: 200 tid=8b1a0f66fc49052c cseq=INVITE contact=102@xxxxxxxxxxxxxxx:5060 / 1 from(wire) INFO | 20080306-154648.396 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1297 | Got: SipReq: BYE HG4000@xxxxxxxxxxxxxxx tid=a5cb12501ccce455406f61840ed63414 cseq=BYE / 1 from(wire) INFO | 20080306-154648.396 | Resiprogate | RESIP:DUM | 716 | DialogUsageManager.cxx:1675 | Handling in-dialog request: SipReq: BYE HG4000@xxxxxxxxxxxxxxx tid=a5cb12501ccce455406f61840ed63414 cseq=BYE / 1 from(wire) INFO | 20080306-154648.396 | Resiprogate | RESIP:DUM | 716 | InviteSession.cxx:1959 | Received SipReq: BYE HG4000@xxxxxxxxxxxxxxx tid=a5cb12501ccce455406f61840ed63414 cseq=BYE / 1 from(wire) INFO | 20080306-154648.396 | Resiprogate | RESIP:DUM | 716 | InviteSession.cxx:2499 | Transition InviteSession::Connected -> InviteSession::Terminated INFO | 20080306-154659.332 | Resiprogate | RESIP:TRANSACTION | 3736 | TuSelector.cxx:70 | Stats message WARNING | 20080306-154659.332 | Resiprogate | RESIP:STATS | 3736 | StatisticsMessage.cxx:152 | RESIP:TRANSACTION 
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 2 SERVERTX 1 TIMERS 4
Transaction summary: reqi 1 reqo 9 rspi 10 rspo 1
_______________________________________________
resiprocate-users mailing list
resiprocate-users@xxxxxxxxxxxxxxx
List Archive: http://list.resiprocate.org/archive/resiprocate-users/

Attachment: smime.p7s
Description: S/MIME cryptographic signature