Hello People,
I’ve been investigating an issue with SDP when sending a call to a Panasonic KX-TGP600 Phone, the call end as soon as the Panasonic send it’s SIP OK
I could not see what is wrong with the SDP and why I get "INVITE: error parsing SDP answer in 200 OK" resulting in "988 Incomplete offer/answer"
I also find it weird that there is no output for this error when Sofia debug is not enabled. It took me a while before I thought of trying to enable more debugging.
There is also the "not found by name */1.1.217.127:1029" Part which I am not sure is related/relevant in this.
--
Here is the console log portion that I thought was relevant:
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
tport.c:2759 tport_wakeup_pri() tport_wakeup_pri(0x7f0e440044a0): events IN
tport.c:2882 tport_recv_event() tport_recv_event(0x7f0e440044a0)
tport_type_udp.c:324 tport_recv_dgram() tport(0x7f0e440044a0): zero length packet
tport.c:2759 tport_wakeup_pri() tport_wakeup_pri(0x7f0e440044a0): events IN
tport.c:2882 tport_recv_event() tport_recv_event(0x7f0e440044a0)
tport.c:3223 tport_recv_iovec() tport_recv_iovec(0x7f0e440044a0) msg 0x7f0e44011e30 from (udp/1.1.131.37:5060) has 845 bytes, veclen = 1
tport.c:3041 tport_deliver() tport_deliver(0x7f0e440044a0): msg 0x7f0e44011e30 (845 bytes) from udp/1.1.217.127:5060/sip next=(nil)
nta.c:3304 agent_recv_response() nta: received 200 OK for INVITE (22953743)
nta.c:3371 agent_recv_response() nta: 200 OK is going to a transaction
tport.c:4240 tport_release() tport_release(0x7f0e440044a0): 0x7f0e4400bca0 by 0x7f0e44010c40 with 0x7f0e44011e30
nua_dialog.c:564 nua_dialog_usage_set_refresh_range() nua(): refresh session after 55 seconds (in [55..65])
soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::0x7f0e4401a9b0, (nil), 0x7f0e4401267a, 259) called
nua_session.c:970 nua_session_client_response() nua(0x7f0e48048c30): INVITE: error parsing SDP answer in 200 OK (200)
nua_stack.c:271 nua_stack_event() nua(0x7f0e48048c30): event r_invite 200 OK
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nta.c:2670 nta_tpn_by_url() nta: selecting scheme sip
tport.c:3275 tport_tsend() tport_tsend(0x7f0e440044a0) tpn = */1.1.217.127:1029
tport.c:4064 tport_resolve() tport_resolve addrinfo = 1.1.217.127:1029
tport.c:4698 tport_by_addrinfo() tport_by_addrinfo(0x7f0e440044a0): not found by name */1.1.217.127:1029
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
tport.c:3612 tport_vsend() tport_vsend(0x7f0e440044a0): 391 bytes of 391 to udp/1.1.217.127:1029
tport.c:3510 tport_send_msg() tport_vsend returned 391
nta.c:8315 outgoing_send() nta: sent ACK (22953743) to */1.1.217.127:1029
nua_stack.c:271 nua_stack_event() nua(0x7f0e48048c30): event i_media_error 988 Incomplete offer/answer
nua_params.c:482 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:1784 soa_terminate() soa_terminate(static::0x7f0e4401a9b0) called
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::0x7f0e4401a9b0) called
nta.c:2670 nta_tpn_by_url() nta: selecting scheme sip
tport.c:3275 tport_tsend() tport_tsend(0x7f0e440044a0) tpn = */1.1.217.127:1029
tport.c:4064 tport_resolve() tport_resolve addrinfo = 1.1.217.127:1029
tport.c:4698 tport_by_addrinfo() tport_by_addrinfo(0x7f0e440044a0): not found by name */1.1.217.127:1029
tport.c:3612 tport_vsend() tport_vsend(0x7f0e440044a0): 616 bytes of 616 to udp/1.1.217.127:1029
tport.c:3510 tport_send_msg() tport_vsend returned 616
nta.c:8315 outgoing_send() nta: sent BYE (22953744) to */1.1.217.127:1029
tport.c:4178 tport_pend() tport_pend(0x7f0e440044a0): pending 0x7f0e4400d880 for udp/1.1.131.37:5060 (already 0)
nta.c:1348 set_timeout() nta: timer shortened to 1000 ms
nua_session.c:4140 signal_call_state_change() nua(0x7f0e48048c30): call state changed: proceeding -> terminating, received answer
soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::0x7f0e4401a9b0, [0x7f0e705a0778], [0x7f0e705a0780], [(nil)]) called
soa.c:616 soa_get_params() soa_get_params(static::0x7f0e4401a9b0, ...) called
nua_stack.c:271 nua_stack_event() nua(0x7f0e48048c30): event i_state 200 OK
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2020-07-17 15:44:35.795689 [DEBUG] sofia.c:7325 Channel sofia/public/golfvalneigette3 entering state [terminating][200]
--
And here is the SIP OK from the Panasonic:
Via: SIP/2.0/UDP 1.1.131.37;rport=5060;branch=z9hG4bKttaHKmXNgBtSQ;received=1.1.131.37
Call-ID: cbecb6ef-4300-1239-dfa0-000c29124868
CSeq: 22952030 INVITE
Allow: INVITE,ACK,CANCEL,BYE,PRACK,INFO,UPDATE,OPTIONS,MESSAGE,NOTIFY,REFER
Supported: 100rel,precondition
Require: replaces
Content-Type: application/sdp
Server: Panasonic-KX-TGP600/11.110 (4c364e38b998)
Content-Length: 263
v=0
o=- 1595011648 1595011648 IN IP4 192.168.1.193
s=-
c=IN IP4 192.168.1.193
t=0 0
m=audio 16176 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=ptime:20
m=video 0 RTP/AVP 34 0 16 178 64 0 16 178 0 0
--
I have a PCAP file for the whole call should it be needed.
Any help resolving this issue would be greatly appreciated.
Kindly,