-------- [message] 2016-04-08 11:39:37:508 Using (r/w) config information from /home/martin/.linphonerc [message] 2016-04-08 11:39:37:508 Initializing LinphoneCore 3.9.1 [message] 2016-04-08 11:39:37:508 Vtable [0x19a8760] registered on core [0x19a8bc0] [message] 2016-04-08 11:39:37:508 Linphone core [0x19a8760] notifying [global_state_changed] [message] 2016-04-08 11:39:37:508 oRTP-0.25.0 initialized. [message] 2016-04-08 11:39:37:508 Mediastreamer2 factory 2.12.1 (git: 2.12.1) initialized. [message] 2016-04-08 11:39:37:508 CPU count set to 4 [message] 2016-04-08 11:39:37:508 ms_factory_init() done: platform_tags=linux,x86,desktop [message] 2016-04-08 11:39:37:508 srtp init [message] 2016-04-08 11:39:37:514 Registering all soundcard handlers [message] 2016-04-08 11:39:37:516 New PulseAudio context state: PA_CONTEXT_CONNECTING [message] 2016-04-08 11:39:37:516 New PulseAudio context state: PA_CONTEXT_FAILED [error ] 2016-04-08 11:39:37:516 Connection to the pulseaudio server failed [message] 2016-04-08 11:39:37:525 Card 'ALSA: default device' added [message] 2016-04-08 11:39:37:528 Card 'ALSA: HDA Intel PCH' added [message] 2016-04-08 11:39:37:528 Registering all webcam handlers [message] 2016-04-08 11:39:37:607 Webcam V4L2: /dev/video0 added [message] 2016-04-08 11:39:37:607 Webcam StaticImage: Static picture added [message] 2016-04-08 11:39:37:609 ms_factory_init_voip() done [message] 2016-04-08 11:39:37:609 Loading ms plugins from [/usr/lib/mediastreamer/plugins] [message] 2016-04-08 11:39:37:609 Loading plugin /usr/lib/mediastreamer/plugins/libmsbcg729.so.0.0.0... [message] 2016-04-08 11:39:37:610 libmsbcg729 debug plugin loaded [message] 2016-04-08 11:39:37:610 Plugin loaded (/usr/lib/mediastreamer/plugins/libmsbcg729.so.0.0.0) [message] 2016-04-08 11:39:37:610 Codec opus/48000 fmtp=[useinbandfec=1] number=-1, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for SILK [message] 2016-04-08 11:39:37:610 Could not find decoder for SILK [message] 2016-04-08 11:39:37:610 Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec t140/1000 fmtp=[] number=96, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec red/1000 fmtp=[] number=97, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for iLBC [message] 2016-04-08 11:39:37:610 Could not find decoder for iLBC [message] 2016-04-08 11:39:37:610 Could not find encoder for AMR [message] 2016-04-08 11:39:37:610 Could not find decoder for AMR [message] 2016-04-08 11:39:37:610 Could not find encoder for AMR-WB [message] 2016-04-08 11:39:37:610 Could not find decoder for AMR-WB [message] 2016-04-08 11:39:37:610 Codec G729/8000 fmtp=[annexb=no] number=18, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find decoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find encoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find decoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find encoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find decoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find encoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find decoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find encoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find decoder for mpeg4-generic [message] 2016-04-08 11:39:37:610 Could not find encoder for iSAC [message] 2016-04-08 11:39:37:610 Could not find decoder for iSAC [message] 2016-04-08 11:39:37:610 Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for SILK [message] 2016-04-08 11:39:37:610 Could not find decoder for SILK [message] 2016-04-08 11:39:37:610 Could not find encoder for SILK [message] 2016-04-08 11:39:37:610 Could not find decoder for SILK [message] 2016-04-08 11:39:37:610 Could not find encoder for SILK [message] 2016-04-08 11:39:37:610 Could not find decoder for SILK [message] 2016-04-08 11:39:37:610 Could not find encoder for G726-16 [message] 2016-04-08 11:39:37:610 Could not find decoder for G726-16 [message] 2016-04-08 11:39:37:610 Could not find encoder for G726-24 [message] 2016-04-08 11:39:37:610 Could not find decoder for G726-24 [message] 2016-04-08 11:39:37:610 Could not find encoder for G726-32 [message] 2016-04-08 11:39:37:610 Could not find decoder for G726-32 [message] 2016-04-08 11:39:37:610 Could not find encoder for G726-40 [message] 2016-04-08 11:39:37:610 Could not find decoder for G726-40 [message] 2016-04-08 11:39:37:610 Could not find encoder for AAL2-G726-16 [message] 2016-04-08 11:39:37:610 Could not find decoder for AAL2-G726-16 [message] 2016-04-08 11:39:37:610 Could not find encoder for AAL2-G726-24 [message] 2016-04-08 11:39:37:610 Could not find decoder for AAL2-G726-24 [message] 2016-04-08 11:39:37:610 Could not find encoder for AAL2-G726-32 [message] 2016-04-08 11:39:37:610 Could not find decoder for AAL2-G726-32 [message] 2016-04-08 11:39:37:610 Could not find encoder for AAL2-G726-40 [message] 2016-04-08 11:39:37:610 Could not find decoder for AAL2-G726-40 [message] 2016-04-08 11:39:37:610 Could not find encoder for CODEC2 [message] 2016-04-08 11:39:37:610 Could not find decoder for CODEC2 [message] 2016-04-08 11:39:37:610 Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for H264 [message] 2016-04-08 11:39:37:610 Codec MP4V-ES/90000 fmtp=[profile-level-id=3] number=-1, enabled=1) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec H263-1998/90000 fmtp=[CIF=1;QCIF=1] number=-1, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec H263/90000 fmtp=[] number=34, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for 1016 [message] 2016-04-08 11:39:37:610 Could not find decoder for 1016 [message] 2016-04-08 11:39:37:610 Could not find encoder for G723 [message] 2016-04-08 11:39:37:610 Could not find decoder for G723 [message] 2016-04-08 11:39:37:610 Could not find encoder for LPC [message] 2016-04-08 11:39:37:610 Could not find decoder for LPC [message] 2016-04-08 11:39:37:610 Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. [message] 2016-04-08 11:39:37:610 Could not find encoder for CN [message] 2016-04-08 11:39:37:610 Could not find decoder for CN [message] 2016-04-08 11:39:37:610 Could not find encoder for H261 [message] 2016-04-08 11:39:37:610 Could not find decoder for H261 [message] 2016-04-08 11:39:37:610 Could not find encoder for MPV [message] 2016-04-08 11:39:37:610 Could not find decoder for MPV [message] 2016-04-08 11:39:37:610 Sal nat helper [enabled] [message] 2016-04-08 11:39:37:611 Root ca path set to /etc/ssl/certs [message] 2016-04-08 11:39:37:611 Root ca path set to /etc/ssl/certs [message] 2016-04-08 11:39:37:611 Root ca path set to /etc/ssl/certs [message] 2016-04-08 11:39:37:611 Linphone core [0x19a8760] notifying [configuring_status] [message] 2016-04-08 11:39:37:611 Cannot open directory /usr/lib/liblinphone/plugins: No such file or directory [message] 2016-04-08 11:39:37:611 linphone_core_set_playback_gain_db(): no active call. [message] 2016-04-08 11:39:37:611 linphone_core_set_mic_gain_db(): no active call. [message] 2016-04-08 11:39:37:611 MTU is supposed to be 1300, rtp payload max size will be 1240 [message] 2016-04-08 11:39:37:611 Sal nat helper [enabled] [message] 2016-04-08 11:39:37:611 Sal use rport [enabled] [message] 2016-04-08 11:39:37:611 Supported codec t140/1000 fmtp= automatically added to codec list. [message] 2016-04-08 11:39:37:611 Supported codec red/1000 fmtp= automatically added to codec list. [message] 2016-04-08 11:39:37:611 Sal use rport [enabled] [message] 2016-04-08 11:39:37:611 Root ca path set to /etc/ssl/certs [message] 2016-04-08 11:39:37:611 sal_unlisten_ports done [message] 2016-04-08 11:39:37:611 Creating listening point [0x1a1a0b0] on [sip:0.0.0.0:5060;transport=UDP] [message] 2016-04-08 11:39:37:611 Creating listening point [0x1a1a5c0] on [sip:0.0.0.0:5060;transport=TCP] [message] 2016-04-08 11:39:37:612 Linphone core [0x19a8760] notifying [display_status] [message] 2016-04-08 11:39:37:613 Notifying all friends that we are [online] [message] 2016-04-08 11:39:37:615 StatusIcon: Initialising [message] 2016-04-08 11:39:37:615 StatusIcon: looking for implementation... [message] 2016-04-08 11:39:37:615 StatusIcon: found implementation: gtk_status_icon [message] 2016-04-08 11:39:37:615 StatusIcon: instanciating singleton [message] 2016-04-08 11:39:37:616 StatusIcon: starting status icon [message] 2016-04-08 11:39:37:628 Linphone core [0x19a8760] notifying [global_state_changed] [message] 2016-04-08 11:39:37:629 Table already up to date: duplicate column name: url. [message] 2016-04-08 11:39:37:629 Table already up to date: duplicate column name: utc. [message] 2016-04-08 11:39:37:629 Table already up to date: duplicate column name: appdata. [message] 2016-04-08 11:39:37:629 Table already up to date: duplicate column name: content. [message] 2016-04-08 11:39:37:629 Table already up to date: duplicate column name: call_id. [message] 2016-04-08 11:39:37:632 linphone_core_get_call_history(): completed in 3 ms [warning] 2016-04-08 11:39:37:632 nothing to migrate, skipping... [message] 2016-04-08 11:39:37:636 linphone_core_get_call_history(): completed in 3 ms [message] 2016-04-08 11:39:37:680 New local ip address is 192.168.0.17 [message] 2016-04-08 11:39:37:680 Network state is now [UP] [message] 2016-04-08 11:39:37:680 LinphoneProxyConfig [0x1a1d0e0] about to register (LinphoneCore version: 3.9.1) [message] 2016-04-08 11:39:37:682 belle_sip_client_transaction_send_request(): waiting channel to be ready [message] 2016-04-08 11:39:37:682 channel [0x1afcd40]: starting resolution of gvgw.simonics.com [message] 2016-04-08 11:39:37:682 channel 0x1afcd40: state RES_IN_PROGRESS [message] 2016-04-08 11:39:37:682 transaction [0x1af21f0] channel state changed to [RES_IN_PROGRESS] [message] 2016-04-08 11:39:37:682 Resolver is using DNS server(s): [message] 2016-04-08 11:39:37:682 75.75.75.75 [message] 2016-04-08 11:39:37:682 75.75.76.76 [message] 2016-04-08 11:39:37:682 resolver_process_data dns_res_check() in progress [message] 2016-04-08 11:39:37:682 DNS resolution awaiting response, queued to main loop [message] 2016-04-08 11:39:37:682 Neither Expires header nor corresponding Contact header found, checking from original request [message] 2016-04-08 11:39:37:682 Refresher [0x1af7020] takes ownership of transaction [0x1af21f0] [message] 2016-04-08 11:39:37:682 Linphone core [0x19a8760] notifying [display_status] [message] 2016-04-08 11:39:37:682 Proxy config [0x1a1d0e0] for identity [sip:address@hidden moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress] [message] 2016-04-08 11:39:37:683 Linphone core [0x19a8760] notifying [registration_state_changed] [message] 2016-04-08 11:39:37:741 SRV _sip._udp.gvgw.simonics.com resolved to [target:gvgw10.simonics.com. port:5060 prio:0 weight:0] [message] 2016-04-08 11:39:37:741 SRV _sip._udp.gvgw.simonics.com resolved to [target:gvgw11.simonics.com. port:5060 prio:0 weight:0] [message] 2016-04-08 11:39:37:741 SRV _sip._udp.gvgw.simonics.com resolved to [target:gvgw12.simonics.com. port:5060 prio:0 weight:0] [message] 2016-04-08 11:39:37:741 SRV _sip._udp.gvgw.simonics.com resolved to [target:gvgw13.simonics.com. port:5060 prio:0 weight:0] [message] 2016-04-08 11:39:37:741 Starting A/AAAA query for srv result [gvgw10.simonics.com.] [message] 2016-04-08 11:39:37:741 Resolver is using DNS server(s): [message] 2016-04-08 11:39:37:741 75.75.75.75 [message] 2016-04-08 11:39:37:741 75.75.76.76 [message] 2016-04-08 11:39:37:741 resolver_process_data dns_res_check() in progress [message] 2016-04-08 11:39:37:741 DNS resolution awaiting response, queued to main loop [message] 2016-04-08 11:39:37:741 Starting A/AAAA query for srv result [gvgw11.simonics.com.] [message] 2016-04-08 11:39:37:741 Resolver is using DNS server(s): [message] 2016-04-08 11:39:37:741 75.75.75.75 [message] 2016-04-08 11:39:37:741 75.75.76.76 [message] 2016-04-08 11:39:37:741 resolver_process_data dns_res_check() in progress [message] 2016-04-08 11:39:37:741 DNS resolution awaiting response, queued to main loop [message] 2016-04-08 11:39:37:741 Starting A/AAAA query for srv result [gvgw12.simonics.com.] [message] 2016-04-08 11:39:37:741 Resolver is using DNS server(s): [message] 2016-04-08 11:39:37:741 75.75.75.75 [message] 2016-04-08 11:39:37:741 75.75.76.76 [message] 2016-04-08 11:39:37:742 resolver_process_data dns_res_check() in progress [message] 2016-04-08 11:39:37:742 DNS resolution awaiting response, queued to main loop [message] 2016-04-08 11:39:37:742 Starting A/AAAA query for srv result [gvgw13.simonics.com.] [message] 2016-04-08 11:39:37:742 Resolver is using DNS server(s): [message] 2016-04-08 11:39:37:742 75.75.75.75 [message] 2016-04-08 11:39:37:742 75.75.76.76 [message] 2016-04-08 11:39:37:742 resolver_process_data dns_res_check() in progress [message] 2016-04-08 11:39:37:742 DNS resolution awaiting response, queued to main loop [message] 2016-04-08 11:39:37:786 No directory for music, using [/home/martin] instead [message] 2016-04-08 11:39:37:786 New LinphoneCall [0x1b7ad70] initialized (LinphoneCore version: 3.9.1) [message] 2016-04-08 11:39:37:787 Call 0x1b7ad70: moving from state LinphoneCallIdle to LinphoneCallOutgoingInit [message] 2016-04-08 11:39:37:793 Call 0x1b7ad70 is locking sound resources. [message] 2016-04-08 11:39:37:793 Linphone core [0x19a8760] notifying [call_state_changed] [message] 2016-04-08 11:39:37:793 Cannot determine multicast role for stream type [audio] on call [0x1b7ad70] [message] 2016-04-08 11:39:37:793 RtpSession bound to [0.0.0.0] ports [7078] [7079] [message] 2016-04-08 11:39:37:793 Setting DSCP to 46 for MSAudio stream. [message] 2016-04-08 11:39:37:793 Equalizer location: hp [message] 2016-04-08 11:39:37:794 cannot set noise gate mode to [0] because no volume send [message] 2016-04-08 11:39:37:794 Cannot determine multicast role for stream type [video] on call [0x1b7ad70] [message] 2016-04-08 11:39:37:794 RtpSession bound to [0.0.0.0] ports [9078] [9079] [message] 2016-04-08 11:39:37:794 Setting DSCP to 0 for MSVideo stream. [message] 2016-04-08 11:39:37:794 Contact has been fixed using proxy [message] 2016-04-08 11:39:37:794 Don't put video stream on local offer for call [0x1b7ad70] [message] 2016-04-08 11:39:37:794 Don't put text stream on local offer for call [0x1b7ad70] [message] 2016-04-08 11:39:37:794 ms_filter_link: MSRtpRecv:0x1b50c70,0-->MSVoidSink:0x1b5d520,0 [message] 2016-04-08 11:39:37:794 Priority used: 99 [message] 2016-04-08 11:39:37:794 MSAudio MSTicker setpriority() failed: Permission denied, nevermind. [message] 2016-04-08 11:39:37:794 [sip:address@hidden calling [sip:address@hidden on op [0x1b22700] [message] 2016-04-08 11:39:37:794 Skipping top route of initial route-set because same as request-uri. [message] 2016-04-08 11:39:37:794 Linphone core [0x19a8760] notifying [display_status] [message] 2016-04-08 11:39:37:794 Call 0x1b7ad70: moving from state LinphoneCallOutgoingInit to LinphoneCallOutgoingProgress [message] 2016-04-08 11:39:37:795 Call 0x1b7ad70 is locking sound resources. [message] 2016-04-08 11:39:37:795 Linphone core [0x19a8760] notifying [call_state_changed] [message] 2016-04-08 11:39:37:823 gvgw10.simonics.com. resolved to 104.236.102.59 [message] 2016-04-08 11:39:37:823 A query finished for srv result [gvgw10.simonics.com.] [message] 2016-04-08 11:39:37:823 gvgw11.simonics.com. resolved to 45.55.163.124 [message] 2016-04-08 11:39:37:823 A query finished for srv result [gvgw11.simonics.com.] [message] 2016-04-08 11:39:37:823 gvgw13.simonics.com. resolved to 162.243.107.101 [message] 2016-04-08 11:39:37:823 A query finished for srv result [gvgw13.simonics.com.] [message] 2016-04-08 11:39:37:884 gvgw12.simonics.com. resolved to 198.199.84.66 [message] 2016-04-08 11:39:37:884 A query finished for srv result [gvgw12.simonics.com.] [message] 2016-04-08 11:39:37:884 All A/AAAA results for combined resolution have arrived. [message] 2016-04-08 11:39:37:884 channel 0x1afcd40: state RES_DONE [message] 2016-04-08 11:39:37:884 transaction [0x1af21f0] channel state changed to [RES_DONE] [message] 2016-04-08 11:39:37:884 transaction [0x1b64ca0] channel state changed to [RES_DONE] [message] 2016-04-08 11:39:37:884 channel 0x1afcd40: state CONNECTING [message] 2016-04-08 11:39:37:884 transaction [0x1af21f0] channel state changed to [CONNECTING] [message] 2016-04-08 11:39:37:884 transaction [0x1b64ca0] channel state changed to [CONNECTING] [message] 2016-04-08 11:39:37:884 Trying to connect to [UDP://104.236.102.59:5060] [message] 2016-04-08 11:39:37:884 belle_sip_get_src_addr_for(): af_inet6=0 [message] 2016-04-08 11:39:37:884 Channel has local address 192.168.0.17:5060 [message] 2016-04-08 11:39:37:884 channel 0x1afcd40: state READY [message] 2016-04-08 11:39:37:884 transaction [0x1af21f0] channel state changed to [READY] [message] 2016-04-08 11:39:37:884 Changing [client] [REGISTER] transaction [0x1af21f0], from state [INIT] to [TRYING] [message] 2016-04-08 11:39:37:884 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [547] bytes REGISTER sip:gvgw.simonics.com SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.ShKR8bjOH;rport From: ;tag=7U3IwDT-M To: sip:address@hidden CSeq: 20 REGISTER Call-ID: 6dZKHh8UKE Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 3600 User-Agent: Linphone/3.9.1 (belle-sip/1.4.2) [message] 2016-04-08 11:39:37:884 transaction [0x1b64ca0] channel state changed to [READY] [message] 2016-04-08 11:39:37:884 Changing [client] [INVITE] transaction [0x1b64ca0], from state [INIT] to [CALLING] [message] 2016-04-08 11:39:37:884 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [1040] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.EucS9yxED;rport From: ;tag=mvyxMVnR8 To: sip:address@hidden CSeq: 20 INVITE Call-ID: to0l4UtAZh Max-Forwards: 70 Supported: outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 452 Contact: ;+sip.instance="" User-Agent: Linphone/3.9.1 (belle-sip/1.4.2) v=0 o=gv13106993578 1077 377 IN IP4 192.168.0.17 s=Talk c=IN IP4 192.168.0.17 t=0 0 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 7078 RTP/AVP 96 97 98 0 8 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 [message] 2016-04-08 11:39:38:006 channel [0x1afcd40]: received [290] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.ShKR8bjOH;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden Call-ID: 6dZKHh8UKE CSeq: 20 REGISTER Server: GVGW Content-Length: 0 [message] 2016-04-08 11:39:38:007 channel [0x1afcd40] [290] bytes parsed [message] 2016-04-08 11:39:38:007 channel [0x1afcd40]: discovered public ip and port are [73.240.34.98:61092] [message] 2016-04-08 11:39:38:007 Found transaction matching response. [message] 2016-04-08 11:39:38:007 Changing [client] [REGISTER] transaction [0x1af21f0], from state [TRYING] to [PROCEEDING] [message] 2016-04-08 11:39:38:007 Refresher: scheduling next timer in 60000 ms [message] 2016-04-08 11:39:38:007 Register refresher [100] reason [Trying] for proxy [sip:gvgw.simonics.com] [message] 2016-04-08 11:39:38:037 channel [0x1afcd40]: received [285] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.EucS9yxED;rport=61092;received=73.240.34.98 From: ;tag=mvyxMVnR8 To: sip:address@hidden Call-ID: to0l4UtAZh CSeq: 20 INVITE Server: GVGW Content-Length: 0 [message] 2016-04-08 11:39:38:038 channel [0x1afcd40] [285] bytes parsed [message] 2016-04-08 11:39:38:038 Found transaction matching response. [message] 2016-04-08 11:39:38:038 Changing [client] [INVITE] transaction [0x1b64ca0], from state [CALLING] to [PROCEEDING] [message] 2016-04-08 11:39:38:038 op [0x1b22700] : set_or_update_dialog() current=[(nil)] new=[(nil)] [message] 2016-04-08 11:39:38:038 Op [0x1b22700] receiving call response [100], dialog is [(nil)] in state [BELLE_SIP_DIALOG_NULL] [message] 2016-04-08 11:39:38:067 channel [0x1afcd40]: received [481] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.ShKR8bjOH;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden Call-ID: 6dZKHh8UKE CSeq: 20 REGISTER WWW-Authenticate: Digest realm="GVGW", nonce="d633dde62ff078b514aa236e8e0f4247.1460140736", stale=FALSE, algorithm=MD5 Server: GVGW Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 [message] 2016-04-08 11:39:38:068 channel [0x1afcd40] [481] bytes parsed [message] 2016-04-08 11:39:38:068 Found transaction matching response. [message] 2016-04-08 11:39:38:068 Changing [client] [REGISTER] transaction [0x1af21f0], from state [PROCEEDING] to [COMPLETED] [message] 2016-04-08 11:39:38:068 linphone_core_find_auth_info(): returning auth info username=gv13106993578, realm=GVGW [message] 2016-04-08 11:39:38:068 Auth info found for [gv13106993578] realm [GVGW] [message] 2016-04-08 11:39:38:068 Changing [client] [REGISTER] transaction [0x1c20870], from state [INIT] to [TRYING] [message] 2016-04-08 11:39:38:069 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [759] bytes REGISTER sip:gvgw.simonics.com SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.Tkd2VglRo;rport From: ;tag=7U3IwDT-M To: sip:address@hidden CSeq: 21 REGISTER Call-ID: 6dZKHh8UKE Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 3600 User-Agent: Linphone/3.9.1 (belle-sip/1.4.2) Authorization: Digest realm="GVGW", nonce="d633dde62ff078b514aa236e8e0f4247.1460140736", algorithm=MD5, username="gv13106993578", uri="sip:gvgw.simonics.com", response="7943f10113a9ae75be4c582c74362d55" [message] 2016-04-08 11:39:38:128 channel [0x1afcd40]: received [523] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.EucS9yxED;rport=61092;received=73.240.34.98 From: ;tag=mvyxMVnR8 To: sip:address@hidden Call-ID: to0l4UtAZh CSeq: 20 INVITE WWW-Authenticate: Digest realm="GVGW", nonce="d633dde62ff078b514aa236e8e0f4247.1460140736", stale=FALSE, algorithm=MD5 Server: GVGW Contact: Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 [message] 2016-04-08 11:39:38:130 channel [0x1afcd40] [523] bytes parsed [message] 2016-04-08 11:39:38:130 Found transaction matching response. [message] 2016-04-08 11:39:38:130 Changing [client] [INVITE] transaction [0x1b64ca0], from state [PROCEEDING] to [COMPLETED] [message] 2016-04-08 11:39:38:130 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [378] bytes ACK sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.EucS9yxED;rport Call-ID: to0l4UtAZh From: ;tag=mvyxMVnR8 To: sip:address@hidden Contact: ;+sip.instance="" Max-Forwards: 70 CSeq: 20 ACK [message] 2016-04-08 11:39:38:130 linphone_core_find_auth_info(): returning auth info username=gv13106993578, realm=GVGW [message] 2016-04-08 11:39:38:130 Auth info found for [gv13106993578] realm [GVGW] [message] 2016-04-08 11:39:38:130 Changing [client] [INVITE] transaction [0x1bd0bc0], from state [INIT] to [CALLING] [message] 2016-04-08 11:39:38:130 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [1263] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.nWMfYNAI2;rport From: ;tag=mvyxMVnR8 To: sip:address@hidden CSeq: 21 INVITE Call-ID: to0l4UtAZh Max-Forwards: 70 Supported: outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 452 Contact: ;+sip.instance="" User-Agent: Linphone/3.9.1 (belle-sip/1.4.2) Authorization: Digest realm="GVGW", nonce="d633dde62ff078b514aa236e8e0f4247.1460140736", algorithm=MD5, username="gv13106993578", uri="sip:address@hidden", response="17b365e02af139ab2c074787fbf8672b" v=0 o=gv13106993578 1077 377 IN IP4 192.168.0.17 s=Talk c=IN IP4 192.168.0.17 t=0 0 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 7078 RTP/AVP 96 97 98 0 8 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 [message] 2016-04-08 11:39:38:219 channel [0x1afcd40]: received [290] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.Tkd2VglRo;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden Call-ID: 6dZKHh8UKE CSeq: 21 REGISTER Server: GVGW Content-Length: 0 [message] 2016-04-08 11:39:38:221 channel [0x1afcd40] [290] bytes parsed [message] 2016-04-08 11:39:38:221 Found transaction matching response. [message] 2016-04-08 11:39:38:221 Changing [client] [REGISTER] transaction [0x1c20870], from state [TRYING] to [PROCEEDING] [message] 2016-04-08 11:39:38:221 Refresher: scheduling next timer in 60000 ms [message] 2016-04-08 11:39:38:221 Register refresher [100] reason [Trying] for proxy [sip:gvgw.simonics.com] [message] 2016-04-08 11:39:38:250 channel [0x1afcd40]: received [285] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.nWMfYNAI2;rport=61092;received=73.240.34.98 From: ;tag=mvyxMVnR8 To: sip:address@hidden Call-ID: to0l4UtAZh CSeq: 21 INVITE Server: GVGW Content-Length: 0 [message] 2016-04-08 11:39:38:252 channel [0x1afcd40] [285] bytes parsed [message] 2016-04-08 11:39:38:252 Found transaction matching response. [message] 2016-04-08 11:39:38:252 Changing [client] [INVITE] transaction [0x1bd0bc0], from state [CALLING] to [PROCEEDING] [message] 2016-04-08 11:39:38:252 op [0x1b22700] : set_or_update_dialog() current=[(nil)] new=[(nil)] [message] 2016-04-08 11:39:38:252 Op [0x1b22700] receiving call response [100], dialog is [(nil)] in state [BELLE_SIP_DIALOG_NULL] [message] 2016-04-08 11:39:38:282 channel [0x1afcd40]: received [443] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.Tkd2VglRo;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden;tag=1647486965 Call-ID: 6dZKHh8UKE CSeq: 21 REGISTER Expires: 3600 Contact: ;expires=3600 Server: GVGW Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 [message] 2016-04-08 11:39:38:283 channel [0x1afcd40] [443] bytes parsed [message] 2016-04-08 11:39:38:283 Found transaction matching response. [message] 2016-04-08 11:39:38:283 Changing [client] [REGISTER] transaction [0x1c20870], from state [PROCEEDING] to [COMPLETED] [message] 2016-04-08 11:39:38:283 Refresher [0x1af7020]: has no contact for request [0x1c18000]. [message] 2016-04-08 11:39:38:283 Refresher: scheduling next timer in 3240000 ms [message] 2016-04-08 11:39:38:283 Register refresher [200] reason [OK] for proxy [sip:gvgw.simonics.com] [message] 2016-04-08 11:39:38:283 Proxy config [0x1a1d0e0] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationOk] [message] 2016-04-08 11:39:38:285 Linphone core [0x19a8760] notifying [registration_state_changed] [message] 2016-04-08 11:39:38:285 Linphone core [0x19a8760] notifying [display_status] [message] 2016-04-08 11:39:38:343 channel [0x1afcd40]: received [414] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 404 No route to call target Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.nWMfYNAI2;rport=61092;received=73.240.34.98 From: ;tag=mvyxMVnR8 To: sip:address@hidden Call-ID: to0l4UtAZh CSeq: 21 INVITE Server: GVGW Contact: Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 [message] 2016-04-08 11:39:38:344 channel [0x1afcd40] [414] bytes parsed [message] 2016-04-08 11:39:38:344 Found transaction matching response. [message] 2016-04-08 11:39:38:344 Changing [client] [INVITE] transaction [0x1bd0bc0], from state [PROCEEDING] to [COMPLETED] [message] 2016-04-08 11:39:38:344 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [378] bytes ACK sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.nWMfYNAI2;rport Call-ID: to0l4UtAZh From: ;tag=mvyxMVnR8 To: sip:address@hidden Contact: ;+sip.instance="" Max-Forwards: 70 CSeq: 21 ACK [message] 2016-04-08 11:39:38:344 op [0x1b22700] : set_or_update_dialog() current=[(nil)] new=[(nil)] [message] 2016-04-08 11:39:38:344 Op [0x1b22700] receiving call response [404], dialog is [(nil)] in state [BELLE_SIP_DIALOG_NULL] [message] 2016-04-08 11:39:38:344 Linphone core [0x19a8760] notifying [display_status] [message] 2016-04-08 11:39:38:344 ms_filter_unlink: MSRtpRecv:0x1b50c70,0-->MSVoidSink:0x1b5d520,0 [message] 2016-04-08 11:39:38:344 =========================================================== [message] 2016-04-08 11:39:38:344 FILTER USAGE STATISTICS [message] 2016-04-08 11:39:38:344 Name Count Time/tick (ms) CPU Usage [message] 2016-04-08 11:39:38:344 ----------------------------------------------------------- [message] 2016-04-08 11:39:38:344 MSRtpRecv 56 0.0116404 99.9998 [message] 2016-04-08 11:39:38:344 MSVoidSink 0 0 0 [message] 2016-04-08 11:39:38:344 MSSpeexEC 0 0 0 [message] 2016-04-08 11:39:38:344 MSRtpSend 0 0 0 [message] 2016-04-08 11:39:38:344 =========================================================== [message] 2016-04-08 11:39:38:344 Call 0x1b7ad70: moving from state LinphoneCallOutgoingProgress to LinphoneCallError [message] 2016-04-08 11:39:38:354 MSAudio MSTicker thread exiting [message] 2016-04-08 11:39:38:428 linphone_core_get_call_history(): completed in 3 ms [message] 2016-04-08 11:39:38:429 Linphone core [0x19a8760] notifying [call_log_updated] [message] 2016-04-08 11:39:38:429 Resetting the current call [message] 2016-04-08 11:39:38:430 Linphone core [0x19a8760] notifying [call_state_changed] [message] 2016-04-08 11:39:38:430 Call 0x1b7ad70: moving from state LinphoneCallError to LinphoneCallReleased [message] 2016-04-08 11:39:38:430 Linphone core [0x19a8760] notifying [call_state_changed] [message] 2016-04-08 11:39:38:430 op [0x1b22700] : set_or_update_dialog() current=[(nil)] new=[(nil)] [message] 2016-04-08 11:39:40:271 Call [0x1b7ad70] freed. [message] 2016-04-08 11:39:43:085 Changing [client] [REGISTER] transaction [0x1af21f0], from state [COMPLETED] to [TERMINATED] [message] 2016-04-08 11:39:43:085 Client internal REGISTER transaction [0x1af21f0] terminated [message] 2016-04-08 11:39:43:297 Changing [client] [REGISTER] transaction [0x1c20870], from state [COMPLETED] to [TERMINATED] [message] 2016-04-08 11:39:43:297 Client internal REGISTER transaction [0x1c20870] terminated [message] 2016-04-08 11:39:47:640 channel [0x1afcd40]: keep alive sent to [UDP://gvgw.simonics.com:5060] [message] 2016-04-08 11:39:48:161 Linphone core [0x19a8760] notifying [global_state_changed] [message] 2016-04-08 11:39:48:161 Destroying friends. [message] 2016-04-08 11:39:48:161 Destroying friends done. [message] 2016-04-08 11:39:48:161 linphone_core_find_auth_info(): returning auth info username=gv13106993578, realm=GVGW [message] 2016-04-08 11:39:48:161 Auth info found for [gv13106993578] realm [GVGW] [message] 2016-04-08 11:39:48:161 Changing [client] [REGISTER] transaction [0x1883480], from state [INIT] to [TRYING] [message] 2016-04-08 11:39:48:162 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [756] bytes REGISTER sip:gvgw.simonics.com SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.WNfF~YHkN;rport From: ;tag=7U3IwDT-M To: sip:address@hidden CSeq: 22 REGISTER Call-ID: 6dZKHh8UKE Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 0 User-Agent: Linphone/3.9.1 (belle-sip/1.4.2) Authorization: Digest realm="GVGW", nonce="d633dde62ff078b514aa236e8e0f4247.1460140736", algorithm=MD5, username="gv13106993578", uri="sip:gvgw.simonics.com", response="7943f10113a9ae75be4c582c74362d55" [message] 2016-04-08 11:39:48:162 Refresher [0x1af7020] stopped. [message] 2016-04-08 11:39:48:162 Unregistration started. [message] 2016-04-08 11:39:48:362 channel [0x1afcd40]: received [290] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.WNfF~YHkN;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden Call-ID: 6dZKHh8UKE CSeq: 22 REGISTER Server: GVGW Content-Length: 0 [message] 2016-04-08 11:39:48:363 channel [0x1afcd40] [290] bytes parsed [message] 2016-04-08 11:39:48:363 Found transaction matching response. [message] 2016-04-08 11:39:48:363 Changing [client] [REGISTER] transaction [0x1883480], from state [TRYING] to [PROCEEDING] [message] 2016-04-08 11:39:48:363 Register refresher [100] reason [Trying] for proxy [sip:gvgw.simonics.com] [message] 2016-04-08 11:39:48:464 channel [0x1afcd40]: received [480] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.WNfF~YHkN;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden Call-ID: 6dZKHh8UKE CSeq: 22 REGISTER WWW-Authenticate: Digest realm="GVGW", nonce="85813b22679b8e6cf0c315525f0b7ca5.1460140747", stale=TRUE, algorithm=MD5 Server: GVGW Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 [message] 2016-04-08 11:39:48:465 channel [0x1afcd40] [480] bytes parsed [message] 2016-04-08 11:39:48:465 Found transaction matching response. [message] 2016-04-08 11:39:48:465 Changing [client] [REGISTER] transaction [0x1883480], from state [PROCEEDING] to [COMPLETED] [message] 2016-04-08 11:39:48:465 linphone_core_find_auth_info(): returning auth info username=gv13106993578, realm=GVGW [message] 2016-04-08 11:39:48:465 Auth info found for [gv13106993578] realm [GVGW] [message] 2016-04-08 11:39:48:465 Changing [client] [REGISTER] transaction [0x1a23000], from state [INIT] to [TRYING] [message] 2016-04-08 11:39:48:465 channel [0x1afcd40]: message sent to [UDP://gvgw.simonics.com:5060], size: [756] bytes REGISTER sip:gvgw.simonics.com SIP/2.0 Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.BXbh5Esq1;rport From: ;tag=7U3IwDT-M To: sip:address@hidden CSeq: 23 REGISTER Call-ID: 6dZKHh8UKE Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 0 User-Agent: Linphone/3.9.1 (belle-sip/1.4.2) Authorization: Digest realm="GVGW", nonce="85813b22679b8e6cf0c315525f0b7ca5.1460140747", algorithm=MD5, username="gv13106993578", uri="sip:gvgw.simonics.com", response="4bc4d8e3db360ed3abbf0f1cf527ca12" [message] 2016-04-08 11:39:48:465 Refresher [0x1af7020] stopped. [message] 2016-04-08 11:39:48:666 channel [0x1afcd40]: received [290] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.BXbh5Esq1;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden Call-ID: 6dZKHh8UKE CSeq: 23 REGISTER Server: GVGW Content-Length: 0 [message] 2016-04-08 11:39:48:667 channel [0x1afcd40] [290] bytes parsed [message] 2016-04-08 11:39:48:667 Found transaction matching response. [message] 2016-04-08 11:39:48:667 Changing [client] [REGISTER] transaction [0x1a23000], from state [TRYING] to [PROCEEDING] [message] 2016-04-08 11:39:48:667 Register refresher [100] reason [Trying] for proxy [sip:gvgw.simonics.com] [message] 2016-04-08 11:39:48:767 channel [0x1afcd40]: received [366] new bytes from [UDP://gvgw.simonics.com:5060]: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK.BXbh5Esq1;rport=61092;received=73.240.34.98 From: ;tag=7U3IwDT-M To: sip:address@hidden;tag=1634789970 Call-ID: 6dZKHh8UKE CSeq: 23 REGISTER Server: GVGW Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 [message] 2016-04-08 11:39:48:769 channel [0x1afcd40] [366] bytes parsed [message] 2016-04-08 11:39:48:769 Found transaction matching response. [message] 2016-04-08 11:39:48:769 Changing [client] [REGISTER] transaction [0x1a23000], from state [PROCEEDING] to [COMPLETED] [message] 2016-04-08 11:39:48:769 Neither Expires header nor corresponding Contact header found, checking from original request [message] 2016-04-08 11:39:48:769 Refresher [0x1af7020] stopped. [message] 2016-04-08 11:39:48:769 Refresher [0x1af7020] not scheduling next refresh, because it was stopped [message] 2016-04-08 11:39:48:769 Register refresher [200] reason [OK] for proxy [sip:gvgw.simonics.com] [message] 2016-04-08 11:39:48:769 Proxy config [0x1a1d0e0] for identity [sip:address@hidden moving from state [LinphoneRegistrationOk] to [LinphoneRegistrationCleared] [message] 2016-04-08 11:39:48:769 Linphone core [0x19a8760] notifying [registration_state_changed] [message] 2016-04-08 11:39:48:769 Linphone core [0x19a8760] notifying [display_status] [message] 2016-04-08 11:39:48:769 Garbage collecting unowned object of type belle_sip_header_contact_t [message] 2016-04-08 11:39:48:769 Garbage collecting unowned object of type belle_sip_header_contact_t [message] 2016-04-08 11:39:48:869 Refresher [0x1af7020] stopped. [message] 2016-04-08 11:39:48:869 Destroying op [0x1a75280] of type [SalOpRegister] [message] 2016-04-08 11:39:48:869 Refresher [0x1af7020] stopped. [message] 2016-04-08 11:39:48:869 Reseting transports [message] 2016-04-08 11:39:48:869 Listening point destroying [1] channels [message] 2016-04-08 11:39:48:869 channel 0x1afcd40: state DISCONNECTED [message] 2016-04-08 11:39:48:869 transaction [0x1b64ca0] channel state changed to [DISCONNECTED] [message] 2016-04-08 11:39:48:869 Changing [client] [INVITE] transaction [0x1b64ca0], from state [COMPLETED] to [TERMINATED] [message] 2016-04-08 11:39:48:869 Client INVITE transaction [0x1b64ca0] terminated [message] 2016-04-08 11:39:48:869 transaction [0x1bd0bc0] channel state changed to [DISCONNECTED] [message] 2016-04-08 11:39:48:869 Changing [client] [INVITE] transaction [0x1bd0bc0], from state [COMPLETED] to [TERMINATED] [message] 2016-04-08 11:39:48:869 Client INVITE transaction [0x1bd0bc0] terminated [message] 2016-04-08 11:39:48:869 Destroying op [0x1b22700] of type [SalOpCall] [message] 2016-04-08 11:39:48:869 transaction [0x1883480] channel state changed to [DISCONNECTED] [message] 2016-04-08 11:39:48:869 Changing [client] [REGISTER] transaction [0x1883480], from state [COMPLETED] to [TERMINATED] [message] 2016-04-08 11:39:48:869 Client internal REGISTER transaction [0x1883480] terminated [message] 2016-04-08 11:39:48:869 transaction [0x1a23000] channel state changed to [DISCONNECTED] [message] 2016-04-08 11:39:48:869 Changing [client] [REGISTER] transaction [0x1a23000], from state [COMPLETED] to [TERMINATED] [message] 2016-04-08 11:39:48:869 Client internal REGISTER transaction [0x1a23000] terminated [message] 2016-04-08 11:39:48:870 Channel [0x1afcd40] destroyed [message] 2016-04-08 11:39:48:870 Listening point [0x1a1a0b0] on [sip:0.0.0.0:5060;transport=UDP] destroyed [message] 2016-04-08 11:39:48:870 Listening point [0x1a1a5c0] on [sip:0.0.0.0:5060;transport=TCP] destroyed [message] 2016-04-08 11:39:48:870 sal_unlisten_ports done [message] 2016-04-08 11:39:48:870 http provider destroyed. [message] 2016-04-08 11:39:48:870 stack [0x1a18430] destroyed. [message] 2016-04-08 11:39:48:870 Linphone core [0x19a8760] notifying [global_state_changed] --------