01-26 11:44:41.663: I/mediastreamer(14176): Flattened number is '9115002' 01-26 11:44:41.663: I/mediastreamer(14176): No need to add a prefix 01-26 11:44:41.663: I/mediastreamer(14176): Local interface to reach is 192.168.1.159. 01-26 11:44:41.663: I/mediastreamer(14176): Notifying all friends that we are in status 5 01-26 11:44:42.174: I/mediastreamer(14176): Partial MTU discovered : 1500 01-26 11:44:42.174: I/mediastreamer(14176): mtu to is 1500 01-26 11:44:42.174: I/mediastreamer(14176): Discovered mtu is 1500, RTP payload max size is 1440 01-26 11:44:42.174: I/mediastreamer(14176): Call 0x11c928: moving from state LinphoneCallIdle to LinphoneCallOutgoingInit 01-26 11:44:42.178: I/mediastreamer(14176): Contact has been fixed using proxy to @:56857;transport=tcp> 01-26 11:44:42.186: W/mediastreamer(14176): cannot set noise gate mode to [0] because no volume send 01-26 11:44:42.186: I/mediastreamer(14176): allocating transaction ressource 8 1389463157 01-26 11:44:42.186: I/mediastreamer(14176): allocating ICT context 01-26 11:44:42.186: I/mediastreamer(14176): Call 0x11c928: moving from state LinphoneCallOutgoingInit to LinphoneCallOutgoingProgress 01-26 11:44:42.202: I/mediastreamer(14176): DNS resolution with :5060 01-26 11:44:42.202: I/mediastreamer(14176): getaddrinfo returned the following addresses: 01-26 11:44:42.202: I/mediastreamer(14176): port 5060 01-26 11:44:42.202: I/mediastreamer(14176): socket node: , socket 42 [pos=0], connected 01-26 11:44:42.202: I/mediastreamer(14176): Message sent: (to dest=:5060) 01-26 11:44:42.202: I/mediastreamer(14176): INVITE sip:9115002@ SIP/2.0 01-26 11:44:42.202: I/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport;branch=z9hG4bK1565785571 01-26 11:44:42.202: I/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:42.202: I/mediastreamer(14176): To: > 01-26 11:44:42.202: I/mediastreamer(14176): Call-ID: 1389463157 01-26 11:44:42.202: I/mediastreamer(14176): CSeq: 20 INVITE 01-26 11:44:42.202: I/mediastreamer(14176): Contact: @:56857;transport=tcp> 01-26 11:44:42.202: I/mediastreamer(14176): Content-Type: application/sdp 01-26 11:44:42.202: I/mediastreamer(14176): Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO 01-26 11:44:42.202: I/mediastreamer(14176): Max-Forwards: 70 01-26 11:44:42.202: I/mediastreamer(14176): User-Agent: Linphone/3.4.0 (eXosip2/unknown) 01-26 11:44:42.202: I/mediastreamer(14176): Subject: Phone call 01-26 11:44:42.202: I/mediastreamer(14176): Content-Length: 644 01-26 11:44:42.202: I/mediastreamer(14176): 01-26 11:44:42.202: I/mediastreamer(14176): v=0 01-26 11:44:42.202: I/mediastreamer(14176): o= 3529 3529 IN IP4 192.168.1.159 01-26 11:44:42.202: I/mediastreamer(14176): s=Talk 01-26 11:44:42.202: I/mediastreamer(14176): c=IN IP4 192.168.1.159 01-26 11:44:42.202: I/mediastreamer(14176): t=0 0 01-26 11:44:42.202: I/mediastreamer(14176): m=audio 7078 RTP/AVP 112 111 110 100 104 3 0 8 101 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:112 speex/32000 01-26 11:44:42.202: I/mediastreamer(14176): a=fmtp:112 vbr=on 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:111 speex/16000 01-26 11:44:42.202: I/mediastreamer(14176): a=fmtp:111 vbr=on 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:110 speex/8000 01-26 11:44:42.202: I/mediastreamer(14176): a=fmtp:110 vbr=on 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:100 iLBC/8000 01-26 11:44:42.202: I/mediastreamer(14176): a=fmtp:100 mode=30 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:104 AMR/8000 01-26 11:44:42.202: I/mediastreamer(14176): a=fmtp:104 octet-align=1 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:101 telephone-event/8000 01-26 11:44:42.202: I/mediastreamer(14176): a=fmtp:101 0-11 01-26 11:44:42.202: I/mediastreamer(14176): m=video 9078 RTP/AVP 103 102 99 98 01-26 11:44:42.202: I/mediastreamer(14176): a=rtpmap:103 VP8 01-26 11:44:42.202: I/mediastreamer(14176): cb_sndinvite (id=8) 01-26 11:44:42.202: I/mediastreamer(14176): keep alive: 6 01-26 11:44:42.202: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:42.202: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:42.210: I/mediastreamer(14176): Local interface to reach is 192.168.1.159. 01-26 11:44:42.428: I/mediastreamer(14176): socket :5060: read 260 bytes 01-26 11:44:42.436: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:42.436: E/mediastreamer(14176): SIP/2.0 100 Trying 01-26 11:44:42.436: E/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:42.436: E/mediastreamer(14176): To: > 01-26 11:44:42.436: E/mediastreamer(14176): Call-Id: 1389463157 01-26 11:44:42.436: E/mediastreamer(14176): Cseq: 20 INVITE 01-26 11:44:42.436: E/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport=56857;branch=z9hG4bK1565785571;received= 01-26 11:44:42.436: E/mediastreamer(14176): Content-Length: 0 01-26 11:44:42.436: E/mediastreamer(14176): 01-26 11:44:42.436: I/mediastreamer(14176): MESSAGE REC. CALLID:1389463157 01-26 11:44:42.436: I/mediastreamer(14176): Message received from: :5060 01-26 11:44:42.436: I/mediastreamer(14176): cb_rcv1xx (id=8) 01-26 11:44:42.436: I/mediastreamer(14176): keep alive: 0 01-26 11:44:42.436: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:42.436: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:42.491: I/mediastreamer(14176): linphone process event get a message 8 01-26 11:44:42.491: I/mediastreamer(14176): CALL_PROCEEDING 01-26 11:44:42.491: I/mediastreamer(14176): Contact address updated to @:56857;transport=tcp> 01-26 11:44:42.624: I/mediastreamer(14176): socket :5060: read 988 bytes 01-26 11:44:42.631: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:42.631: E/mediastreamer(14176): SIP/2.0 407 Proxy Authentication Required 01-26 11:44:42.631: E/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:42.631: E/mediastreamer(14176): To: >;tag=48hf`m 01-26 11:44:42.631: E/mediastreamer(14176): Call-Id: 1389463157 01-26 11:44:42.631: E/mediastreamer(14176): Cseq: 20 INVITE 01-26 11:44:42.631: E/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport=56857;branch=z9hG4bK1565785571;received= 01-26 11:44:42.631: E/mediastreamer(14176): Proxy-Authenticate: Digest realm="", nonce="31b741058445e269ad2e9dbbf84157934f216634", qop="auth" 01-26 11:44:42.631: E/mediastreamer(14176): Server: sipXecs/4.4.0 sipXecs/sipXproxy (Linux) 01-26 11:44:42.631: E/mediastreamer(14176): Date: Thu, 26 Jan 2012 14:41:56 GMT 01-26 11:44:42.631: E/mediastreamer(14176): Content-Length: 0 01-26 11:44:42.631: E/mediastreamer(14176): 01-26 11:44:42.631: I/mediastreamer(14176): MESSAGE REC. CALLID:1389463157 01-26 11:44:42.631: I/mediastreamer(14176): Message received from: :5060 01-26 11:44:42.631: I/mediastreamer(14176): socket :5060: message has no content-length: <> 01-26 11:44:42.631: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:42.631: E/mediastreamer(14176): Could not parse start line of message. 01-26 11:44:42.631: E/mediastreamer(14176): could not parse message 01-26 11:44:42.647: I/mediastreamer(14176): DNS resolution with :5060 01-26 11:44:42.647: I/mediastreamer(14176): getaddrinfo returned the following addresses: 01-26 11:44:42.647: I/mediastreamer(14176): port 5060 01-26 11:44:42.647: I/mediastreamer(14176): socket node: , socket 42 [pos=0], connected 01-26 11:44:42.647: I/mediastreamer(14176): Message sent: (to dest=:5060) 01-26 11:44:42.647: I/mediastreamer(14176): ACK sip:9115002@ SIP/2.0 01-26 11:44:42.647: I/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport;branch=z9hG4bK1565785571 01-26 11:44:42.647: I/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:42.647: I/mediastreamer(14176): To: >;tag=48hf`m 01-26 11:44:42.647: I/mediastreamer(14176): Call-ID: 1389463157 01-26 11:44:42.647: I/mediastreamer(14176): CSeq: 20 ACK 01-26 11:44:42.647: I/mediastreamer(14176): Content-Length: 0 01-26 11:44:42.647: I/mediastreamer(14176): 01-26 11:44:42.647: I/mediastreamer(14176): cb_rcv4xx (id=8) 01-26 11:44:42.647: I/mediastreamer(14176): cb_sndack (id=8) 01-26 11:44:42.647: I/mediastreamer(14176): keep alive: 0 01-26 11:44:42.647: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:42.647: I/mediastreamer(14176): eXosip: timer sec:0 usec:10000! 01-26 11:44:42.655: I/mediastreamer(14176): cb_nict_kill_transaction (id=8) 01-26 11:44:42.655: I/mediastreamer(14176): keep alive: 0 01-26 11:44:42.655: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:42.655: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:42.686: I/mediastreamer(14176): linphone process event get a message 12 01-26 11:44:42.686: I/mediastreamer(14176): CALL_REQUESTFAILURE or GLOBALFAILURE or SERVERFAILURE 01-26 11:44:42.686: I/mediastreamer(14176): auth_requested() for realm="", username= 01-26 11:44:42.686: I/mediastreamer(14176): auth_requested(): authenticating realm="", username= 01-26 11:44:42.686: I/mediastreamer(14176): Authentication info for username [], id[], realm [(null)] added to eXosip 01-26 11:44:42.694: I/mediastreamer(14176): Contact address updated to @:56857;transport=tcp> 01-26 11:44:42.694: I/mediastreamer(14176): INFO: authinfo: "" 01-26 11:44:42.694: I/mediastreamer(14176): INFO: authinfo: "" 01-26 11:44:42.694: I/mediastreamer(14176): authinfo: 01-26 11:44:42.694: I/mediastreamer(14176): allocating transaction ressource 9 1389463157 01-26 11:44:42.694: I/mediastreamer(14176): allocating ICT context 01-26 11:44:42.694: I/mediastreamer(14176): eXosip_default_action() done 01-26 11:44:42.694: I/mediastreamer(14176): DNS resolution with :5060 01-26 11:44:42.702: I/mediastreamer(14176): getaddrinfo returned the following addresses: 01-26 11:44:42.702: I/mediastreamer(14176): port 5060 01-26 11:44:42.702: I/mediastreamer(14176): socket node: , socket 42 [pos=0], connected 01-26 11:44:42.702: I/mediastreamer(14176): Message sent: (to dest=:5060) 01-26 11:44:42.702: I/mediastreamer(14176): INVITE sip:9115002@ SIP/2.0 01-26 11:44:42.702: I/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport;branch=z9hG4bK1849693487 01-26 11:44:42.702: I/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:42.702: I/mediastreamer(14176): To: > 01-26 11:44:42.702: I/mediastreamer(14176): Call-ID: 1389463157 01-26 11:44:42.702: I/mediastreamer(14176): CSeq: 21 INVITE 01-26 11:44:42.702: I/mediastreamer(14176): Contact: @:56857;transport=tcp> 01-26 11:44:42.702: I/mediastreamer(14176): Proxy-Authorization: Digest username="", realm="", nonce="31b741058445e269ad2e9dbbf84157934f216634", uri="sip:9115002@", response="281ebf63145c455cf5e2d3121e72722d", algorithm=MD5, cnonce="0a4f113b", qop=auth, nc=00000001 01-26 11:44:42.702: I/mediastreamer(14176): Content-Type: application/sdp 01-26 11:44:42.702: I/mediastreamer(14176): Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO 01-26 11:44:42.702: I/mediastreamer(14176): Max-Forwards: 70 01-26 11:44:42.702: I/mediastreamer(14176): User-Agent: Linphone/3.4.0 (eXosip2/unknown) 01-26 11:44:42.702: I/mediastreamer(14176): Subject: Phone call 01-26 11:44:42.702: I/mediastreamer(14176): Content-Length: 644 01-26 11:44:42.702: I/mediastreamer(14176): 01-26 11:44:42.702: I/mediastreamer(14176): v=0 01-26 11:44:42.702: I/mediastreamer(14176): o= 3529 3529 IN IP4 192.168.1.159 01-26 11:44:42.702: I/mediastreamer(14176): s=Talk 01-26 11:44:42.702: I/mediastreamer(14176): c=IN IP4 192.168.1.159 01-26 11:44:42.702: I/mediastreamer(14176): t=0 0 01-26 11:44:42.702: I/mediastreamer(14176): m=audio 7078 RTP/AVP 112 111 110 100 104 3 0 8 101 01-26 11:44:42.702: I/mediastreamer(14176): a=rtpmap:112 speex/32000 01-26 11:44:42.702: I/mediastreamer(14176): a=fmtp:112 vbr=on 01-26 11:44:42.702: I/mediastreamer(14176): a=rtpmap:111 speex/16000 01-26 11:44:42.702: I/mediastreamer(14176): a=fm 01-26 11:44:42.702: I/mediastreamer(14176): cb_sndinvite (id=9) 01-26 11:44:42.702: I/mediastreamer(14176): free transaction ressource 8 1389463157 01-26 11:44:42.702: I/mediastreamer(14176): free ict ressource 01-26 11:44:42.702: I/mediastreamer(14176): keep alive: 0 01-26 11:44:42.702: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:42.702: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:42.811: I/mediastreamer(14176): socket :5060: read 494 bytes 01-26 11:44:42.811: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:42.811: E/mediastreamer(14176): SIP/2.0 407 Proxy Authentication Required 01-26 11:44:42.811: E/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:42.811: E/mediastreamer(14176): To: >;tag=48hf`m 01-26 11:44:42.811: E/mediastreamer(14176): Call-Id: 1389463157 01-26 11:44:42.811: E/mediastreamer(14176): Cseq: 20 INVITE 01-26 11:44:42.811: E/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport=56857;branch=z9hG4bK1565785571;received= 01-26 11:44:42.811: E/mediastreamer(14176): Proxy-Authenticate: Digest realm="", nonce="31b741058445e269ad2e9dbbf84157934f216634", qop="auth" 01-26 11:44:42.811: E/mediastreamer(14176): Server: sipXecs/4.4.0 sipXecs/sipXproxy (Linux) 01-26 11:44:42.811: E/mediastreamer(14176): Date: Thu, 26 Jan 2012 14:41:56 GMT 01-26 11:44:42.811: E/mediastreamer(14176): Content-Length: 0 01-26 11:44:42.811: E/mediastreamer(14176): 01-26 11:44:42.811: I/mediastreamer(14176): MESSAGE REC. CALLID:1389463157 01-26 11:44:42.811: I/mediastreamer(14176): Message received from: :5060 01-26 11:44:42.811: I/mediastreamer(14176): This is a request 01-26 11:44:42.811: I/mediastreamer(14176): Incoming 2xx has no relations with current calls: Message discarded. 01-26 11:44:42.811: I/mediastreamer(14176): keep alive: 0 01-26 11:44:42.811: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:42.811: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:43.080: I/mediastreamer(14176): socket :5060: read 260 bytes 01-26 11:44:43.080: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:43.080: E/mediastreamer(14176): SIP/2.0 100 Trying 01-26 11:44:43.080: E/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:43.080: E/mediastreamer(14176): To: > 01-26 11:44:43.080: E/mediastreamer(14176): Call-Id: 1389463157 01-26 11:44:43.080: E/mediastreamer(14176): Cseq: 21 INVITE 01-26 11:44:43.080: E/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport=56857;branch=z9hG4bK1849693487;received= 01-26 11:44:43.080: E/mediastreamer(14176): Content-Length: 0 01-26 11:44:43.080: E/mediastreamer(14176): 01-26 11:44:43.080: I/mediastreamer(14176): MESSAGE REC. CALLID:1389463157 01-26 11:44:43.080: I/mediastreamer(14176): Message received from: :5060 01-26 11:44:43.080: I/mediastreamer(14176): cb_rcv1xx (id=9) 01-26 11:44:43.080: I/mediastreamer(14176): keep alive: 1 01-26 11:44:43.080: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:43.085: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:43.092: I/mediastreamer(14176): linphone process event get a message 8 01-26 11:44:43.092: I/mediastreamer(14176): CALL_PROCEEDING 01-26 11:44:43.092: I/mediastreamer(14176): Contact address updated to @:56857;transport=tcp> 01-26 11:44:43.116: I/mediastreamer(14176): socket :5060: read 1448 bytes 01-26 11:44:43.116: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:43.116: E/mediastreamer(14176): SIP/2.0 183 Session Progress 01-26 11:44:43.116: E/mediastreamer(14176): Record-Route: :5060;lr;sipXecs-CallDest=AL;sipXecs-rs=%2Aauth%7E.%2Afrom%7EMjA0NTA2NDg0Mg%60%60.900_ntap%2Aid%7EODUyNi0xNg%60%60%21a859167d6858bbab614ef1b01fbbb937;x-sipX-done> 01-26 11:44:43.116: E/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport=56857;branch=z9hG4bK1849693487;received= 01-26 11:44:43.116: E/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:43.116: E/mediastreamer(14176): To: >;tag=B07X3r6X14v9e 01-26 11:44:43.116: E/mediastreamer(14176): Call-Id: 1389463157 01-26 11:44:43.116: E/mediastreamer(14176): Cseq: 21 INVITE 01-26 11:44:43.116: E/mediastreamer(14176): Contact: :15060;transport=udp> 01-26 11:44:43.116: E/mediastreamer(14176): User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20111019T020933Z 01-26 11:44:43.116: E/mediastreamer(14176): Accept: application/sdp 01-26 11:44:43.116: E/mediastreamer(14176): Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY 01-26 11:44:43.116: E/mediastreamer(14176): Supported: timer, precondition, path, replaces 01-26 11:44:43.116: E/mediastreamer(14176): Allow-Events: talk, hold, refer 01-26 11:44:43.116: E/mediastreamer(14176): Content-Type: application/sdp 01-26 11:44:43.116: E/mediastreamer(14176): Content-Disposition: session 01-26 11:44:43.116: E/mediastreamer(14176): Content-Length: 338 01-26 11:44:43.116: E/mediastreamer(14176): Remote-Party-Id: "9115002" >;party=calling;privacy=off;screen=no 01-26 11:44:43.116: E/mediastreamer(14176): Date: Thu, 26 Jan 2012 14:41:5 01-26 11:44:43.116: I/mediastreamer(14176): MESSAGE REC. CALLID:1389463157 01-26 11:44:43.116: I/mediastreamer(14176): Message received from: :5060 01-26 11:44:43.116: I/mediastreamer(14176): cb_rcv1xx (id=9) 01-26 11:44:43.116: I/mediastreamer(14176): keep alive: 0 01-26 11:44:43.116: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:43.116: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:43.193: I/mediastreamer(14176): linphone process event get a message 9 01-26 11:44:43.193: I/mediastreamer(14176): CALL_RINGING 01-26 11:44:43.193: I/mediastreamer(14176): Contact address updated to @:56857;transport=tcp> 01-26 11:44:43.194: I/mediastreamer(14176): Found payload PCMU/8000 fmtp= 01-26 11:44:43.194: I/mediastreamer(14176): Found payload telephone-event/8000 fmtp=0-16 01-26 11:44:43.194: E/mediastreamer(14176): payload number 19 has no rtpmap and is unknown in AV Profile, ignored. 01-26 11:44:43.194: I/mediastreamer(14176): Doing SDP offer/answer process 01-26 11:44:43.194: I/mediastreamer(14176): Processing for stream 0 01-26 11:44:43.194: I/mediastreamer(14176): Adding speex/32000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Adding speex/16000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Adding speex/8000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Adding iLBC/8000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Adding AMR/8000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Adding GSM/8000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Adding PCMA/8000 for compatibility, just in case. 01-26 11:44:43.194: I/mediastreamer(14176): Processing for stream 1 01-26 11:44:43.194: I/mediastreamer(14176): Call 0x11c928: moving from state LinphoneCallOutgoingProgress to LinphoneCallOutgoingEarlyMedia 01-26 11:44:43.194: I/mediastreamer(14176): Doing early media... 01-26 11:44:43.194: I/mediastreamer(14176): Audio bandwidth for this call is 80 01-26 11:44:43.194: I/mediastreamer(14176): Hardware sample rate is 44100 01-26 11:44:43.194: I/mediastreamer(14176): speex_lib_ctl init with neon ? 1 01-26 11:44:43.194: I/mediastreamer(14176): Payload's bitrate is 80000 01-26 11:44:43.194: I/mediastreamer(14176): Setting audio encoder network bitrate to 80000 01-26 11:44:43.194: I/mediastreamer(14176): MSUlawEnc: got ptime=20 01-26 11:44:43.194: I/mediastreamer(14176): configuring MSRtpRecv-->MSAndSoundWrite from rate[8000] to rate [44100] 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSAndSoundRead:0x1a14b0,0-->MSSpeexEC:0x193fd8,1 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSSpeexEC:0x193fd8,1-->MSVolume:0x1b26c0,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSVolume:0x1b26c0,0-->MSUlawEnc:0x1a1628,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSUlawEnc:0x1a1628,0-->MSRtpSend:0x184188,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSRtpRecv:0x1a13e0,0-->MSUlawDec:0x1b2680,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSUlawDec:0x1b2680,0-->MSDtmfGen:0x1a1430,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSDtmfGen:0x1a1430,0-->MSVolume:0x1b27b0,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSVolume:0x1b27b0,0-->MSEqualizer:0x1b2940,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSEqualizer:0x1b2940,0-->MSSpeexEC:0x193fd8,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSSpeexEC:0x193fd8,0-->MSResample:0x1b28a0,0 01-26 11:44:43.194: I/mediastreamer(14176): ms_filter_link: MSResample:0x1b28a0,0-->MSAndSoundWrite:0x1a1578,0 01-26 11:44:43.194: I/mediastreamer(14176): Configuring recorder with [16] bits rate [8000] nchanels [1] buff size [3200], chunk size [400] 01-26 11:44:43.210: I/mediastreamer(14176): ms_ticker_set_time_func: ticker updated. 01-26 11:44:43.210: I/mediastreamer(14176): Initializing speex echo canceler with framesize=64, filterlength=2000, delay_samples=0 01-26 11:44:43.210: I/mediastreamer(14176): speex echo state restored. 01-26 11:44:43.210: I/mediastreamer(14176): Configuring player with [16] bits rate [44100] nchanels [1] buff size [8192] chunk size [1764] 01-26 11:44:43.217: I/mediastreamer(14176): Priority used: 99 01-26 11:44:43.217: I/mediastreamer(14176): Audio MSTicker priority increased to maximum. 01-26 11:44:43.233: I/mediastreamer(14176): Filter MSRtpRecv is already being scheduled; nothing to do. 01-26 11:44:43.233: W/mediastreamer(14176): No valid video stream defined. 01-26 11:44:43.264: I/mediastreamer(14176): socket :5060: read 1173 bytes 01-26 11:44:43.264: I/mediastreamer(14176): socket :5060: message has no content-length: <> 01-26 11:44:43.264: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:43.264: E/mediastreamer(14176): Could not parse start line of message. 01-26 11:44:43.264: E/mediastreamer(14176): could not parse message 01-26 11:44:43.272: I/mediastreamer(14176): keep alive: 0 01-26 11:44:43.272: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:43.272: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:43.303: W/mediastreamer(14176): Getting reference signal but no echo to synchronize on. 01-26 11:44:43.303: W/mediastreamer(14176): Not enough ref samples, using zeroes 01-26 11:44:43.616: I/mediastreamer(14176): socket :5060: read 1291 bytes 01-26 11:44:43.616: I/mediastreamer(14176): socket :5060: message has no content-length: <> 01-26 11:44:43.616: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:43.616: E/mediastreamer(14176): Could not parse start line of message. 01-26 11:44:43.616: E/mediastreamer(14176): could not parse message 01-26 11:44:43.616: I/mediastreamer(14176): keep alive: 0 01-26 11:44:43.616: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:43.616: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:43.647: I/mediastreamer(14176): Samples are back. 01-26 11:44:43.647: W/mediastreamer(14176): Not enough ref samples, using zeroes 01-26 11:44:43.663: I/mediastreamer(14176): Samples are back. 01-26 11:44:43.928: W/mediastreamer(14176): Not enough ref samples, using zeroes 01-26 11:44:43.944: I/mediastreamer(14176): Samples are back. 01-26 11:44:44.616: I/mediastreamer(14176): socket :5060: read 1291 bytes 01-26 11:44:44.616: I/mediastreamer(14176): socket :5060: message has no content-length: <> 01-26 11:44:44.616: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:44.616: E/mediastreamer(14176): Could not parse start line of message. 01-26 11:44:44.616: E/mediastreamer(14176): could not parse message 01-26 11:44:44.616: I/mediastreamer(14176): keep alive: 1 01-26 11:44:44.616: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:44.616: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:46.616: I/mediastreamer(14176): socket :5060: read 1291 bytes 01-26 11:44:46.616: I/mediastreamer(14176): socket :5060: message has no content-length: <> 01-26 11:44:46.616: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:46.616: E/mediastreamer(14176): Could not parse start line of message. 01-26 11:44:46.616: E/mediastreamer(14176): could not parse message 01-26 11:44:46.616: I/mediastreamer(14176): keep alive: 2 01-26 11:44:46.616: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:46.616: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:47.100: I/mediastreamer(14176): Local interface to reach is 192.168.1.159. 01-26 11:44:47.421: I/mediastreamer(14176): Authentication info for username [], id[], realm [(null)] added to eXosip 01-26 11:44:47.421: I/mediastreamer(14176): allocating transaction ressource 10 1389463157 01-26 11:44:47.421: I/mediastreamer(14176): allocating NICT context 01-26 11:44:47.421: W/mediastreamer(14176): Exosip could not terminate the call: cid=3 did=4 01-26 11:44:47.421: I/mediastreamer(14176): Writing echo canceler state, 10952 bytes 01-26 11:44:47.421: I/mediastreamer(14176): ms_ticker_set_time_func: ticker updated. 01-26 11:44:47.421: I/mediastreamer(14176): DNS resolution with :5060 01-26 11:44:47.421: I/mediastreamer(14176): getaddrinfo returned the following addresses: 01-26 11:44:47.421: I/mediastreamer(14176): port 5060 01-26 11:44:47.421: I/mediastreamer(14176): socket node: , socket 42 [pos=0], connected 01-26 11:44:47.421: I/mediastreamer(14176): Message sent: (to dest=:5060) 01-26 11:44:47.421: I/mediastreamer(14176): CANCEL sip:9115002@ SIP/2.0 01-26 11:44:47.421: I/mediastreamer(14176): Via: SIP/2.0/TCP 192.168.1.159:5060;rport;branch=z9hG4bK1849693487 01-26 11:44:47.421: I/mediastreamer(14176): From: @>;tag=2045064842 01-26 11:44:47.421: I/mediastreamer(14176): To: > 01-26 11:44:47.421: I/mediastreamer(14176): Call-ID: 1389463157 01-26 11:44:47.421: I/mediastreamer(14176): CSeq: 21 CANCEL 01-26 11:44:47.421: I/mediastreamer(14176): Max-Forwards: 70 01-26 11:44:47.421: I/mediastreamer(14176): User-Agent: Linphone/3.4.0 (eXosip2/unknown) 01-26 11:44:47.421: I/mediastreamer(14176): Content-Length: 0 01-26 11:44:47.421: I/mediastreamer(14176): 01-26 11:44:47.421: I/mediastreamer(14176): cb_sndcancel (id=10) 01-26 11:44:47.421: I/mediastreamer(14176): keep alive: 1 01-26 11:44:47.421: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:47.421: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up! 01-26 11:44:47.444: I/mediastreamer(14176): Thread end, detaching jvm from current thread 01-26 11:44:47.500: I/mediastreamer(14176): Thread end, detaching jvm from current thread 01-26 11:44:47.500: I/mediastreamer(14176): Filter MSRtpRecv is not scheduled; nothing to do. 01-26 11:44:47.500: I/mediastreamer(14176): oRTP-stats: 01-26 11:44:47.500: I/mediastreamer(14176): Audio session's RTP statistics : 01-26 11:44:47.500: I/mediastreamer(14176): number of rtp packet sent=204 01-26 11:44:47.500: I/mediastreamer(14176): number of rtp bytes sent=35088 bytes 01-26 11:44:47.500: I/mediastreamer(14176): number of rtp packet received=192 01-26 11:44:47.500: I/mediastreamer(14176): number of rtp bytes received=33024 bytes 01-26 11:44:47.500: I/mediastreamer(14176): number of incoming rtp bytes successfully delivered to the application=32508 01-26 11:44:47.500: I/mediastreamer(14176): number of rtp packet lost=0 01-26 11:44:47.500: I/mediastreamer(14176): number of rtp packets received too late=0 01-26 11:44:47.500: I/mediastreamer(14176): number of bad formatted rtp packets=0 01-26 11:44:47.500: I/mediastreamer(14176): number of packet discarded because of queue overflow=0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSAndSoundRead:0x1a14b0,0-->MSSpeexEC:0x193fd8,1 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSSpeexEC:0x193fd8,1-->MSVolume:0x1b26c0,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSVolume:0x1b26c0,0-->MSUlawEnc:0x1a1628,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSUlawEnc:0x1a1628,0-->MSRtpSend:0x184188,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSRtpRecv:0x1a13e0,0-->MSUlawDec:0x1b2680,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSUlawDec:0x1b2680,0-->MSDtmfGen:0x1a1430,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSDtmfGen:0x1a1430,0-->MSVolume:0x1b27b0,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSVolume:0x1b27b0,0-->MSEqualizer:0x1b2940,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSEqualizer:0x1b2940,0-->MSSpeexEC:0x193fd8,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSSpeexEC:0x193fd8,0-->MSResample:0x1b28a0,0 01-26 11:44:47.500: I/mediastreamer(14176): ms_filter_unlink: MSResample:0x1b28a0,0-->MSAndSoundWrite:0x1a1578,0 01-26 11:44:47.506: I/mediastreamer(14176): Audio MSTicker thread exiting 01-26 11:44:47.506: I/mediastreamer(14176): Thread end, detaching jvm from current thread 01-26 11:44:47.506: I/mediastreamer(14176): Filter usage statistics: 01-26 11:44:47.506: I/mediastreamer(14176): Name Count Time/tick (ms) CPU Usage 01-26 11:44:47.506: I/mediastreamer(14176): MSSpeexEC 379 2.917 67.0878 01-26 11:44:47.506: I/mediastreamer(14176): MSResample 204 1.8382 22.8071 01-26 11:44:47.506: I/mediastreamer(14176): MSAndSoundWrite 204 0.30592 3.79564 01-26 11:44:47.506: I/mediastreamer(14176): MSRtpSend 419 0.0932966 2.37158 01-26 11:44:47.506: I/mediastreamer(14176): MSRtpRecv 419 0.0733875 1.8655 01-26 11:44:47.506: I/mediastreamer(14176): MSVolume 393 0.0272645 0.650155 01-26 11:44:47.506: I/mediastreamer(14176): MSAndSoundRead 419 0.0210717 0.535638 01-26 11:44:47.514: I/mediastreamer(14176): MSUlawEnc 204 0.0308153 0.382335 01-26 11:44:47.514: I/mediastreamer(14176): MSUlawDec 189 0.0293932 0.338006 01-26 11:44:47.514: I/mediastreamer(14176): MSDtmfGen 419 0.00494094 0.125598 01-26 11:44:47.514: I/mediastreamer(14176): MSEqualizer 189 0.00353362 0.0406347 01-26 11:44:47.514: I/mediastreamer(14176): Call 0x11c928: moving from state LinphoneCallOutgoingEarlyMedia to LinphoneCallEnd 01-26 11:44:47.514: I/mediastreamer(14176): Resetting the current call 01-26 11:44:47.514: I/mediastreamer(14176): Notifying all friends that we are in status 1 01-26 11:44:47.616: I/mediastreamer(14176): socket :5060: read 267 bytes 01-26 11:44:47.616: I/mediastreamer(14176): socket :5060: message has no content-length: <> 01-26 11:44:47.616: E/mediastreamer(14176): Received message from :5060: 01-26 11:44:47.616: E/mediastreamer(14176): Could not parse start line of message. 01-26 11:44:47.616: E/mediastreamer(14176): could not parse message 01-26 11:44:47.616: I/mediastreamer(14176): keep alive: 0 01-26 11:44:47.616: I/mediastreamer(14176): tcp_tl_keepalive socket node::5060 , socket 42 [pos=0], connected 01-26 11:44:47.616: I/mediastreamer(14176): eXosip: Reseting timer to 10s before waking up!