Author Topic: Parsing failure for SIP INVITEs over TCP and TLS connections  (Read 546 times)

ttkr

  • Newbie
  • *
  • Posts: 8
    • View Profile
Parsing failure for SIP INVITEs over TCP and TLS connections
« on: March 16, 2017, 07:55:24 AM »
On GXP1782 I am observing failures when a SIP INVITE message is sent to the phone over the TCP or TLS connection.  This makes the phone unusable while using TCP or TLS as SIP transport.  The same behavior is observed when the SIP port on the phone is listening on an ephemeral port or not.

ttkr

  • Newbie
  • *
  • Posts: 8
    • View Profile
Re: Parsing failure for SIP INVITEs over TCP and TLS connections
« Reply #1 on: March 16, 2017, 07:59:15 AM »
Additionally, I find this in the debug log:

Code: [Select]
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] parse:SIPInviteParser.cc(99)->SIPInviteParser::parse: No XML message in the Dialog message body
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] cb_transport_error:SIPStack.cc(7643)->SIPStack::cb_transport_error: Transport error (-1) for transaction 1706
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_config_ring_path: ring_path=0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_voice: EVT_AUD_SET_RING_PATH
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_voice: EVT_AUD_STATE_EXIT
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_ring: EVT_AUD_STATE_ENTER
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_do_config_ring_path: ring_path=0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_load_wbhf_dyn_umt ( mode=50 size=146 )
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: ehs_sm_idle: EVT_EHS_REQ_ONHOOK
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_load_wbhf_dyn_umt complete
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_load_wbhf_dyn_umt ( mode=50 size=146 )
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_load_wbhf_dyn_umt complete
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_idle: EVT_TONE_SET_RING_PATH
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_apply_setting: aud_path=AUD_PATH_SPEAKERRING
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_mute_voip
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: alsa_pcm_service_process_message: msg: 0: id 1
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: Settingup PCMFD SAR for downsampling, rate requested = 48000
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: resampling_factor  3000000
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: return of SetDspValue 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: return of p_da_SwitchInstance 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: device 1 p/- opened
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_tone_current_audio_path: path=4
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_cfg_css (path[4] vol[1] bw[0])
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(UGT_IDLE)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(UGT_D_CLASS)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(DYN_RINGER)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_unmute_voip
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_apply_setting: done
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_send_event_synchronous: received sync_id 45
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_tone_start( tone = TONE_RING, path = TONE_PATH_LOCAL )
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_idle: EVT_TONE_START
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_tone_set_tog_instances: tog_source=0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_idle: EVT_TONE_STATE_EXIT
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_tone_playing: EVT_TONE_STATE_ENTER
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_tone_playing: EVT_TONE_STATE_ENTER ( tone = TONE_RING )
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_set_path: AUD_PATH_NULL
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_ring: EVT_AUD_SET_VOLUME
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_ring: EVT_AUD_SET_PATH
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_ring: EVT_AUD_STATE_EXIT
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_voice: EVT_AUD_STATE_ENTER
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_voice: EVT_AUD_SET_PATH
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_tone_playing: EVT_TONE_STOP
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_tone_playing: EVT_TONE_STATE_EXIT
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: tone_sm_idle: EVT_TONE_STATE_ENTER
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: ehs_sm_idle: EVT_EHS_REQ_ONHOOK
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_apply_setting: aud_path=AUD_PATH_NULL
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: alsa_pcm_service_process_message: msg: 1: id 1
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: device 1/0 closing
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: CSS: device 1/0 closed
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_mute_voip
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_tone_current_audio_path: path=0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_cfg_css (path[0] vol[1] bw[1])
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(UGT_IDLE)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(DYN_IDLE)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_unmute_voip
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_apply_setting: done
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_send_event_synchronous: received sync_id 46
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_set_path: AUD_PATH_NULL
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_sm_voice: EVT_AUD_SET_PATH
GXP1782_GUI: [xx:xx:xx:xx:xx:xx][1.0.0.38]updateMainPanel:CallScreen.cpp(2349)->[-Main-] Require to update whole screen...
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: ehs_sm_idle: EVT_EHS_REQ_ONHOOK
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_apply_setting: aud_path=AUD_PATH_NULL
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_mute_voip
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_tone_current_audio_path: path=0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_cfg_css (path[0] vol[1] bw[1])
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(UGT_IDLE)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_set_wbhf_mode(DYN_IDLE)
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: dua_unmute_voip
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_apply_setting: done
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] LIBGSDSP: aud_send_event_synchronous: received sync_id 47
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 1
GXP1782_GUI: [SL] OutboundNotificationMan:266->ON::needSendNotif| evt: Incoming_Call, prot: CTI, CTIReady: 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 2
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 3
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 4
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 5
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 6
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 7
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 0 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 1 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 2 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 3 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 4 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 5 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 6 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 7 is 0
GXP1782_GUI: [SL] OutboundNotificationMan:266->ON::needSendNotif| evt: Call_Canceled, prot: CTI, CTIReady: 0
GXP1782_PHONE: [SL] MpkMgr:2113->[GSMPK] getMonitoredVPKByPage page 0
GXP1782_PHONE: [SL] MpkMgr:2156->[GSMPK] initMpkList done 8
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 1
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 2
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 3
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 4
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 5
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 6
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] turnOffVPKLED:PhoneCallControl.cc(4881)->[YYYY] turn off led 7
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 0 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 1 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 2 is 0
GXP1782_PHONE: [xx:xx:xx:xx:xx:xx][1.0.0.38] restoreLineLED:PhoneCallControl.cc(3304)->[check] status for line 3 is 0
GXP1782_PHONE: [SL] MpkMgr:2113->[GSMPK] getMonitoredVPKByPage page 0
GXP1782_PHONE: [SL] MpkMgr:2156->[GSMPK] initMpkList done 0
GXP1782_STAT: [XX:XX:XX:XX:XX:XX]:[ 1.15 1.14 1.13 | 68551 282849 | 6656 | 13 0 0 0 0 0 0 0 0 0 0 0 | 9568 | 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 |  |  ]

Note: the MAC address is filtered  ;)

GS.Rick

  • Global Moderator
  • Hero Member
  • *****
  • Posts: 724
    • View Profile
Re: Parsing failure for SIP INVITEs over TCP and TLS connections
« Reply #2 on: March 29, 2017, 03:02:55 PM »
Hi,

Do you mean the phone cannot receive calls that are over TCP? Could you check on the phone's web UI under Account->SIP settings->Basic setting that the SIP transport is set to TCP? If you have the full packet capture it would be helpful.

Thanks

ttkr

  • Newbie
  • *
  • Posts: 8
    • View Profile
Re: Parsing failure for SIP INVITEs over TCP and TLS connections
« Reply #3 on: April 06, 2017, 06:50:55 AM »
Yes; I observe the same error with the set the SIP transport to either TCP, or TLS/TCP.

I can provide you with packet capture but I am not comfortable to post it on an open forum. Please check your PMs.

GS.Rick

  • Global Moderator
  • Hero Member
  • *****
  • Posts: 724
    • View Profile
Re: Parsing failure for SIP INVITEs over TCP and TLS connections
« Reply #4 on: April 27, 2017, 01:50:47 PM »
Hi,

I didn't receive any PMs. UDP calls work fine? Do you have other phones that are working ok with TCP in the same environment? When you TCP behind NAT, there's a chance for packet fragmentation on the INVITEs with authentication as the packet size gets big. If fragmentation is the issue, you can try turning off unnecessary SIP headers under Account->SIP Settings->Custom SIP headers.

Thanks