2015-02-24 01:56:17:009 WARNING Codec opus/48000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:024 WARNING Codec SILK/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:024 WARNING Codec speex/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:024 WARNING Codec speex/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:040 WARNING Codec PCMU/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:040 WARNING Codec PCMA/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:040 WARNING Codec GSM/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:040 WARNING Codec G722/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:056 WARNING Codec iLBC/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:056 WARNING Codec AMR/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:056 WARNING Codec AMR-WB/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:071 WARNING Codec iSAC/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:071 WARNING Codec speex/32000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:071 WARNING Codec SILK/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:071 WARNING Codec SILK/12000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:071 WARNING Codec SILK/24000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:087 WARNING Codec L16/44100 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:087 WARNING Codec L16/44100 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:17:087 WARNING Codec H264/90000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:26:549 MESSAGE Auth info found for [901489] realm [87.123.123.90] 2015-02-24 01:56:26:552 MESSAGE Changing [client] [REGISTER] transaction [032B18E8], from state [INIT] to [TRYING] 2015-02-24 01:56:26:559 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [662] bytes REGISTER sip:87.123.123.90 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.gn4Kq5Tbv;rport From: "901489" ;tag=qLn38qzzw To: "901489" CSeq: 22 REGISTER Call-ID: u9Bz5-68ZF Max-Forwards: 70 Supported: outbound Contact: ;+sip.instance="" Expires: 28800 User-Agent: LinphoneWP8/2a58c60 (belle-sip/1.3.3) Authorization: Digest realm="87.123.123.90", nonce="145134fa8037eecd23e2207ab0a7f8c7", algorithm=MD5, opaque="", username="901489", uri="sip:87.123.123.90", response="204843ca406c668165933a570477954d" 2015-02-24 01:56:26:794 MESSAGE channel [032B5F80]: received [248] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.gn4Kq5Tbv From: "901489" ;tag=qLn38qzzw To: "901489" CSeq: 22 REGISTER Call-ID: u9Bz5-68ZF Content-Length: 0 2015-02-24 01:56:26:826 MESSAGE channel [032B5F80] [248] bytes parsed 2015-02-24 01:56:26:826 MESSAGE Found transaction matching response. 2015-02-24 01:56:26:826 MESSAGE Changing [client] [REGISTER] transaction [032B18E8], from state [TRYING] to [PROCEEDING] 2015-02-24 01:56:26:826 MESSAGE Refresher: scheduling next timer in 60000 ms 2015-02-24 01:56:26:826 MESSAGE Register refresher [100] reason [Trying] for proxy [] 2015-02-24 01:56:26:847 MESSAGE channel [032B5F80]: received [329] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.gn4Kq5Tbv From: "901489" ;tag=qLn38qzzw CSeq: 22 REGISTER Call-ID: u9Bz5-68ZF To: "901489" ;tag=1424725706306 Expires: 50 Contact: ;expires=50 Content-Length: 0 2015-02-24 01:56:26:871 MESSAGE channel [032B5F80] [329] bytes parsed 2015-02-24 01:56:26:873 MESSAGE Found transaction matching response. 2015-02-24 01:56:26:874 MESSAGE Changing [client] [REGISTER] transaction [032B18E8], from state [PROCEEDING] to [COMPLETED] 2015-02-24 01:56:26:875 MESSAGE Refresher [00B8C068]: has no contact for request [032C6760]. 2015-02-24 01:56:26:875 MESSAGE Refresher: scheduling next timer in 45000 ms 2015-02-24 01:56:26:876 MESSAGE Register refresher [200] reason [OK] for proxy [] 2015-02-24 01:56:26:876 MESSAGE Proxy config [00B67928] for identity ["901489" ] moving from state [LinphoneRegistrationOk] to [LinphoneRegistrationOk] 2015-02-24 01:56:26:877 MESSAGE Linphone core [032664A8] notifying [registration_state_changed] 2015-02-24 01:56:26:878 MESSAGE Linphone core [032664A8] notifying [display_status] 2015-02-24 01:56:26:879 MESSAGE Garbage collecting unowned object of type belle_sip_header_contact_t 2015-02-24 01:56:26:913 MESSAGE [LinphoneManager] Registration state changed: RegistrationOk, message=Registration successful for identity "901489" 2015-02-24 01:56:29:206 WARNING Codec opus/48000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:221 WARNING Codec SILK/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:221 WARNING Codec speex/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:221 WARNING Codec speex/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:237 WARNING Codec PCMU/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:237 WARNING Codec PCMA/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:237 WARNING Codec GSM/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:237 WARNING Codec G722/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:253 WARNING Codec iLBC/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:253 WARNING Codec AMR/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:253 WARNING Codec AMR-WB/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:253 WARNING Codec iSAC/16000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:268 WARNING Codec speex/32000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:268 WARNING Codec SILK/8000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:268 WARNING Codec SILK/12000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:268 WARNING Codec SILK/24000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:284 WARNING Codec L16/44100 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:284 WARNING Codec L16/44100 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:29:284 WARNING Codec H264/90000 supported by core is not shown in the settings view, disable it 2015-02-24 01:56:31:898 MESSAGE Changing [client] [REGISTER] transaction [032B18E8], from state [COMPLETED] to [TERMINATED] 2015-02-24 01:56:31:898 MESSAGE Client internal REGISTER transaction [032B18E8] terminated 2015-02-24 01:56:35:151 MESSAGE New LinphoneCall [032A0F80] initialized (LinphoneCore version: 3.7.0-1625-g209219b) 2015-02-24 01:56:35:182 MESSAGE Call 032A0F80: moving from state LinphoneCallIdle to LinphoneCallOutgoingInit 2015-02-24 01:56:35:182 MESSAGE Linphone core [032664A8] notifying [call_state_changed] 2015-02-24 01:56:35:182 MESSAGE RtpSession bound to [0.0.0.0] ports [7076] [7077] 2015-02-24 01:56:35:182 MESSAGE Setting DSCP to 46 for MSAudio stream. 2015-02-24 01:56:35:182 MESSAGE Equalizer location: hp 2015-02-24 01:56:35:182 ERROR Could not open C:\Data\Users\DefApps\AppData\{BB0B8F3F-8638-49CF-B968-E097A2E6CBBE}\local\/.linphone.ecstate for read. No such file or directory 2015-02-24 01:56:35:182 MESSAGE cannot set noise gate mode to [0] because no volume send 2015-02-24 01:56:35:197 MESSAGE RtpSession bound to [0.0.0.0] ports [9078] [9079] 2015-02-24 01:56:35:197 MESSAGE Setting DSCP to 0 for MSVideo stream. 2015-02-24 01:56:35:197 MESSAGE Contact has been fixed using proxy 2015-02-24 01:56:35:197 MESSAGE ms_filter_link: MSRtpRecv:032D3888,0-->MSVoidSink:032D38E8,0 2015-02-24 01:56:35:197 MESSAGE ["901489" ] calling [sip:address@hidden on op [03257660] 2015-02-24 01:56:35:197 MESSAGE Skipping top route of initial route-set because same as request-uri. 2015-02-24 01:56:35:197 MESSAGE Changing [client] [INVITE] transaction [00B1C528], from state [INIT] to [CALLING] 2015-02-24 01:56:35:213 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [831] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.cHDMcR3~g;rport From: "901489" ;tag=d6gccJoUc To: sip:address@hidden CSeq: 20 INVITE Call-ID: vkCbcvtXZ2 Max-Forwards: 70 Supported: outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 242 Contact: ;+sip.instance="" User-Agent: LinphoneWP8/2a58c60 (belle-sip/1.3.3) v=0 o=901489 41 2083 IN IP4 192.168.1.104 s=Talk c=IN IP4 192.168.1.104 t=0 0 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 7076 RTP/AVP 18 101 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 2015-02-24 01:56:35:213 MESSAGE Linphone core [032664A8] notifying [display_status] 2015-02-24 01:56:35:213 MESSAGE Call 032A0F80: moving from state LinphoneCallOutgoingInit to LinphoneCallOutgoingProgress 2015-02-24 01:56:35:213 MESSAGE Linphone core [032664A8] notifying [call_state_changed] 2015-02-24 01:56:35:250 MESSAGE [LinphoneManager] Outgoing progress 2015-02-24 01:56:35:262 MESSAGE [LinphoneManager] Display name null, looking for remote address in contact: address@hidden 2015-02-24 01:56:35:317 MESSAGE [LinphoneManager] AudioEndpointChanged:Earpiece 2015-02-24 01:56:35:317 MESSAGE [LinphoneManager] AudioEndpointChanged:Earpiece 2015-02-24 01:56:35:317 MESSAGE [LinphoneManager] AudioEndpointChanged:Earpiece 2015-02-24 01:56:35:317 MESSAGE [LinphoneManager] AudioEndpointChanged:Earpiece 2015-02-24 01:56:35:692 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [831] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.cHDMcR3~g;rport From: "901489" ;tag=d6gccJoUc To: sip:address@hidden CSeq: 20 INVITE Call-ID: vkCbcvtXZ2 Max-Forwards: 70 Supported: outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 242 Contact: ;+sip.instance="" User-Agent: LinphoneWP8/2a58c60 (belle-sip/1.3.3) v=0 o=901489 41 2083 IN IP4 192.168.1.104 s=Talk c=IN IP4 192.168.1.104 t=0 0 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 7076 RTP/AVP 18 101 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 2015-02-24 01:56:35:883 MESSAGE channel [032B5F80]: received [393] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 407 Proxy Authentication required Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.cHDMcR3~g From: "901489" ;tag=d6gccJoUc To: CSeq: 20 INVITE Call-ID: vkCbcvtXZ2 Proxy-Authenticate: Digest nonce="00dd3c5fda36ba75edbface3362f3b90",realm="87.123.123.90",opaque="",stale=FALSE,algorithm=MD5 Content-Length: 0 2015-02-24 01:56:35:930 MESSAGE channel [032B5F80] [393] bytes parsed 2015-02-24 01:56:35:930 MESSAGE Found transaction matching response. 2015-02-24 01:56:35:930 MESSAGE Changing [client] [INVITE] transaction [00B1C528], from state [CALLING] to [PROCEEDING] 2015-02-24 01:56:35:930 MESSAGE Changing [client] [INVITE] transaction [00B1C528], from state [PROCEEDING] to [COMPLETED] 2015-02-24 01:56:35:930 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [368] bytes ACK sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.cHDMcR3~g;rport Call-ID: vkCbcvtXZ2 From: "901489" ;tag=d6gccJoUc To: sip:address@hidden Contact: ;+sip.instance="" Max-Forwards: 70 CSeq: 20 ACK 2015-02-24 01:56:35:930 MESSAGE Auth info found for [901489] realm [87.123.123.90] 2015-02-24 01:56:35:930 MESSAGE Changing [client] [INVITE] transaction [00B1AA10], from state [INIT] to [CALLING] 2015-02-24 01:56:35:930 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [1054] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.yC3IZyCo5;rport From: "901489" ;tag=d6gccJoUc To: sip:address@hidden CSeq: 21 INVITE Call-ID: vkCbcvtXZ2 Max-Forwards: 70 Supported: outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 242 Contact: ;+sip.instance="" User-Agent: LinphoneWP8/2a58c60 (belle-sip/1.3.3) Proxy-Authorization: Digest realm="87.123.123.90", nonce="00dd3c5fda36ba75edbface3362f3b90", algorithm=MD5, opaque="", username="901489", uri="sip:address@hidden", response="65cb1c268964409720b19cb1734f334b" v=0 o=901489 41 2083 IN IP4 192.168.1.104 s=Talk c=IN IP4 192.168.1.104 t=0 0 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 7076 RTP/AVP 18 101 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 2015-02-24 01:56:36:316 MESSAGE channel [032B5F80]: received [393] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 407 Proxy Authentication required Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.cHDMcR3~g From: "901489" ;tag=d6gccJoUc To: CSeq: 20 INVITE Call-ID: vkCbcvtXZ2 Proxy-Authenticate: Digest nonce="d542065e98587c9859876cf02252ed67",realm="87.123.123.90",opaque="",stale=FALSE,algorithm=MD5 Content-Length: 0 2015-02-24 01:56:36:379 MESSAGE channel [032B5F80] [393] bytes parsed 2015-02-24 01:56:36:379 MESSAGE Found transaction matching response. 2015-02-24 01:56:36:379 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [368] bytes ACK sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.cHDMcR3~g;rport Call-ID: vkCbcvtXZ2 From: "901489" ;tag=d6gccJoUc To: sip:address@hidden Contact: ;+sip.instance="" Max-Forwards: 70 CSeq: 20 ACK 2015-02-24 01:56:36:442 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [1054] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.yC3IZyCo5;rport From: "901489" ;tag=d6gccJoUc To: sip:address@hidden CSeq: 21 INVITE Call-ID: vkCbcvtXZ2 Max-Forwards: 70 Supported: outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 242 Contact: ;+sip.instance="" User-Agent: LinphoneWP8/2a58c60 (belle-sip/1.3.3) Proxy-Authorization: Digest realm="87.123.123.90", nonce="00dd3c5fda36ba75edbface3362f3b90", algorithm=MD5, opaque="", username="901489", uri="sip:address@hidden", response="65cb1c268964409720b19cb1734f334b" v=0 o=901489 41 2083 IN IP4 192.168.1.104 s=Talk c=IN IP4 192.168.1.104 t=0 0 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 7076 RTP/AVP 18 101 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 2015-02-24 01:56:36:539 MESSAGE channel [032B5F80]: received [243] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.yC3IZyCo5 From: "901489" ;tag=d6gccJoUc To: CSeq: 21 INVITE Call-ID: vkCbcvtXZ2 Content-Length: 0 2015-02-24 01:56:36:554 MESSAGE channel [032B5F80] [243] bytes parsed 2015-02-24 01:56:36:554 MESSAGE Found transaction matching response. 2015-02-24 01:56:36:554 MESSAGE Changing [client] [INVITE] transaction [00B1AA10], from state [CALLING] to [PROCEEDING] 2015-02-24 01:56:36:554 MESSAGE op [03257660] : set_or_update_dialog() current=[00000000] new=[00000000] 2015-02-24 01:56:36:554 MESSAGE Op [03257660] receiving call response [100], dialog is [00000000] in state [BELLE_SIP_DIALOG_NULL] 2015-02-24 01:56:36:586 MESSAGE channel [032B5F80]: received [641] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 183 Session progress Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.yC3IZyCo5 From: "901489" ;tag=d6gccJoUc To: ;tag=GB-1424725761019 CSeq: 21 INVITE Call-ID: vkCbcvtXZ2 Contact: Record-Route: Content-Type: application/sdp Content-Length: 256 v=0 o=901489 41 2083 IN IP4 87.123.123.90 s=3vays c=IN IP4 87.123.123.90 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics t=0 0 m=audio 37710 RTP/AVP 18 101 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=sendrecv 2015-02-24 01:56:36:617 MESSAGE channel [032B5F80] [385] bytes parsed 2015-02-24 01:56:36:617 MESSAGE channel [032B5F80] read [256] bytes of body from [87.123.123.90:5060] 2015-02-24 01:56:36:617 MESSAGE Found transaction matching response. 2015-02-24 01:56:36:617 MESSAGE New client dialog [00B9B710] , local tag [d6gccJoUc], remote tag [GB-1424725761019] 2015-02-24 01:56:36:617 MESSAGE Dialog [00B9B710]: now updated by transaction [00B1AA10]. 2015-02-24 01:56:36:633 MESSAGE op [03257660] : set_or_update_dialog() current=[00000000] new=[00B9B710] 2015-02-24 01:56:36:633 MESSAGE Op [03257660] receiving call response [183], dialog is [00B9B710] in state [BELLE_SIP_DIALOG_EARLY] 2015-02-24 01:56:36:633 MESSAGE ----[¨·Gj]----- 2015-02-24 01:56:36:633 MESSAGE [org.antlr.runtime.MismatchedTokenException] reason [IS_TOKEN(b)] 2015-02-24 01:56:36:633 MESSAGE [org.antlr.runtime.MismatchedTokenException] reason [IS_TOKEN(b)] 2015-02-24 01:56:36:633 ERROR session_description parser error for [v=0 o=901489 41 2083 IN IP4 87.123.123.90 s=3vays c=IN IP4 87.123.123.90 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics t=0 0 m=audio 37710 RTP/AVP 18 101 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=sendrecv ] 2015-02-24 01:56:36:633 ERROR Failed to parse SDP message. 2015-02-24 01:56:36:633 MESSAGE Doing SDP offer/answer process of type outgoing 2015-02-24 01:56:36:633 MESSAGE Linphone core [032664A8] notifying [display_status] 2015-02-24 01:56:36:633 MESSAGE ms_filter_unlink: MSRtpRecv:032D3888,0-->MSVoidSink:032D38E8,0 2015-02-24 01:56:36:664 MESSAGE Configuring resampler input with rate=[8000], nchannels=[1] 2015-02-24 01:56:36:664 MESSAGE MSFilePlayer[0331B5D8]: ./Assets/Sounds/ringback.wav opened: rate=8000,channel=1 2015-02-24 01:56:36:664 MESSAGE configuring resampler output to rate=[48000], nchannels=[2] 2015-02-24 01:56:36:664 MESSAGE ms_filter_link: MSFilePlayer:0331B5D8,0-->MSDtmfGen:0331BB78,0 2015-02-24 01:56:36:664 MESSAGE ms_filter_link: MSDtmfGen:0331BB78,0-->MSResample:0331B4B8,0 2015-02-24 01:56:36:664 MESSAGE ms_filter_link: MSResample:0331B4B8,0-->MSWASAPIWrite:0331B0F8,0 2015-02-24 01:56:36:664 MESSAGE Initializing speex resampler in mode [voip] 2015-02-24 01:56:36:854 MESSAGE MSWASAPI audio output interface buffer size: 12000 2015-02-24 01:56:36:855 MESSAGE Remote ringing... 2015-02-24 01:56:36:855 MESSAGE Linphone core [032664A8] notifying [display_status] 2015-02-24 01:56:36:856 MESSAGE Call 032A0F80: moving from state LinphoneCallOutgoingProgress to LinphoneCallOutgoingRinging 2015-02-24 01:56:36:856 MESSAGE Linphone core [032664A8] notifying [call_state_changed] 2015-02-24 01:56:36:961 MESSAGE [LinphoneManager] AudioEndpointChanged:Speakerphone 2015-02-24 01:56:36:962 MESSAGE [LinphoneManager] AudioEndpointChanged:Speakerphone 2015-02-24 01:56:36:963 MESSAGE [LinphoneManager] AudioEndpointChanged:Speakerphone 2015-02-24 01:56:36:963 MESSAGE [LinphoneManager] AudioEndpointChanged:Speakerphone 2015-02-24 01:56:37:191 MESSAGE channel [032B5F80]: received [243] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.yC3IZyCo5 From: "901489" ;tag=d6gccJoUc To: CSeq: 21 INVITE Call-ID: vkCbcvtXZ2 Content-Length: 0 2015-02-24 01:56:37:229 MESSAGE channel [032B5F80] [243] bytes parsed 2015-02-24 01:56:37:230 MESSAGE Found transaction matching response. 2015-02-24 01:56:37:231 MESSAGE Dialog [00B9B710]: now updated by transaction [00B1AA10]. 2015-02-24 01:56:37:231 MESSAGE op [03257660] : set_or_update_dialog() current=[00B9B710] new=[00B9B710] 2015-02-24 01:56:37:232 MESSAGE Op [03257660] receiving call response [100], dialog is [00B9B710] in state [BELLE_SIP_DIALOG_EARLY] 2015-02-24 01:56:40:848 MESSAGE channel [032B5F80]: keep alive sent to [UDP://87.123.123.90:5060] 2015-02-24 01:56:41:625 MESSAGE Cancelling INVITE request from ["901489" ] to [sip:address@hidden 2015-02-24 01:56:41:626 MESSAGE Found transaction [00B1AA10] matching request. 2015-02-24 01:56:41:627 MESSAGE Changing [client] [CANCEL] transaction [032B1BE8], from state [INIT] to [TRYING] 2015-02-24 01:56:41:628 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [318] bytes CANCEL sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.yC3IZyCo5;rport Call-ID: vkCbcvtXZ2 From: "901489" ;tag=d6gccJoUc To: sip:address@hidden Max-Forwards: 70 CSeq: 21 CANCEL User-Agent: LinphoneWP8/2a58c60 (belle-sip/1.3.3) 2015-02-24 01:56:41:630 MESSAGE ms_filter_unlink: MSFilePlayer:0331B5D8,0-->MSDtmfGen:0331BB78,0 2015-02-24 01:56:41:631 MESSAGE ms_filter_unlink: MSDtmfGen:0331BB78,0-->MSResample:0331B4B8,0 2015-02-24 01:56:41:632 MESSAGE ms_filter_unlink: MSResample:0331B4B8,0-->MSWASAPIWrite:0331B0F8,0 2015-02-24 01:56:41:642 MESSAGE Ring MSTicker thread exiting 2015-02-24 01:56:41:646 MESSAGE =========================================================== 2015-02-24 01:56:41:646 MESSAGE FILTER USAGE STATISTICS 2015-02-24 01:56:41:646 MESSAGE Name Count Time/tick (ms) CPU Usage 2015-02-24 01:56:41:646 MESSAGE ----------------------------------------------------------- 2015-02-24 01:56:41:646 MESSAGE MSWASAPIWrite 477 0.0334728 100 2015-02-24 01:56:41:646 MESSAGE MSResample 477 0 0 2015-02-24 01:56:41:646 MESSAGE MSDtmfGen 477 0 0 2015-02-24 01:56:41:646 MESSAGE MSFilePlayer 477 0 0 2015-02-24 01:56:41:646 MESSAGE MSVoidSink 0 0 0 2015-02-24 01:56:41:646 MESSAGE MSRtpRecv 144 0 0 2015-02-24 01:56:41:662 MESSAGE MSWebRTCAEC 0 0 0 2015-02-24 01:56:41:662 MESSAGE MSRtpSend 0 0 0 2015-02-24 01:56:41:662 MESSAGE =========================================================== 2015-02-24 01:56:41:662 MESSAGE Linphone core [032664A8] notifying [display_status] 2015-02-24 01:56:41:662 MESSAGE Call 032A0F80: moving from state LinphoneCallOutgoingRinging to LinphoneCallEnd 2015-02-24 01:56:41:662 MESSAGE MSAudio MSTicker thread exiting 2015-02-24 01:56:41:662 MESSAGE Linphone core [032664A8] notifying [call_log_updated] 2015-02-24 01:56:41:662 MESSAGE Resetting the current call 2015-02-24 01:56:41:662 MESSAGE Linphone core [032664A8] notifying [call_state_changed] 2015-02-24 01:56:41:725 MESSAGE Notifying soundcard that we don't need it anymore for calls. 2015-02-24 01:56:41:757 MESSAGE [LinphoneManager] Call ended: Call terminated 2015-02-24 01:56:41:875 MESSAGE channel [032B5F80]: received [239] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.yC3IZyCo5 Call-ID: vkCbcvtXZ2 From: "901489" ;tag=d6gccJoUc To: CSeq: 21 CANCEL Content-Length: 0 2015-02-24 01:56:41:890 MESSAGE channel [032B5F80] [239] bytes parsed 2015-02-24 01:56:41:891 MESSAGE Found transaction matching response. 2015-02-24 01:56:41:892 MESSAGE Changing [client] [CANCEL] transaction [032B1BE8], from state [TRYING] to [COMPLETED] 2015-02-24 01:56:41:893 MESSAGE op [03257660] : set_or_update_dialog() current=[00B9B710] new=[00000000] 2015-02-24 01:56:41:893 MESSAGE Op [03257660] receiving call response [200], dialog is [00000000] in state [BELLE_SIP_DIALOG_NULL] 2015-02-24 01:56:41:915 MESSAGE channel [032B5F80]: received [255] new bytes from [UDP://87.123.123.90:5060]: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 192.168.1.104:60332;rport;branch=z9hG4bK.yC3IZyCo5 From: "901489" ;tag=d6gccJoUc To: CSeq: 21 INVITE Call-ID: vkCbcvtXZ2 Content-Length: 0 2015-02-24 01:56:41:942 MESSAGE channel [032B5F80] [255] bytes parsed 2015-02-24 01:56:41:944 MESSAGE Found transaction matching response. 2015-02-24 01:56:41:944 MESSAGE Changing [client] [INVITE] transaction [00B1AA10], from state [PROCEEDING] to [COMPLETED] 2015-02-24 01:56:41:947 MESSAGE channel [032B5F80]: message sent to [UDP://87.123.123.90:5060], size: [368] bytes ACK sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP 192.168.1.104:60332;branch=z9hG4bK.yC3IZyCo5;rport Call-ID: vkCbcvtXZ2 From: "901489" ;tag=d6gccJoUc To: sip:address@hidden Contact: ;+sip.instance="" Max-Forwards: 70 CSeq: 21 ACK 2015-02-24 01:56:41:948 MESSAGE Dialog [00B9B710]: now updated by transaction [00B1AA10]. 2015-02-24 01:56:41:949 MESSAGE dialog [00B9B710] deleted. 2015-02-24 01:56:41:953 MESSAGE op [03257660] : set_or_update_dialog() current=[00000000] new=[00B9B710] 2015-02-24 01:56:41:954 MESSAGE Op [03257660] receiving call response [487], dialog is [00B9B710] in state [BELLE_SIP_DIALOG_TERMINATED] 2015-02-24 01:56:41:954 MESSAGE Linphone core [032664A8] notifying [show] 2015-02-24 01:56:41:976 MESSAGE Dialog [00B9B710] terminated for op [03257660] 2015-02-24 01:56:41:997 MESSAGE Call 032A0F80: moving from state LinphoneCallEnd to LinphoneCallReleased 2015-02-24 01:56:41:998 MESSAGE Linphone core [032664A8] notifying [call_state_changed] 2015-02-24 01:56:42:005 MESSAGE [LinphoneManager] Call released 2015-02-24 01:56:42:007 MESSAGE Notifying soundcard that we don't need it anymore for calls. 2015-02-24 01:56:42:008 MESSAGE op [03257660] : set_or_update_dialog() current=[00B9B710] new=[00000000]