2008/1/2, [EMAIL PROTECTED] <[EMAIL PROTECTED]>: > back to the point, I'm having some problems when trying to answer a call > through wengo. I get a "strange ACK" message when accepting the invite, and > then a terminated message with an internal error before that.
> However, it's fine if I am the one calling from sofia-sip to another client > through wengo. Any idea? You have hairy logs and managed to trip to multiple problems... ;) It looks to me that Wengo is a rfc 2543 proxy, SER is forking requests, and the request merging logic in sofia-sip nta fails with the second fork (the first INVITE shown in your log, and 2nd Via line containing z9hG4bK261e.c5161123.0). So, the request is processed by nua in the context of the original dialog, so nua discards the request because its CSeq has not been increased. However, the "overlapping" INVITE seem to corrupt the SOA SDP state from original INVITE so when you accept the call the nua_respond() fails. It also looks like the stack matches the ACK message with the original INVITE (one with 2nd Via line containing z9hG4bK261e.c5161123.4), not with the INVITE shown in the log. The original INVITE transaction is still pending and it does not process ACK but it is delivered to the transaction (which just logs "strange ACK"). 3 bugs and still counting. ;-/ --Pekka > > Here I strip a little from the output with TPORT_LOG=9 > > ------------------------------------------------------------------------ > Remote SDP: (null) > Call 6|early > recv 1118 bytes from udp/[213.91.9.206]:5060 at 15:18:50.843667: > ------------------------------------------------------------------------ > INVITE sip:[EMAIL PROTECTED] SIP/2.0 > Record-Route: <sip:213.91.9.206:5060;lr=on> > Record-Route: > <sip:192.168.70.88:5062;proxy=yes;ftag=32721-BF-00a49812-47837c974;lr=on> > Record-Route: <sip:192.168.70.242:5067;lr=on> > Allow: UPDATE,REFER > Call-ID: [EMAIL PROTECTED] > Contact: <sip:213.91.9.213:5060> > Content-Type: application/sdp > CSeq: 10745350 INVITE > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > Max-Forwards: 27 > To: <sip:[EMAIL PROTECTED];user=phone> > User-Agent: Cirpack/v4.41a (gw_sip) > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > Via: SIP/2.0/UDP 192.168.70.242:5067;branch=0 > Via: SIP/2.0/UDP > 213.91.9.213:5060;received=192.168.70.20;branch=z9hG4bK-14AE-27B95 > Content-Length: 276 > > v=0 > o=cp10 119927620337 119927620338 IN IP4 80.118.99.22 > s=SIP Call > c=IN IP4 80.118.99.22 > t=0 0 > m=audio 45168 RTP/AVP 8 0 18 > b=AS:64 > a=rtpmap:8 PCMA/8000/1 > a=rtpmap:0 PCMU/8000/1 > a=rtpmap:18 G729/8000/1 > a=fmtp:18 annexb=no > a=ptime:30 > a=sendrecv > a=nortpproxy:yes > ------------------------------------------------------------------------ > send 733 bytes to udp/[213.91.9.206]:5060 at 15:18:50.844278: > ------------------------------------------------------------------------ > SIP/2.0 500 Overlapping Requests > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > Via: SIP/2.0/UDP 192.168.70.242:5067;branch=0 > Via: SIP/2.0/UDP > 213.91.9.213:5060;received=192.168.70.20;branch=z9hG4bK-14AE-27B95 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > Call-ID: [EMAIL PROTECTED] > CSeq: 10745350 INVITE > Retry-After: 7 (Overlapping Requests) > User-Agent: sofia-sip/1.12.7 > Accept: application/sdp > Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, > NOTIFY, REFER, UPDATE > Supported: timer, 100rel > Content-Length: 0 > > ------------------------------------------------------------------------ > recv 509 bytes from udp/[213.91.9.206]:5060 at 15:18:51.066475: > ------------------------------------------------------------------------ > ACK sip:[EMAIL PROTECTED] SIP/2.0 > Max-Forwards: 10 > Record-Route: <sip:213.91.9.206:5060;lr=on> > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > Call-ID: [EMAIL PROTECTED] > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > CSeq: 10745350 ACK > User-Agent: OpenSer (1.1.0-notls (i386/linux)) > Content-Length: 0 > > ------------------------------------------------------------------------ > nua(0x8059e88): strange ACK from <sip:[EMAIL PROTECTED];user=phone> > send 733 bytes to udp/[213.91.9.206]:5060 at 15:18:51.345997: > ------------------------------------------------------------------------ > SIP/2.0 500 Overlapping Requests > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > Via: SIP/2.0/UDP 192.168.70.242:5067;branch=0 > Via: SIP/2.0/UDP > 213.91.9.213:5060;received=192.168.70.20;branch=z9hG4bK-14AE-27B95 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > Call-ID: [EMAIL PROTECTED] > CSeq: 10745350 INVITE > Retry-After: 7 (Overlapping Requests) > User-Agent: sofia-sip/1.12.7 > Accept: application/sdp > Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, > NOTIFY, REFER, UPDATE > Supported: timer, 100rel > Content-Length: 0 > > ------------------------------------------------------------------------ > recv 509 bytes from udp/[213.91.9.206]:5060 at 15:18:51.551582: > ------------------------------------------------------------------------ > ACK sip:[EMAIL PROTECTED] SIP/2.0 > Max-Forwards: 10 > Record-Route: <sip:213.91.9.206:5060;lr=on> > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > Call-ID: [EMAIL PROTECTED] > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > CSeq: 10745350 ACK > User-Agent: OpenSer (1.1.0-notls (i386/linux)) > Content-Length: 0 > > > ------- and then, later, when I choose to 'answer' ----------- > > ------------------------------------------------------------------------ > send 733 bytes to udp/[213.91.9.206]:5060 at 15:18:54.348987: > ------------------------------------------------------------------------ > SIP/2.0 500 Overlapping Requests > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > Via: SIP/2.0/UDP 192.168.70.242:5067;branch=0 > Via: SIP/2.0/UDP > 213.91.9.213:5060;received=192.168.70.20;branch=z9hG4bK-14AE-27B95 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > Call-ID: [EMAIL PROTECTED] > CSeq: 10745350 INVITE > Retry-After: 7 (Overlapping Requests) > User-Agent: sofia-sip/1.12.7 > Accept: application/sdp > Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, > NOTIFY, REFER, UPDATE > Supported: timer, 100rel > Content-Length: 0 > > ------------------------------------------------------------------------ > recv 509 bytes from udp/[213.91.9.206]:5060 at 15:18:54.572938: > ------------------------------------------------------------------------ > ACK sip:[EMAIL PROTECTED] SIP/2.0 > Max-Forwards: 10 > Record-Route: <sip:213.91.9.206:5060;lr=on> > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > Call-ID: [EMAIL PROTECTED] > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > CSeq: 10745350 ACK > User-Agent: OpenSer (1.1.0-notls (i386/linux)) > Content-Length: 0 > > ------------------------------------------------------------------------ > send 733 bytes to udp/[213.91.9.206]:5060 at 15:18:55.301320: > ------------------------------------------------------------------------ > SIP/2.0 500 Overlapping Requests > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > Via: SIP/2.0/UDP 192.168.70.242:5067;branch=0 > Via: SIP/2.0/UDP > 213.91.9.213:5060;received=192.168.70.20;branch=z9hG4bK-14AE-27B95 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > Call-ID: [EMAIL PROTECTED] > CSeq: 10745350 INVITE > Retry-After: 2 (Overlapping Requests) > User-Agent: sofia-sip/1.12.7 > Accept: application/sdp > Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, > NOTIFY, REFER, UPDATE > Supported: timer, 100rel > Content-Length: 0 > > ------------------------------------------------------------------------ > send 883 bytes to udp/[213.91.9.206]:5060 at 15:18:55.365311: > ------------------------------------------------------------------------ > SIP/2.0 500 Internal Server Error > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.4 > Via: SIP/2.0/UDP 192.168.70.242:5067;branch=0 > Via: SIP/2.0/UDP > 213.91.9.213:5060;received=192.168.70.20;branch=z9hG4bK-14AE-27B95 > Record-Route: <sip:213.91.9.206:5060;lr=on> > Record-Route: > <sip:192.168.70.88:5062;proxy=yes;ftag=32721-BF-00a49812-47837c974;lr=on> > Record-Route: <sip:192.168.70.242:5067;lr=on> > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > Call-ID: [EMAIL PROTECTED] > CSeq: 10745350 INVITE > Contact: <sip:192.168.255.102> > User-Agent: sofia-sip/1.12.7 > Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, > NOTIFY, REFER, UPDATE > Supported: timer, 100rel > Content-Length: 0 > > ------------------------------------------------------------------------ > ::1199287135 sofia_events.c at app_i_error(): NUA Error: Internal Server > Error > Remote SDP: (null) > Call 10|terminated > Call terminated > ::tag_null: 0 > recv 509 bytes from udp/[213.91.9.206]:5060 at 15:18:55.555716: > ------------------------------------------------------------------------ > ACK sip:[EMAIL PROTECTED] SIP/2.0 > Max-Forwards: 10 > Record-Route: <sip:213.91.9.206:5060;lr=on> > Via: SIP/2.0/UDP 213.91.9.206;branch=0 > Via: SIP/2.0/UDP 192.168.70.88:5062;branch=z9hG4bK261e.c5161123.0 > From: "cjb2002" > <sip:[EMAIL PROTECTED];user=phone>;tag=32721-BF-00a49812-47837c974 > Call-ID: [EMAIL PROTECTED] > To: <sip:[EMAIL PROTECTED];user=phone>;tag=F19jtD1g3Hmpp > CSeq: 10745350 ACK > User-Agent: OpenSer (1.1.0-notls (i386/linux)) > Content-Length: 0 > > > > Thanks in advance, > > Carlos > > ------------------------------------------------------------------------- > This SF.net email is sponsored by: Microsoft > Defy all challenges. Microsoft(R) Visual Studio 2005. > http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/ > _______________________________________________ > Sofia-sip-devel mailing list > Sofia-sip-devel@lists.sourceforge.net > https://lists.sourceforge.net/lists/listinfo/sofia-sip-devel > -- Pekka.Pessi mail at nokia.com ------------------------------------------------------------------------- This SF.net email is sponsored by: Microsoft Defy all challenges. Microsoft(R) Visual Studio 2005. http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/ _______________________________________________ Sofia-sip-devel mailing list Sofia-sip-devel@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/sofia-sip-devel
