[pjsip] Application crash on Windows Mobile 5.0

Samer Faour smf18 at aub.edu.lb
Tue Feb 19 11:04:19 EST 2008


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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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)


More information about the pjsip mailing list