HELP...where am I wrong?

Asterisk Asterisk Support
1

Hi, I’m developing a simple softphone, I’m stuck in the responses ACK …
where am I wrong?

[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Trying to put ‘BYE sip:103’ onto UDP socket destined for 77.7.54.233:51565
[2013-01-23 17:37:19] VERBOSE[9908] chan_sip.c:
<— SIP read from UDP:77.7.54.233:51565 —>
ACK sip:110@droidsip.net SIP/2.0
Via: SIP/2.0/UDP 87.117.235.69:5060;branch=z9hG4bK6f1dd1de;rport
Max-Forwards: 70
From: sip:103@droidsip.net;tag=as7bc6786a
To: sip:110@droidsip.net;tag=87148
Call-ID: 84277df45c530b8263ec42e07f58e6bb@droidsip.net
CSeq: 102 ACK
Content-Length: 0

<------------->
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 0 [ 32]: ACK sip:110@droidsip.net SIP/2.0
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 1 [ 64]: Via: SIP/2.0/UDP 87.117.235.69:5060;branch=z9hG4bK6f1dd1de;rport
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 3 [ 43]: From: sip:103@droidsip.net;tag=as7bc6786a
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 4 [ 36]: To: sip:110@droidsip.net;tag=87148
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 5 [ 54]: Call-ID: 84277df45c530b8263ec42e07f58e6bb@droidsip.net
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 6 [ 13]: CSeq: 102 BYE
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Header 7 [ 17]: Content-Length: 0
[2013-01-23 17:37:19] VERBOSE[9908] chan_sip.c: — (8 headers 0 lines) —
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: = Looking for Call ID: 84277df45c530b8263ec42e07f58e6bb@droidsip.net (Checking From) --From tag as7bc6786a --To-tag 87148
[2013-01-23 17:37:19] DEBUG[9908] chan_sip.c: Invalid SIP message - rejected , no callid, len 283

2

Your trace does not contain the final status message which you are ACKing.

3

Hey, thanks for your answer I posted the log … can you help me thank you again.

A ----(INVITE)----->B
A<--------180 ring…B
A<--------200 OK—B
A-----------ACK---->B

is that correct?

SIP/2.0 200 OK
Via: SIP/2.0/UDP 0.0.0.0:5060;branch=z9hG4bK-72128-6415132;received=77.7.54.233;rport=59884
From: sip:103@droidsip.net;tag=72128
To: "110@droidsip.net"sip:110@droidsip.net;tag=as511a765f
Call-ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net
CSeq: 6 INVITE
Server: FPBX-2.10.1(1.8.19.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: sip:110@87.117.235.69:5060
Content-Type: application/sdp
Content-Length: 180

v=0
o=root 626002205 626002205 IN IP4 87.117.235.69
s=Asterisk PBX 1.8.19.1
c=IN IP4 87.117.235.69
t=0 0
m=audio 12602 RTP/AVP 3
a=rtpmap:3 GSM/8000
a=ptime:20
a=sendrecv

[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Trying to put ‘SIP/2.0 200’ onto UDP socket destined for 77.7.54.233:59884
[2013-01-23 19:47:21] VERBOSE[9908] chan_sip.c:
<— SIP read from UDP:77.7.54.233:59884 —>
ACK sip:110@droidsip.net SIP/2.0
Via: SIP/2.0/UDP 0.0.0.0:5060;branch=z9hG4bK-72128-6415132
Max-Forwards: 70
From: sip:103@droidsip.net;tag=72128
To: sip:110@droidsip.net;tag=as511a765f
Call-ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net
CSeq: 6 ACK
Content-Length: 0

<------------->
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 0 [ 32]: ACK sip:110@droidsip.net SIP/2.0
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 1 [ 58]: Via: SIP/2.0/UDP 0.0.0.0:5060;branch=z9hG4bK-72128-6415132
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 3 [ 38]: From: sip:103@droidsip.net;tag=72128
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 4 [ 41]: To: sip:110@droidsip.net;tag=as511a765f
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 5 [ 54]: Call-ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 6 [ 11]: CSeq: 6 ACK
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 7 [ 17]: Content-Length: 0
[2013-01-23 19:47:21] VERBOSE[9908] chan_sip.c: — (8 headers 0 lines) —
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: = Looking for Call ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net (Checking From) --From tag 72128 --To-tag as511a765f
???------> [2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Invalid SIP message - rejected , no callid, len 275
[2013-01-23 19:47:21] VERBOSE[9908] chan_sip.c:
<— SIP read from UDP:77.7.54.233:59884 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 0.0.0.0:5060;branch=z9hG4bK-72128-6415132
Max-Forwards: 70
From: sip:103@droidsip.net;tag=72128
To: sip:110@droidsip.net;tag=as511a765f
Call-ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net
CSeq: 6 INVITE
Content-Length: 0

<------------->
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 0 [ 14]: SIP/2.0 200 OK
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 1 [ 58]: Via: SIP/2.0/UDP 0.0.0.0:5060;branch=z9hG4bK-72128-6415132
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 3 [ 38]: From: sip:103@droidsip.net;tag=72128
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 4 [ 41]: To: sip:110@droidsip.net;tag=as511a765f
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 5 [ 54]: Call-ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 6 [ 14]: CSeq: 6 INVITE
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Header 7 [ 17]: Content-Length: 0
[2013-01-23 19:47:21] VERBOSE[9908] chan_sip.c: — (8 headers 0 lines) —
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: = Looking for Call ID: 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net (Checking To) --From tag 72128 --To-tag as511a765f
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: That’s odd… Got a response on a call we don’t know about. Callid 9dfd1a88d21638e6df3a6c8b1e5306f2@droidsip.net
[2013-01-23 19:47:21] DEBUG[9908] chan_sip.c: Invalid SIP message - rejected , no callid, len 260
[2013-01-23 19:47:22] DEBUG[9908] chan_sip.c: SIP TIMER: Rescheduling retransmission #112076 (10) NOTIFY - 4
[2013-01-23 19:47:22] DEBUG[9908] chan_sip.c: ** SIP timers: Rescheduling retransmission 11 to 4000 ms (t1 500 ms (Retrans id #112076))

4

0.0.0.0 is invalid in a Via header.

You appear to be receiving both the OK and the ACK for the same call! You should be sending one and receiving one!

5

SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.110:5060;branch=z9hG4bK-57560-6087703
Max-Forwards: 70
Contact: <103@droidsip.net:63000>
From: sip:103@droidsip.net;tag=57560
To: sip:110@droidsip.net;tag=as7df658b0
Call-ID: 1c89469cc469a8dc8f49a600d9b36a0c@droidsip.net
CSeq: 6 ACK
Content-Length: 0

ACK sip:110@droidsip.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.110:5060;branch=z9hG4bK-57560-6087703
Max-Forwards: 70
Contact: <103@droidsip.net:63000>
From: sip:103@droidsip.net;tag=57560
To: sip:110@droidsip.net;tag=as7df658b0
Call-ID: 1c89469cc469a8dc8f49a600d9b36a0c@droidsip.net
CSeq: 6 ACK
Content-Length: 0

SIP/2.0 200 OK

Via: SIP/2.0/UDP 192.168.1.110:5060;branch=z9hG4bK-57560-6087703;received=77.7.54.233;rport=63000

From: sip:103@droidsip.net;tag=57560

To: "110@droidsip.net"sip:110@droidsip.net;tag=as7df658b0

Call-ID: 1c89469cc469a8dc8f49a600d9b36a0c@droidsip.net

CSeq: 6 INVITE

Server: FPBX-2.10.1(1.8.19.1)

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Contact: sip:110@87.117.235.69:5060

Content-Type: application/sdp

Content-Length: 178

v=0

o=root 98008599 98008599 IN IP4 87.117.235.69

s=Asterisk PBX 1.8.19.1

c=IN IP4 87.117.235.69

t=0 0

m=audio 13384 RTP/AVP 3

a=rtpmap:3 GSM/8000

a=ptime:20

a=sendrecv

ACK sip:110@droidsip.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.110:5060;branch=z9hG4bK-57560-6087703
Max-Forwards: 70
Contact: <103@droidsip.net:63000>
From: sip:103@droidsip.net;tag=57560
To: sip:110@droidsip.net;tag=as7df658b0
Call-ID: 1c89469cc469a8dc8f49a600d9b36a0c@droidsip.net
CSeq: 6 ACK
Content-Length: 0

SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.110:5060;branch=z9hG4bK-57560-6087703
Max-Forwards: 70
Contact: <103@droidsip.net:63000>
From: sip:103@droidsip.net;tag=57560
To: sip:110@droidsip.net;tag=as7df658b0
Call-ID: 1c89469cc469a8dc8f49a600d9b36a0c@droidsip.net
CSeq: 6 ACK
Content-Length: 0