Thanks for the reply. I attached the log files for the release and debug builds. I am building using VS2005. We kept the default codec configuration. Any thoughts or suggestions would be much appreciated. ________________________________________ Samer M. Faour Computer and Communications Engineering American University of Beirut P.O. Box 11-0236/ 1461 Riad el Solh Square 1107 - 2020 Email: smf18 at aub.edu.lb ---------------------------------------------------------------- -------------- next part -------------- 18:07:14.000 sip_endpoint.c Module "mod-pjsua-log" registered 18:07:14.000 sip_endpoint.c Module "mod-tsx-layer" registered 18:07:14.000 sip_endpoint.c Module "mod-stateful-util" registered 18:07:14.000 sip_endpoint.c Module "mod-ua" registered 18:07:14.000 sip_endpoint.c Module "mod-100rel" registered 18:07:14.000 sip_endpoint.c Module "mod-pjsua" registered 18:07:14.000 sip_endpoint.c Module "mod-invite" registered 18:07:14.000 pasound.c PortAudio sound library initialized, status=0 18:07:14.000 pasound.c PortAudio host api count=2 18:07:14.000 pasound.c Sound device count=4 18:07:14.000 pjlib select() I/O Queue created (00219F64) 18:07:14.000 speex_codec.c Adjusting quality to 5 for uwb 18:07:14.000 conference.c Creating conference bridge with 254 ports 18:07:14.000 conference.c Sound device successfully created for port 0 18:07:14.000 sip_endpoint.c Module "mod-evsub" registered 18:07:14.000 sip_endpoint.c Module "mod-presence" registered 18:07:14.000 evsub.c Event pkg "presence" registered by mod-presence 18:07:14.000 sip_endpoint.c Module "mod-refer" registered 18:07:14.000 evsub.c Event pkg "refer" registered by mod-refer 18:07:14.000 sip_endpoint.c Module "mod-pjsua-pres" registered 18:07:14.000 sip_endpoint.c Module "mod-pjsua-im" registered 18:07:14.000 sip_endpoint.c Module "mod-pjsua-options" registered 18:07:14.000 pjsua_core.c 1 SIP worker threads created 18:07:14.000 pjsua_core.c pjsua version 0.8.0-trunk for win32-wince initialized 18:07:14.000 pjsua_core.c SIP UDP socket reachable at 192.168.140.135:5060 18:07:14.000 udp00227EA0 SIP UDP transport started, published address is 192.168.140.135:5060 18:07:14.000 pjsua_acc.c Account <sip:192.168.140.135:5060> added with id 0 18:07:14.000 pjsua_acc.c Account sip:jack at 192.168.195.170 added with id 1 18:07:14.000 endpoint Request msg REGISTER/cseq=17982 (tdta002370E0) created. 18:07:14.000 tsx00237954 Transaction created for Request msg REGISTER/cseq=17983 (tdta002370E0) 18:07:14.000 tsx00237954 Sending Request msg REGISTER/cseq=17983 (tdta002370E0) in state Null 18:07:14.000 sip_resolve.c Target '192.168.195.170:0' type=Unspecified resolved to '192.168.195.170:5060' type=UDP (UDP transport) 18:07:14.000 pjsua_core.c TX 360 bytes Request msg REGISTER/cseq=17983 (tdta002370E0) to UDP 192.168.195.170:5060: REGISTER sip:192.168.195.170 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.135:5060;rport;branch=z9hG4bKPj33c20000000323482900 Max-Forwards: 70 From: <sip:jack@192.168.195.170>;tag=33c20000000223482900 To: <sip:jack at 192.168.195.170> Call-ID: 33c20000000123482900 CSeq: 17983 REGISTER Contact: <sip:jack at 192.168.140.135:5060> Expires: 300 Content-Length: 0 --end msg-- 18:07:15.000 tsx00237954 State changed from Null to Calling, event=TX_MSG 18:07:15.000 pjsua_acc.c Registration sent 18:07:15.000 pjsua_media.c RTP socket reachable at 192.168.140.135:4000 18:07:15.000 pjsua_media.c RTCP socket reachable at 192.168.140.135:4001 18:07:15.000 pjsua_media.c RTP socket reachable at 192.168.140.135:4002 18:07:15.000 pjsua_media.c RTCP socket reachable at 192.168.140.135:4003 18:07:15.000 pjsua_media.c RTP socket reachable at 192.168.140.135:4004 18:07:15.000 pjsua_media.c RTCP socket reachable at 192.168.140.135:4005 18:07:15.000 pjsua_media.c RTP socket reachable at 192.168.140.135:4006 18:07:15.000 pjsua_media.c RTCP socket reachable at 192.168.140.135:4007 18:07:15.000 pjsua_media.c pjsua_set_snd_dev(): attempting to open devices @8000 Hz 18:07:15.000 pasound.c Opened device M - Input(MME)/M - Output(MME) for recording and playback, sample rate=8000, ch=1, bits=16, 80 samples per frame, input latency=120 ms, output latency=120 ms 18:07:15.000 pasound.c Starting M - Input stream.. 18:07:15.000 pasound.c Player thread started 18:07:15.000 pasound.c Done, status=0 18:07:15.000 pasound.c Recorder thread started 18:07:15.000 sip_endpoint.c Processing incoming message: Response msg 401/REGISTER/cseq=17983 (rdata00234E14) 18:07:15.000 pjsua_core.c RX 462 bytes Response msg 401/REGISTER/cseq=17983 (rdata00234E14) from UDP 192.168.195.170:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.140.135:5060;rport=5060;branch=z9hG4bKPj33c20000000323482900 From: <sip:jack@192.168.195.170>;tag=33c20000000223482900 To: <sip:jack at 192.168.195.170>;tag=3c03be1240cfef49842f10c82e442d2b.1649 Call-ID: 33c20000000123482900 CSeq: 17983 REGISTER WWW-Authenticate: Digest realm="192.168.195.170", nonce="47b8793fd6cf2b0e8484a20df510eb27f063396b" Server: OpenSER (1.3.0-tls (i386/linux)) Content-Length: 0 --end msg-- 18:07:15.000 tsx00237954 Incoming Response msg 401/REGISTER/cseq=17983 (rdata00234E14) in state Calling 18:07:15.000 tsx00237954 State changed from Calling to Completed, event=RX_MSG 18:07:15.000 tsx0026D0F4 Transaction created for Request msg REGISTER/cseq=17984 (tdta002370E0) 18:07:15.000 tsx0026D0F4 Sending Request msg REGISTER/cseq=17984 (tdta002370E0) in state Null 18:07:15.000 sip_resolve.c Target '192.168.195.170:0' type=Unspecified resolved to '192.168.195.170:5060' type=UDP (UDP transport) 18:07:15.000 pjsua_core.c TX 546 bytes Request msg REGISTER/cseq=17984 (tdta002370E0) to UDP 192.168.195.170:5060: REGISTER sip:192.168.195.170 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.135:5060;rport;branch=z9hG4bKPj33c20000000423482900 Max-Forwards: 70 From: <sip:jack@192.168.195.170>;tag=33c20000000223482900 To: <sip:jack at 192.168.195.170> Call-ID: 33c20000000123482900 CSeq: 17984 REGISTER Contact: <sip:jack at 192.168.140.135:5060> Expires: 300 Authorization: Digest username="jack", realm="192.168.195.170", nonce="47b8793fd6cf2b0e8484a20df510eb27f063396b", uri="sip:192.168.195.170", response="c9ca8118b44cebec069be41e086e3249" Content-Length: 0 --end msg-- 18:07:15.000 tsx0026D0F4 State changed from Null to Calling, event=TX_MSG 18:07:15.000 sip_endpoint.c Processing incoming message: Response msg 200/REGISTER/cseq=17984 (rdata00234E14) 18:07:15.000 pjsua_core.c RX 406 bytes Response msg 200/REGISTER/cseq=17984 (rdata00234E14) from UDP 192.168.195.170:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.140.135:5060;rport=5060;branch=z9hG4bKPj33c20000000423482900 From: <sip:jack@192.168.195.170>;tag=33c20000000223482900 To: <sip:jack at 192.168.195.170>;tag=3c03be1240cfef49842f10c82e442d2b.38d7 Call-ID: 33c20000000123482900 CSeq: 17984 REGISTER Contact: <sip:jack at 192.168.140.135:5060>;expires=300 Server: OpenSER (1.3.0-tls (i386/linux)) Content-Length: 0 --end msg-- 18:07:15.000 tsx0026D0F4 Incoming Response msg 200/REGISTER/cseq=17984 (rdata00234E14) in state Calling 18:07:15.000 tsx0026D0F4 State changed from Calling to Completed, event=RX_MSG 18:07:15.000 pjsua_acc.c sip:jack at 192.168.195.170: registration success, status=200 (OK), will re-register in 300 seconds 18:07:18.000 ecsu00222FB8 Vad cur_threshold updated 4-->3. Signal lo=-1 18:07:20.000 tsx00237954 Timeout timer event 18:07:20.000 tsx00237954 State changed from Completed to Terminated, event=TIMER 18:07:20.000 tsx0026D0F4 Timeout timer event 18:07:20.000 tsx0026D0F4 State changed from Completed to Terminated, event=TIMER 18:07:20.000 tsx00237954 Timeout timer event 18:07:20.000 tsx00237954 State changed from Terminated to Destroyed, event=TIMER 18:07:20.000 tsx00237954 Transaction destroyed! 18:07:20.000 tsx0026D0F4 Timeout timer event 18:07:20.000 tsx0026D0F4 State changed from Terminated to Destroyed, event=TIMER 18:07:20.000 tdta002370E0 Destroying txdata Request msg REGISTER/cseq=17984 (tdta002370E0) 18:07:20.000 tsx0026D0F4 Transaction destroyed! 18:07:20.000 sound_port.c EC suspended because of inactivity 18:07:25.000 pjsua_call.c Making call with acc #1 to sip:192.168.140.130:5060 18:07:25.000 dlg0026E014 UAC dialog created 18:07:25.000 dlg0026E014 Module mod-invite added as dialog usage, data=0026FC34 18:07:25.000 dlg0026E014 Session count inc to 2 by mod-invite 18:07:25.000 dlg0026E014 Module mod-100rel added as dialog usage, data=0026FD60 18:07:25.000 dlg0026E014 100rel module attached 18:07:25.000 inv0026E014 UAC invite session created for dialog dlg0026E014 18:07:25.000 endpoint Request msg INVITE/cseq=22649 (tdta0026CE80) created. 18:07:25.000 inv0026E014 Sending Request msg INVITE/cseq=22649 (tdta0026CE80) 18:07:25.000 dlg0026E014 Sending Request msg INVITE/cseq=22649 (tdta0026CE80) 18:07:25.000 tsx00270CE4 Transaction created for Request msg INVITE/cseq=22648 (tdta0026CE80) 18:07:25.000 tsx00270CE4 Sending Request msg INVITE/cseq=22648 (tdta0026CE80) in state Null 18:07:25.000 sip_resolve.c Target '192.168.140.130:5060' type=Unspecified resolved to '192.168.140.130:5060' type=UDP (UDP transport) 18:07:25.000 pjsua_core.c TX 928 bytes Request msg INVITE/cseq=22648 (tdta0026CE80) to UDP 192.168.140.130:5060: INVITE sip:192.168.140.130:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.135:5060;rport;branch=z9hG4bKPj33c20000000723482900 Max-Forwards: 70 From: sip:jack@192.168.195.170;tag=33c20000000523482900 To: sip:192.168.140.130 Contact: <sip:jack at 192.168.140.135:5060> Call-ID: 33c20000000623482900 CSeq: 22648 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, norefersub Content-Type: application/sdp Content-Length: 414 v=0 o=- 3412260445 3412260445 IN IP4 192.168.140.135 s=pjmedia c=IN IP4 192.168.140.135 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 8 102 117 103 3 101 a=rtcp:4001 IN IP4 192.168.140.135 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:102 speex/8000 a=rtpmap:117 iLBC/8000 a=fmtp:117 mode=30 a=rtpmap:103 speex/16000 a=rtpmap:3 GSM/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 18:07:25.000 tsx00270CE4 State changed from Null to Calling, event=TX_MSG 18:07:25.000 dlg0026E014 Transaction tsx00270CE4 state changed to Calling 18:07:25.000 sip_endpoint.c Processing incoming message: Response msg 100/INVITE/cseq=22648 (rdata00234E14) 18:07:25.000 pjsua_core.c RX 291 bytes Response msg 100/INVITE/cseq=22648 (rdata00234E14) from UDP 192.168.140.130:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.140.135:5060;rport=5060;received=192.168.140.135;branch=z9hG4bKPj33c20000000723482900 Call-ID: 33c20000000623482900 From: <sip:jack@192.168.195.170>;tag=33c20000000523482900 To: <sip:192.168.140.130> CSeq: 22648 INVITE Content-Length: 0 --end msg-- 18:07:25.000 tsx00270CE4 Incoming Response msg 100/INVITE/cseq=22648 (rdata00234E14) in state Calling 18:07:25.000 tsx00270CE4 State changed from Calling to Proceeding, event=RX_MSG 18:07:25.000 dlg0026E014 Received Response msg 100/INVITE/cseq=22648 (rdata00234E14) 18:07:25.000 dlg0026E014 Transaction tsx00270CE4 state changed to Proceeding 18:07:29.000 sip_endpoint.c Processing incoming message: Response msg 200/INVITE/cseq=22648 (rdata00234E14) 18:07:29.000 pjsua_core.c RX 811 bytes Response msg 200/INVITE/cseq=22648 (rdata00234E14) from UDP 192.168.140.130:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.140.135:5060;rport=5060;received=192.168.140.135;branch=z9hG4bKPj33c20000000723482900 Call-ID: 33c20000000623482900 From: <sip:jack@192.168.195.170>;tag=33c20000000523482900 To: <sip:192.168.140.130>;tag=e4ea355d4e834c36a38b372c9fec3251 CSeq: 22648 INVITE Contact: <sip:192.168.140.130:5060;transport=UDP> Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, norefersub Content-Type: application/sdp Content-Length: 260 v=0 o=- 3412260167 3412260168 IN IP4 192.168.140.130 s=pjmedia c=IN IP4 192.168.140.130 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 101 a=rtcp:4001 IN IP4 192.168.140.130 a=rtpmap:0 PCMU/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 18:07:29.000 tsx00270CE4 Incoming Response msg 200/INVITE/cseq=22648 (rdata00234E14) in state Proceeding 18:07:29.000 tsx00270CE4 State changed from Proceeding to Terminated, event=RX_MSG 18:07:29.000 dlg0026E014 Received Response msg 200/INVITE/cseq=22648 (rdata00234E14) 18:07:29.000 dlg0026E014 Route-set updated 18:07:29.000 dlg0026E014 Route-set frozen 18:07:29.000 dlg0026E014 Transaction tsx00270CE4 state changed to Terminated 18:07:29.000 inv0026E014 Got SDP answer in Response msg 200/INVITE/cseq=22648 (rdata00234E14) 18:07:29.000 inv0026E014 SDP negotiation done, status=0 18:07:29.000 pjsua_call.c Call 0: remote NAT type is 0 (Unknown) 18:07:29.000 strm002727E4 VAD temporarily disabled 18:07:29.000 rtp.c pjmedia_rtp_session_init: ses=002742D4, default_pt=0, ssrc=0x4ae13d6c 18:07:29.000 rtp.c pjmedia_rtp_session_init: ses=00275100, default_pt=0, ssrc=0x4ae13d6c 18:07:29.000 stream.c Stream strm002727E4 created 18:07:29.000 strm002727E4 Encoder stream started 18:07:29.000 strm002727E4 Decoder stream started 18:07:29.000 pjsua_media.c Media updates, stream #0: PCMU (sendrecv) 18:07:29.000 conference.c Port 1 (sip:192.168.140.130:5060) transmitting to port 0 (M - Input) 18:07:29.000 strm002727E4 Jitter buffer empty (prefetch=15) 18:07:29.000 conference.c Port 0 (M - Input) transmitting to port 1 (sip:192.168.140.130:5060) 18:07:29.000 inv0026E014 Received Response msg 200/INVITE/cseq=22648 (rdata00234E14), sending ACK 18:07:29.000 endpoint Request msg ACK/cseq=22648 (tdta00276CC0) created. 18:07:29.000 dlg0026E014 Sending Request msg ACK/cseq=22648 (tdta00276CC0) 18:07:29.000 sip_resolve.c Target '192.168.140.130:5060' type=UDP resolved to '192.168.140.130:5060' type=UDP (UDP transport) 18:07:29.000 pjsua_core.c TX 341 bytes Request msg ACK/cseq=22648 (tdta00276CC0) to UDP 192.168.140.130:5060: ACK sip:192.168.140.130:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 192.168.140.135:5060;rport;branch=z9hG4bKPj33c20000000823482900 Max-Forwards: 70 From: sip:jack@192.168.195.170;tag=33c20000000523482900 To: sip:192.168.140.130;tag=e4ea355d4e834c36a38b372c9fec3251 Call-ID: 33c20000000623482900 CSeq: 22648 ACK Content-Length: 0 --end msg-- 18:07:29.000 strm002727E4 RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 18:07:29.000 strm002727E4 Jitter buffer is bufferring (prefetch=15).. 18:07:29.000 strm002727E4 Start talksprut.. 18:07:29.000 tsx00270CE4 Timeout timer event 18:07:29.000 tsx00270CE4 State changed from Terminated to Destroyed, event=TIMER 18:07:29.000 tdta0026CE80 Destroying txdata Request msg INVITE/cseq=22648 (tdta0026CE80) 18:07:29.000 tsx00270CE4 Transaction destroyed! 18:07:29.000 strm002727E4 Jitter buffer is bufferring (prefetch=15).. 18:07:29.000 strm002727E4 Jitter buffer is bufferring (prefetch=15).. 18:07:29.000 strm002727E4 Jitter buffer is bufferring (prefetch=15).. 18:07:29.000 strm002727E4 Jitter buffer is bufferring (prefetch=15).. 18:07:29.000 strm002727E4 Jitter buffer is bufferring (prefetch=15).. 18:07:29.000 sound_port.c EC activated 18:07:29.000 strm002727E4 VAD re-enabled 18:07:29.000 strm002727E4 Jitter buffer empty (prefetch=15) 18:07:30.000 strm002727E4 Jitter buffer empty (prefetch=24) 18:07:30.000 ecsu00222FB8 Vad cur_threshold updated 3-->2. Signal lo=12 18:07:30.000 strm002727E4 Jitter buffer empty (prefetch=24) 18:07:31.000 strm002727E4 Jitter buffer empty (prefetch=24) 18:07:31.000 strm002727E4 Jitter buffer empty (prefetch=24) 18:07:31.000 silencedet.c Vad cur_threshold updated 4-->5. Signal lo=5 18:07:32.000 strm002727E4 Jitter buffer empty (prefetch=24) -------------- next part -------------- 17:58:51.000 sip_endpoint.c Module "mod-pjsua-log" registered 17:58:51.000 sip_endpoint.c Module "mod-tsx-layer" registered 17:58:51.000 sip_endpoint.c Module "mod-stateful-util" registered 17:58:51.000 sip_endpoint.c Module "mod-ua" registered 17:58:51.000 sip_endpoint.c Module "mod-100rel" registered 17:58:51.000 sip_endpoint.c Module "mod-pjsua" registered 17:58:51.000 sip_endpoint.c Module "mod-invite" registered 17:58:51.000 pasound.c PortAudio sound library initialized, status=0 17:58:51.000 pasound.c PortAudio host api count=2 17:58:51.000 pasound.c Sound device count=4 17:58:51.000 pjlib select() I/O Queue created (00119F64) 17:58:51.000 speex_codec.c Adjusting quality to 5 for uwb 17:58:51.000 conference.c Creating conference bridge with 254 ports 17:58:51.000 conference.c Sound device successfully created for port 0 17:58:51.000 sip_endpoint.c Module "mod-evsub" registered 17:58:51.000 sip_endpoint.c Module "mod-presence" registered 17:58:51.000 evsub.c Event pkg "presence" registered by mod-presence 17:58:51.000 sip_endpoint.c Module "mod-refer" registered 17:58:51.000 evsub.c Event pkg "refer" registered by mod-refer 17:58:51.000 sip_endpoint.c Module "mod-pjsua-pres" registered 17:58:51.000 sip_endpoint.c Module "mod-pjsua-im" registered 17:58:51.000 sip_endpoint.c Module "mod-pjsua-options" registered 17:58:51.000 pjsua_core.c 1 SIP worker threads created 17:58:51.000 pjsua_core.c pjsua version 0.8.0-trunk for win32-wince initialized 17:58:51.000 pjsua_core.c SIP UDP socket reachable at 192.168.140.133:5060 17:58:51.000 udp00127EA0 SIP UDP transport started, published address is 192.168.140.133:5060 17:58:51.000 pjsua_acc.c Account <sip:192.168.140.133:5060> added with id 0 17:58:51.000 pjsua_acc.c Account sip:jack at 192.168.195.170 added with id 1 17:58:51.000 endpoint Request msg REGISTER/cseq=17982 (tdta001367E0) created. 17:58:51.000 tsx00136224 Transaction created for Request msg REGISTER/cseq=17983 (tdta001367E0) 17:58:51.000 tsx00136224 Sending Request msg REGISTER/cseq=17983 (tdta001367E0) in state Null 17:58:51.000 sip_resolve.c Target '192.168.195.170:0' type=Unspecified resolved to '192.168.195.170:5060' type=UDP (UDP transport) 17:58:51.000 pjsua_core.c TX 360 bytes Request msg REGISTER/cseq=17983 (tdta001367E0) to UDP 192.168.195.170:5060: REGISTER sip:192.168.195.170 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.133:5060;rport;branch=z9hG4bKPje30c0000000323482900 Max-Forwards: 70 From: <sip:jack@192.168.195.170>;tag=e30c0000000223482900 To: <sip:jack at 192.168.195.170> Call-ID: e30c0000000123482900 CSeq: 17983 REGISTER Contact: <sip:jack at 192.168.140.133:5060> Expires: 300 Content-Length: 0 --end msg-- 17:58:51.000 tsx00136224 State changed from Null to Calling, event=TX_MSG 17:58:51.000 pjsua_acc.c Registration sent 17:58:51.000 pjsua_media.c RTP socket reachable at 192.168.140.133:4000 17:58:51.000 pjsua_media.c RTCP socket reachable at 192.168.140.133:4001 17:58:51.000 pjsua_media.c RTP socket reachable at 192.168.140.133:4002 17:58:51.000 pjsua_media.c RTCP socket reachable at 192.168.140.133:4003 17:58:51.000 pjsua_media.c RTP socket reachable at 192.168.140.133:4004 17:58:51.000 pjsua_media.c RTCP socket reachable at 192.168.140.133:4005 17:58:51.000 pjsua_media.c RTP socket reachable at 192.168.140.133:4006 17:58:51.000 pjsua_media.c RTCP socket reachable at 192.168.140.133:4007 17:58:51.000 pjsua_media.c pjsua_set_snd_dev(): attempting to open devices @8000 Hz 17:58:51.000 pasound.c Opened device M - Input(MME)/M - Output(MME) for recording and playback, sample rate=8000, ch=1, bits=16, 80 samples per frame, input latency=120 ms, output latency=120 ms 17:58:51.000 pasound.c Starting M - Input stream.. 17:58:51.000 pasound.c Player thread started 17:58:51.000 pasound.c Done, status=0 17:58:51.000 pasound.c Recorder thread started 17:58:51.000 sip_endpoint.c Processing incoming message: Response msg 401/REGISTER/cseq=17983 (rdata00134E14) 17:58:51.000 pjsua_core.c RX 462 bytes Response msg 401/REGISTER/cseq=17983 (rdata00134E14) from UDP 192.168.195.170:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.140.133:5060;rport=5060;branch=z9hG4bKPje30c0000000323482900 From: <sip:jack@192.168.195.170>;tag=e30c0000000223482900 To: <sip:jack at 192.168.195.170>;tag=3c03be1240cfef49842f10c82e442d2b.1de5 Call-ID: e30c0000000123482900 CSeq: 17983 REGISTER WWW-Authenticate: Digest realm="192.168.195.170", nonce="47b87748124afb4fab128f3b62036ab4a0977ff1" Server: OpenSER (1.3.0-tls (i386/linux)) Content-Length: 0 --end msg-- 17:58:51.000 tsx00136224 Incoming Response msg 401/REGISTER/cseq=17983 (rdata00134E14) in state Calling 17:58:51.000 tsx00136224 State changed from Calling to Completed, event=RX_MSG 17:58:51.000 tsx0016BB04 Transaction created for Request msg REGISTER/cseq=17984 (tdta001367E0) 17:58:51.000 tsx0016BB04 Sending Request msg REGISTER/cseq=17984 (tdta001367E0) in state Null 17:58:51.000 sip_resolve.c Target '192.168.195.170:0' type=Unspecified resolved to '192.168.195.170:5060' type=UDP (UDP transport) 17:58:51.000 pjsua_core.c TX 546 bytes Request msg REGISTER/cseq=17984 (tdta001367E0) to UDP 192.168.195.170:5060: REGISTER sip:192.168.195.170 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.133:5060;rport;branch=z9hG4bKPje30c0000000423482900 Max-Forwards: 70 From: <sip:jack@192.168.195.170>;tag=e30c0000000223482900 To: <sip:jack at 192.168.195.170> Call-ID: e30c0000000123482900 CSeq: 17984 REGISTER Contact: <sip:jack at 192.168.140.133:5060> Expires: 300 Authorization: Digest username="jack", realm="192.168.195.170", nonce="47b87748124afb4fab128f3b62036ab4a0977ff1", uri="sip:192.168.195.170", response="64564a0390f5f42323390d3d0ba8fdd6" Content-Length: 0 --end msg-- 17:58:51.000 tsx0016BB04 State changed from Null to Calling, event=TX_MSG 17:58:51.000 sip_endpoint.c Processing incoming message: Response msg 200/REGISTER/cseq=17984 (rdata00134E14) 17:58:51.000 pjsua_core.c RX 406 bytes Response msg 200/REGISTER/cseq=17984 (rdata00134E14) from UDP 192.168.195.170:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.140.133:5060;rport=5060;branch=z9hG4bKPje30c0000000423482900 From: <sip:jack@192.168.195.170>;tag=e30c0000000223482900 To: <sip:jack at 192.168.195.170>;tag=3c03be1240cfef49842f10c82e442d2b.337b Call-ID: e30c0000000123482900 CSeq: 17984 REGISTER Contact: <sip:jack at 192.168.140.133:5060>;expires=300 Server: OpenSER (1.3.0-tls (i386/linux)) Content-Length: 0 --end msg-- 17:58:51.000 tsx0016BB04 Incoming Response msg 200/REGISTER/cseq=17984 (rdata00134E14) in state Calling 17:58:51.000 tsx0016BB04 State changed from Calling to Completed, event=RX_MSG 17:58:51.000 pjsua_acc.c sip:jack at 192.168.195.170: registration success, status=200 (OK), will re-register in 300 seconds 17:58:54.000 ecsu00122FB0 Vad cur_threshold updated 4-->3. Signal lo=-1 17:58:56.000 tsx00136224 Timeout timer event 17:58:56.000 tsx00136224 State changed from Completed to Terminated, event=TIMER 17:58:56.000 tsx0016BB04 Timeout timer event 17:58:56.000 tsx0016BB04 State changed from Completed to Terminated, event=TIMER 17:58:56.000 tsx00136224 Timeout timer event 17:58:56.000 tsx00136224 State changed from Terminated to Destroyed, event=TIMER 17:58:56.000 tsx00136224 Transaction destroyed! 17:58:56.000 tsx0016BB04 Timeout timer event 17:58:56.000 tsx0016BB04 State changed from Terminated to Destroyed, event=TIMER 17:58:56.000 tdta001367E0 Destroying txdata Request msg REGISTER/cseq=17984 (tdta001367E0) 17:58:56.000 tsx0016BB04 Transaction destroyed! 17:58:56.000 sound_port.c EC suspended because of inactivity 17:59:49.000 pjsua_call.c Making call with acc #1 to sip:192.168.140.130:5060 17:59:49.000 dlg0016E014 UAC dialog created 17:59:49.000 dlg0016E014 Module mod-invite added as dialog usage, data=0016F8C4 17:59:49.000 dlg0016E014 Session count inc to 2 by mod-invite 17:59:49.000 dlg0016E014 Module mod-100rel added as dialog usage, data=0016F9F0 17:59:49.000 dlg0016E014 100rel module attached 17:59:49.000 inv0016E014 UAC invite session created for dialog dlg0016E014 17:59:49.000 endpoint Request msg INVITE/cseq=22649 (tdta001700E0) created. 17:59:49.000 inv0016E014 Sending Request msg INVITE/cseq=22649 (tdta001700E0) 17:59:49.000 dlg0016E014 Sending Request msg INVITE/cseq=22649 (tdta001700E0) 17:59:49.000 tsx00170F74 Transaction created for Request msg INVITE/cseq=22648 (tdta001700E0) 17:59:49.000 tsx00170F74 Sending Request msg INVITE/cseq=22648 (tdta001700E0) in state Null 17:59:49.000 sip_resolve.c Target '192.168.140.130:5060' type=Unspecified resolved to '192.168.140.130:5060' type=UDP (UDP transport) 17:59:49.000 pjsua_core.c TX 928 bytes Request msg INVITE/cseq=22648 (tdta001700E0) to UDP 192.168.140.130:5060: INVITE sip:192.168.140.130:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.133:5060;rport;branch=z9hG4bKPje30c0000000723482900 Max-Forwards: 70 From: sip:jack@192.168.195.170;tag=e30c0000000523482900 To: sip:192.168.140.130 Contact: <sip:jack at 192.168.140.133:5060> Call-ID: e30c0000000623482900 CSeq: 22648 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, norefersub Content-Type: application/sdp Content-Length: 414 v=0 o=- 3412259989 3412259989 IN IP4 192.168.140.133 s=pjmedia c=IN IP4 192.168.140.133 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 8 102 117 103 3 101 a=rtcp:4001 IN IP4 192.168.140.133 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:102 speex/8000 a=rtpmap:117 iLBC/8000 a=fmtp:117 mode=30 a=rtpmap:103 speex/16000 a=rtpmap:3 GSM/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 17:59:49.000 tsx00170F74 State changed from Null to Calling, event=TX_MSG 17:59:49.000 dlg0016E014 Transaction tsx00170F74 state changed to Calling 17:59:50.000 tsx00170F74 Retransmit timer event 17:59:50.000 tsx00170F74 Retransmiting Request msg INVITE/cseq=22648 (tdta001700E0), count=0, restart?=1 17:59:50.000 pjsua_core.c TX 928 bytes Request msg INVITE/cseq=22648 (tdta001700E0) to UDP 192.168.140.130:5060: INVITE sip:192.168.140.130:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.140.133:5060;rport;branch=z9hG4bKPje30c0000000723482900 Max-Forwards: 70 From: sip:jack@192.168.195.170;tag=e30c0000000523482900 To: sip:192.168.140.130 Contact: <sip:jack at 192.168.140.133:5060> Call-ID: e30c0000000623482900 CSeq: 22648 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, norefersub Content-Type: application/sdp Content-Length: 414 v=0 o=- 3412259989 3412259989 IN IP4 192.168.140.133 s=pjmedia c=IN IP4 192.168.140.133 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 8 102 117 103 3 101 a=rtcp:4001 IN IP4 192.168.140.133 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:102 speex/8000 a=rtpmap:117 iLBC/8000 a=fmtp:117 mode=30 a=rtpmap:103 speex/16000 a=rtpmap:3 GSM/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 17:59:50.000 sip_endpoint.c Processing incoming message: Response msg 100/INVITE/cseq=22648 (rdata00134E14) 17:59:50.000 pjsua_core.c RX 291 bytes Response msg 100/INVITE/cseq=22648 (rdata00134E14) from UDP 192.168.140.130:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.140.133:5060;rport=5060;received=192.168.140.133;branch=z9hG4bKPje30c0000000723482900 Call-ID: e30c0000000623482900 From: <sip:jack@192.168.195.170>;tag=e30c0000000523482900 To: <sip:192.168.140.130> CSeq: 22648 INVITE Content-Length: 0 --end msg-- 17:59:50.000 tsx00170F74 Incoming Response msg 100/INVITE/cseq=22648 (rdata00134E14) in state Calling 17:59:50.000 tsx00170F74 State changed from Calling to Proceeding, event=RX_MSG 17:59:50.000 dlg0016E014 Received Response msg 100/INVITE/cseq=22648 (rdata00134E14) 17:59:50.000 dlg0016E014 Transaction tsx00170F74 state changed to Proceeding 17:59:54.000 sip_endpoint.c Processing incoming message: Response msg 200/INVITE/cseq=22648 (rdata00134E14) 17:59:54.000 pjsua_core.c RX 811 bytes Response msg 200/INVITE/cseq=22648 (rdata00134E14) from UDP 192.168.140.130:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.140.133:5060;rport=5060;received=192.168.140.133;branch=z9hG4bKPje30c0000000723482900 Call-ID: e30c0000000623482900 From: <sip:jack@192.168.195.170>;tag=e30c0000000523482900 To: <sip:192.168.140.130>;tag=34e54cb54f6e463094dc785afafd402b CSeq: 22648 INVITE Contact: <sip:192.168.140.130:5060;transport=UDP> Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, norefersub Content-Type: application/sdp Content-Length: 260 v=0 o=- 3412259711 3412259712 IN IP4 192.168.140.130 s=pjmedia c=IN IP4 192.168.140.130 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 101 a=rtcp:4001 IN IP4 192.168.140.130 a=rtpmap:0 PCMU/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 17:59:54.000 tsx00170F74 Incoming Response msg 200/INVITE/cseq=22648 (rdata00134E14) in state Proceeding 17:59:54.000 tsx00170F74 State changed from Proceeding to Terminated, event=RX_MSG 17:59:54.000 dlg0016E014 Received Response msg 200/INVITE/cseq=22648 (rdata00134E14) 17:59:54.000 dlg0016E014 Route-set updated 17:59:54.000 dlg0016E014 Route-set frozen 17:59:54.000 dlg0016E014 Transaction tsx00170F74 state changed to Terminated 17:59:54.000 inv0016E014 Got SDP answer in Response msg 200/INVITE/cseq=22648 (rdata00134E14) 17:59:54.000 inv0016E014 SDP negotiation done, status=0 17:59:54.000 pjsua_call.c Call 0: remote NAT type is 0 (Unknown) 17:59:54.000 strm001723D4 VAD temporarily disabled 17:59:54.000 rtp.c pjmedia_rtp_session_init: ses=00173EC4, default_pt=0, ssrc=0x4ae13d6c 17:59:54.000 rtp.c pjmedia_rtp_session_init: ses=00174CF0, default_pt=0, ssrc=0x4ae13d6c 17:59:54.000 stream.c Stream strm001723D4 created 17:59:54.000 strm001723D4 Encoder stream started 17:59:54.000 strm001723D4 Decoder stream started 17:59:54.000 pjsua_media.c Media updates, stream #0: PCMU (sendrecv) 17:59:54.000 conference.c Port 1 (sip:192.168.140.130:5060) transmitting to port 0 (M - Input) 17:59:54.000 conference.c Port 0 (M - Input) transmitting to port 1 (sip:192.168.140.130:5060) 17:59:54.000 inv0016E014 Received Response msg 200/INVITE/cseq=22648 (rdata00134E14), sending ACK 17:59:54.000 endpoint Request msg ACK/cseq=22648 (tdta001766A0) created. 17:59:54.000 dlg0016E014 Sending Request msg ACK/cseq=22648 (tdta001766A0) 17:59:54.000 strm001723D4 Jitter buffer empty (prefetch=15) 17:59:54.000 strm001723D4 Start talksprut.. 17:59:54.000 sip_resolve.c Target '192.168.140.130:5060' type=UDP resolved to '192.168.140.130:5060' type=UDP (UDP transport) 17:59:54.000 pjsua_core.c TX 341 bytes Request msg ACK/cseq=22648 (tdta001766A0) to UDP 192.168.140.130:5060: ACK sip:192.168.140.130:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 192.168.140.133:5060;rport;branch=z9hG4bKPje30c0000000823482900 Max-Forwards: 70 From: sip:jack@192.168.195.170;tag=e30c0000000523482900 To: sip:192.168.140.130;tag=34e54cb54f6e463094dc785afafd402b Call-ID: e30c0000000623482900 CSeq: 22648 ACK Content-Length: 0 --end msg-- 17:59:54.000 strm001723D4 RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 17:59:54.000 strm001723D4 Jitter buffer is bufferring (prefetch=15).. 17:59:54.000 tsx00170F74 Timeout timer event 17:59:54.000 tsx00170F74 State changed from Terminated to Destroyed, event=TIMER 17:59:54.000 tdta001700E0 Destroying txdata Request msg INVITE/cseq=22648 (tdta001700E0) 17:59:54.000 tsx00170F74 Transaction destroyed! 17:59:54.000 strm001723D4 Jitter buffer is bufferring (prefetch=15).. 17:59:54.000 strm001723D4 Jitter buffer is bufferring (prefetch=15).. 17:59:54.000 strm001723D4 Jitter buffer is bufferring (prefetch=15).. 17:59:54.000 strm001723D4 Jitter buffer is bufferring (prefetch=15).. 17:59:54.000 strm001723D4 Jitter buffer is bufferring (prefetch=15).. 17:59:54.000 sound_port.c EC activated 17:59:54.000 strm001723D4 VAD re-enabled 17:59:55.000 strm001723D4 Jitter buffer empty (prefetch=15) 17:59:55.000 strm001723D4 Jitter buffer empty (prefetch=24) 17:59:56.000 strm001723D4 Jitter buffer empty (prefetch=24) 17:59:56.000 strm001723D4 Starting silence 17:59:56.000 strm001723D4 Jitter buffer empty (prefetch=24) 17:59:56.000 strm001723D4 Start talksprut.. 17:59:57.000 strm001723D4 Jitter buffer empty (prefetch=24) 17:59:57.000 strm001723D4 Jitter buffer empty (prefetch=24) 17:59:58.000 strm001723D4 Jitter buffer empty (prefetch=24)
