Hi,
I'm implementing a sip clien with pjsua library for Windows Mobile 6 using
C# and Sipek (Telefono.exe).
I implemented too a simple sip client for WindowsXP using C# and Sipek
(TelefonoWin.exe).
Well... I can communicate Telefono.exe with TelefonoWin.exe perfectly, but I
need to communicate Telefono.exe with pjsua-i686-pc-linux-gnu of pjproject
(in Ubuntu). And this don't work correctly.
This is the log of Telefono.exe:
11:48:19.000 sip_endpoint.c Module "mod-pjsua-log" registered
11:48:20.000 sip_endpoint.c Module "mod-tsx-layer" registered
11:48:20.000 sip_endpoint.c Module "mod-stateful-util" registered
11:48:20.000 sip_endpoint.c Module "mod-ua" registered
11:48:20.000 sip_endpoint.c Module "mod-100rel" registered
11:48:20.000 sip_endpoint.c Module "mod-pjsua" registered
11:48:20.000 sip_endpoint.c Module "mod-invite" registered
11:48:20.000 pasound.c PortAudio sound library initialized, status=0
11:48:20.000 pasound.c PortAudio host api count=2
11:48:20.000 pasound.c Sound device count=4
11:48:20.000 pjlib select() I/O Queue created (00061324)
11:48:20.000 conference.c Creating conference bridge with 254 ports
11:48:20.000 conference.c Sound device successfully created for port 0
11:48:20.000 sip_endpoint.c Module "mod-evsub" registered
11:48:20.000 sip_endpoint.c Module "mod-presence" registered
11:48:20.000 evsub.c Event pkg "presence" registered by
mod-presence
11:48:20.000 sip_endpoint.c Module "mod-refer" registered
11:48:21.000 evsub.c Event pkg "refer" registered by mod-refer
11:48:21.000 sip_endpoint.c Module "mod-pjsua-pres" registered
11:48:21.000 sip_endpoint.c Module "mod-pjsua-im" registered
11:48:21.000 sip_endpoint.c Module "mod-pjsua-options" registered
11:48:21.000 pjsua_core.c 1 SIP worker threads created
11:48:21.000 pjsua_core.c pjsua version 1.0.1 for win32-wince
initialized
11:48:21.000 pjsua_core.c SIP UDP socket reachable at
10.166.113.192:5060
11:48:21.000 udp0006BFE0 SIP UDP transport started, published address
is 10.166.113.192:5060
11:48:21.000 pjsua_acc.c Account <sip:10.166.113.192:5060> added with
id 0
11:48:21.000 pjsua_media.c RTP socket reachable at 10.166.113.192:4000
11:48:21.000 pjsua_media.c RTCP socket reachable at 10.166.113.192:4001
11:48:21.000 sip_endpoint.c Module "My-Module" registered
11:48:21.000 pjsipDll_mobil Codec s, prio 130
11:48:21.000 pjsipDll_mobil Setting codec (s) prio: 0
11:48:21.000 pjsipDll_mobil Codec s, prio 128
11:48:21.000 pjsipDll_mobil Setting codec (s) prio: 0
11:48:22.000 pjsipDll_mobil Codec G, prio 128
11:48:22.000 pjsipDll_mobil Setting codec (G) prio: 0
11:48:22.000 pjsipDll_mobil Codec P, prio 128
11:48:22.000 pjsipDll_mobil Setting codec (P) prio: 128
11:48:22.000 pjsipDll_mobil Codec G, prio 128
11:48:22.000 pjsipDll_mobil Setting codec (G) prio: 0
11:48:22.000 pjsipDll_mobil Codec G, prio 0
11:48:22.000 pjsipDll_mobil Setting codec (G) prio: 0
11:48:22.000 pjsipDll_mobil Codec s, prio 0
11:48:22.000 pjsipDll_mobil Setting codec (s) prio: 0
11:48:22.000 pjsipDll_mobil Codec s, prio 0
11:48:22.000 pjsipDll_mobil Setting codec (s) prio: 0
11:48:34.000 pjsua_media.c pjsua_set_snd_dev(): attempting to open
devices @8000 Hz
11:48:34.000 pasound.c Opened device A - Input(MME)/A - Output(MME)
for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per
frame, input latency=100 ms, output latency=100 ms
11:48:34.000 pasound.c Starting A - Input stream..
11:48:34.000 pasound.c Player thread started
11:48:34.000 pasound.c Done, status=0
11:48:34.000 pasound.c Recorder thread started
11:48:34.000 sound_port.c Echo canceller is now disabled in the sound
port
11:48:34.000 pjsua_call.c Making call with acc #0 to sip:10.166.113.193
11:48:34.000 dlg001C98D4 UAC dialog created
11:48:34.000 pjsua_media.c Media index 0 selected for call 0
11:48:34.000 dlg001C98D4 Module mod-invite added as dialog usage,
data=001C9F2C
11:48:34.000 dlg001C98D4 Session count inc to 2 by mod-invite
11:48:34.000 dlg001C98D4 Module mod-100rel added as dialog usage,
data=001CC654
11:48:34.000 dlg001C98D4 100rel module attached
11:48:35.000 inv001C98D4 UAC invite session created for dialog
dlg001C98D4
11:48:35.000 endpoint Request msg INVITE/cseq=31157 (tdta001CC6A0)
created.
11:48:35.000 inv001C98D4 Sending Request msg INVITE/cseq=31157
(tdta001CC6A0)
11:48:35.000 dlg001C98D4 Sending Request msg INVITE/cseq=31157
(tdta001CC6A0)
11:48:35.000 tsx001CD714 Transaction created for Request msg
INVITE/cseq=31156 (tdta001CC6A0)
11:48:35.000 tsx001CD714 Sending Request msg INVITE/cseq=31156
(tdta001CC6A0) in state Null
11:48:35.000 sip_resolve.c Target '10.166.113.193:0' type=Unspecified
resolved to '10.166.113.193:5060' type=UDP (UDP transport)
11:48:35.000 pjsua_core.c TX 928 bytes Request msg INVITE/cseq=31156
(tdta001CC6A0) to UDP 10.166.113.193:5060:
INVITE sip:10.166.113.193 SIP/2.0
Via: SIP/2.0/UDP
10.166.113.192:5060;rport;branch=z9hG4bKPjSbYaEA-kOM5BJvrBJy3HGu0XL.O3-A9m
Max-Forwards: 70
From: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
To: sip:10.166.113.193
Contact: <sip:10.166.113.192:5060>
Call-ID: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
CSeq: 31156 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
User-Agent: Sipek on PJSUA v1.0.1/win32-wince
Content-Type: application/sdp
Content-Length: 358
v=0
o=- 3447488914 3447488914 IN IP4 10.166.113.192
s=pjmedia
c=IN IP4 10.166.113.192
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 117 0 8 101
a=rtcp:4001 IN IP4 10.166.113.192
a=rtpmap:102 speex/8000
a=rtpmap:117 iLBC/8000
a=fmtp:117 mode=30
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
11:48:35.000 tsx001CD714 State changed from Null to Calling,
event=TX_MSG
11:48:35.000 dlg001C98D4 Transaction tsx001CD714 state changed to
Calling
11:48:35.000 pjsipDll_mobil Call 0 state changed to CALLING
11:48:35.000 sip_endpoint.c Processing incoming message: Response msg
100/INVITE/cseq=31156 (rdata0006C464)
11:48:36.000 pjsua_core.c RX 293 bytes Response msg
100/INVITE/cseq=31156 (rdata0006C464) from UDP 10.166.113.193:5060:
SIP/2.0 100 Trying
v: SIP/2.0/UDP 10.166.113.192:5060;rport=5060;received=10.166.113.192;branch=z9hG4bKPjSbYaEA-kOM5BJvrBJy3HGu0XL.O3-A9m
i: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
f: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
t: <sip:10.166.113.193>
CSeq: 31156 INVITE
l: 0
--end msg--
11:48:36.000 udp0006E140 Remote RTCP address switched to
10.166.113.193:4001
11:48:36.000 tsx001CD714 Incoming Response msg 100/INVITE/cseq=31156
(rdata0006C464) in state Calling
11:48:36.000 udp0006E140 Remote RTP address switched to
10.166.113.193:4000
11:48:36.000 tsx001CD714 State changed from Calling to Proceeding,
event=RX_MSG
11:48:36.000 udp0006E140 Remote RTCP address switched to
10.166.113.193:4001
11:48:36.000 dlg001C98D4 Received Response msg 100/INVITE/cseq=31156
(rdata0006C464)
11:48:36.000 dlg001C98D4 Transaction tsx001CD714 state changed to
Proceeding
11:48:36.000 sip_endpoint.c Processing incoming message: Response msg
200/INVITE/cseq=31156 (rdata0006C464)
11:48:36.000 pjsua_core.c RX 674 bytes Response msg
200/INVITE/cseq=31156 (rdata0006C464) from UDP 10.166.113.193:5060:
SIP/2.0 200 OK
v: SIP/2.0/UDP 10.166.113.192:5060;rport=5060;received=10.166.113.192;branch=z9hG4bKPjSbYaEA-kOM5BJvrBJy3HGu0XL.O3-A9m
i: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
f: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
t: <sip:10.166.113.193>;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
CSeq: 31156 INVITE
m: <sip:10.166.113.193:5060>
k: replaces, 100rel, norefersub
c: application/sdp
l: 262
v=0
o=- 3447481717 3447481718 IN IP4 10.166.113.193
s=pjmedia
c=IN IP4 10.166.113.193
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 101
a=rtcp:4001 IN IP4 10.166.113.193
a=rtpmap:102 speex/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
11:48:36.000 tsx001CD714 Incoming Response msg 200/INVITE/cseq=31156
(rdata0006C464) in state Proceeding
11:48:36.000 tsx001CD714 State changed from Proceeding to Terminated,
event=RX_MSG
11:48:36.000 dlg001C98D4 Received Response msg 200/INVITE/cseq=31156
(rdata0006C464)
11:48:36.000 dlg001C98D4 Route-set updated
11:48:37.000 dlg001C98D4 Route-set frozen
11:48:37.000 dlg001C98D4 Transaction tsx001CD714 state changed to
Terminated
11:48:37.000 pjsipDll_mobil Call 0 state changed to CONNECTING
11:48:37.000 inv001C98D4 Got SDP answer in Response msg
200/INVITE/cseq=31156 (rdata0006C464)
11:48:37.000 inv001C98D4 SDP negotiation done, status=0
11:48:37.000 pjsua_call.c Call 0: remote NAT type is 0 (Unknown)
11:48:37.000 rtp.c pjmedia_rtp_session_init: ses=001D1F18,
default_pt=102, ssrc=0x208a4d31
11:48:37.000 rtp.c pjmedia_rtp_session_init: ses=001D27B8,
default_pt=102, ssrc=0x208a4d31
11:48:37.000 stream.c Stream strm001D11B4 created
11:48:37.000 strm001D11B4 Encoder stream started
11:48:37.000 strm001D11B4 Decoder stream started
11:48:37.000 strm001D11B4 RTP status: badpt=0, badssrc=0, dup=0,
outorder=0, probation=-1, restart=0
11:48:37.000 pjsua_media.c Media updates, stream #0: speex (sendrecv)
11:48:38.000 strm001D11B4 Start talksprut..
11:48:38.000 conference.c Port 1 (sip:10.166.113.193) transmitting to
port 0 (A - Input)
11:48:38.000 strm001D11B4 jb updated(2), prefetch=7, size=8
11:48:38.000 conference.c Port 0 (A - Input) transmitting to port 1
(sip:10.166.113.193)
11:48:38.000 pjsipDll_mobil Media for call 0 is active
11:48:38.000 Master/sound 149 samples reduced, buf_cnt=651
11:48:38.000 Master/sound Buffer size adjusted from 800 to 651
(eff_cnt=480)
11:48:38.000 Master/sound 156 samples reduced, buf_cnt=655
11:48:38.000 pjsipDll_mobil Media for call 0 is active
11:48:38.000 inv001C98D4 Received Response msg 200/INVITE/cseq=31156
(rdata0006C464), sending ACK
11:48:38.000 Master/sound 173 samples reduced, buf_cnt=642
11:48:38.000 endpoint Request msg ACK/cseq=31156 (tdta001D5DF0)
created.
11:48:39.000 dlg001C98D4 Sending Request msg ACK/cseq=31156
(tdta001D5DF0)
11:48:39.000 Master/sound 145 samples reduced, buf_cnt=497
11:48:39.000 sip_resolve.c Target '10.166.113.193:5060' type=Unspecified
resolved to '10.166.113.193:5060' type=UDP (UDP transport)
11:48:39.000 Master/sound Buffer size adjusted from 642 to 497
(eff_cnt=480)
11:48:39.000 pjsua_core.c TX 356 bytes Request msg ACK/cseq=31156
(tdta001D5DF0) to UDP 10.166.113.193:5060:
ACK sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP
10.166.113.192:5060;rport;branch=z9hG4bKPjfkReB8oYooJ3wZexkKifQz.VuYoB3aAI
Max-Forwards: 70
From: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
To: sip:10.166.113.193;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
Call-ID: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
CSeq: 31156 ACK
Content-Length: 0
--end msg--
11:48:39.000 pjsipDll_mobil Call 0 state changed to CONFIRMED
11:48:39.000 sip_endpoint.c Processing incoming message: Response msg
200/INVITE/cseq=31156 (rdata0006C464)
11:48:39.000 pjsua_core.c RX 674 bytes Response msg
200/INVITE/cseq=31156 (rdata0006C464) from UDP 10.166.113.193:5060:
SIP/2.0 200 OK
v: SIP/2.0/UDP 10.166.113.192:5060;rport=5060;received=10.166.113.192;branch=z9hG4bKPjSbYaEA-kOM5BJvrBJy3HGu0XL.O3-A9m
i: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
f: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
t: <sip:10.166.113.193>;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
CSeq: 31156 INVITE
m: <sip:10.166.113.193:5060>
k: replaces, 100rel, norefersub
c: application/sdp
l: 262
v=0
o=- 3447481717 3447481718 IN IP4 10.166.113.193
s=pjmedia
c=IN IP4 10.166.113.193
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 101
a=rtcp:4001 IN IP4 10.166.113.193
a=rtpmap:102 speex/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
11:48:39.000 dlg001C98D4 Received Response msg 200/INVITE/cseq=31156
(rdata0006C464)
11:48:39.000 inv001C98D4 Received Response msg 200/INVITE/cseq=31156
(rdata0006C464), sending ACK
11:48:39.000 dlg001C98D4 Sending Request msg ACK/cseq=31156
(tdta001D5DF0)
11:48:40.000 sip_resolve.c Target '10.166.113.193:5060' type=Unspecified
resolved to '10.166.113.193:5060' type=UDP (UDP transport)
11:48:40.000 pjsua_core.c TX 356 bytes Request msg ACK/cseq=31156
(tdta001D5DF0) to UDP 10.166.113.193:5060:
ACK sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP
10.166.113.192:5060;rport;branch=z9hG4bKPjfkReB8oYooJ3wZexkKifQz.VuYoB3aAI
Max-Forwards: 70
From: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
To: sip:10.166.113.193;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
Call-ID: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
CSeq: 31156 ACK
Content-Length: 0
--end msg--
11:48:40.000 sip_endpoint.c Processing incoming message: Response msg
200/INVITE/cseq=31156 (rdata0006C464)
11:48:40.000 strm001D11B4 Jitter buffer empty (prefetch=7)
11:48:40.000 pjsua_core.c RX 674 bytes Response msg
200/INVITE/cseq=31156 (rdata0006C464) from UDP 10.166.113.193:5060:
SIP/2.0 200 OK
v: SIP/2.0/UDP 10.166.113.192:5060;rport=5060;received=10.166.113.192;branch=z9hG4bKPjSbYaEA-kOM5BJvrBJy3HGu0XL.O3-A9m
i: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
f: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
t: <sip:10.166.113.193>;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
CSeq: 31156 INVITE
m: <sip:10.166.113.193:5060>
k: replaces, 100rel, norefersub
c: application/sdp
l: 262
v=0
o=- 3447481717 3447481718 IN IP4 10.166.113.193
s=pjmedia
c=IN IP4 10.166.113.193
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 101
a=rtcp:4001 IN IP4 10.166.113.193
a=rtpmap:102 speex/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
11:48:40.000 dlg001C98D4 Received Response msg 200/INVITE/cseq=31156
(rdata0006C464)
11:48:40.000 Master/sound 17 samples reduced, buf_cnt=800
11:48:40.000 inv001C98D4 Received Response msg 200/INVITE/cseq=31156
(rdata0006C464), sending ACK
11:48:40.000 dlg001C98D4 Sending Request msg ACK/cseq=31156
(tdta001D5DF0)
11:48:40.000 Master/sound 80 samples reduced, buf_cnt=720
11:48:40.000 sip_resolve.c Target '10.166.113.193:5060' type=Unspecified
resolved to '10.166.113.193:5060' type=UDP (UDP transport)
11:48:40.000 Master/sound Buffer size adjusted from 800 to 720
(eff_cnt=480)
11:48:40.000 pjsua_core.c TX 356 bytes Request msg ACK/cseq=31156
(tdta001D5DF0) to UDP 10.166.113.193:5060:
ACK sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP
10.166.113.192:5060;rport;branch=z9hG4bKPjfkReB8oYooJ3wZexkKifQz.VuYoB3aAI
Max-Forwards: 70
From: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
To: sip:10.166.113.193;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
Call-ID: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
CSeq: 31156 ACK
Content-Length: 0
--end msg--
11:48:41.000 tsx001CD714 Timeout timer event
11:48:41.000 Master/sound 172 samples reduced, buf_cnt=548
11:48:41.000 tsx001CD714 State changed from Terminated to Destroyed,
event=TIMER
11:48:41.000 Master/sound Buffer size adjusted from 720 to 548
(eff_cnt=480)
11:48:41.000 tsx001CD714 Transaction destroyed!
11:48:41.000 Master/sound 134 samples reduced, buf_cnt=574
11:48:41.000 Master/sound Buffer size adjusted from 708 to 574
(eff_cnt=480)
11:48:42.000 Master/sound 231 samples reduced, buf_cnt=503
11:48:42.000 Master/sound Buffer size adjusted from 734 to 503
(eff_cnt=480)
11:48:42.000 Master/sound 111 samples reduced, buf_cnt=712
11:48:42.000 Master/sound 84 samples reduced, buf_cnt=628
11:48:42.000 Master/sound Buffer size adjusted from 712 to 628
(eff_cnt=480)
11:48:44.000 endpoint Request msg BYE/cseq=31158 (tdta001D6E00)
created.
11:48:44.000 inv001C98D4 Sending Request msg BYE/cseq=31158
(tdta001D6E00)
11:48:44.000 dlg001C98D4 Sending Request msg BYE/cseq=31158
(tdta001D6E00)
11:48:45.000 tsx001CD714 Transaction created for Request msg
BYE/cseq=31157 (tdta001D6E00)
11:48:45.000 tsx001CD714 Sending Request msg BYE/cseq=31157
(tdta001D6E00) in state Null
11:48:46.000 sip_resolve.c Target '10.166.113.193:5060' type=Unspecified
resolved to '10.166.113.193:5060' type=UDP (UDP transport)
11:48:46.000 pjsua_core.c TX 403 bytes Request msg BYE/cseq=31157
(tdta001D6E00) to UDP 10.166.113.193:5060:
BYE sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP
10.166.113.192:5060;rport;branch=z9hG4bKPj4T5gQINz3O3dldgtWaCMRRNHpgUvjaH8
Max-Forwards: 70
From: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
To: sip:10.166.113.193;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
Call-ID: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
CSeq: 31157 BYE
User-Agent: Sipek on PJSUA v1.0.1/win32-wince
Content-Length: 0
--end msg--
11:48:46.000 tsx001CD714 State changed from Null to Calling,
event=TX_MSG
11:48:47.000 sip_endpoint.c Processing incoming message: Response msg
481/BYE/cseq=31157 (rdata0006C464)
11:48:47.000 dlg001C98D4 Transaction tsx001CD714 state changed to
Calling
11:48:47.000 Master/sound 226 samples reduced, buf_cnt=562
11:48:47.000 Master/sound Buffer size adjusted from 788 to 562
(eff_cnt=612)
11:48:48.000 pjsua_core.c RX 352 bytes Response msg 481/BYE/cseq=31157
(rdata0006C464) from UDP 10.166.113.193:5060:
SIP/2.0 481 Call/Transaction Does Not Exist
v: SIP/2.0/UDP 10.166.113.192:5060;rport=5060;received=10.166.113.192;branch=z9hG4bKPj4T5gQINz3O3dldgtWaCMRRNHpgUvjaH8
i: -qyjexObCUwcuhdjLEXvRySSVYrccEeg
f: <sip:10.166.113.192>;tag=a8YVCcTZ5U94mCi4EaRaaTBpEalqzNeb
t: <sip:10.166.113.193>;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
CSeq: 31157 BYE
l: 0
--end msg--
11:48:48.000 tsx001CD714 Incoming Response msg 481/BYE/cseq=31157
(rdata0006C464) in state Calling
11:48:49.000 pjsipDll_mobil Releasing call 0
11:48:49.000 tsx001CD714 State changed from Calling to Completed,
event=RX_MSG
11:48:50.000 dlg001C98D4 Received Response msg 481/BYE/cseq=31157
(rdata0006C464)
11:48:50.000 dlg001C98D4 Transaction tsx001CD714 state changed to
Completed
11:48:51.000 Master/sound 142 samples reduced, buf_cnt=580
11:48:51.000 Master/sound Buffer size adjusted from 722 to 580
(eff_cnt=539)
11:48:51.000 pjsipDll_mobil Call 0 is DISCONNECTED [reason=200 (Normal
call clearing)]
11:48:52.000 pjsipDll_mobil Call 0 disconnected, dumping media stats..
11:48:52.000 pjsipDll_mobil
[DISCONNCTD] To: sip:10.166.113.193;tag=7oJWZbAmsO9faBwz2Pqxmy.V9vy46o2.
Call time: 00h:00m:13s, 1st res in 3000 ms, conn in 5000ms
SRTP status: Not active Crypto-suite: (null)
#0 speex @8KHz, sendrecv, peer=-
RX pt=102, stat last update: 00h:00m:00.000s ago
total 14pkt 532B (1.0KB +IP hdr) @avg=283bps/582bps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : -0.001 0.000 0.000 0.000 0.000
TX pt=102, ptime=20ms, stat last update: never
total 533pkt 14.9KB (36.2KB +IP hdr) @avg 7.9Kbps/19.3Kbps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
11:48:53.000 Master/sound 197 samples reduced, buf_cnt=543
11:48:53.000 Master/sound Buffer size adjusted from 740 to 543
(eff_cnt=484)
11:48:54.000 pjsua_media.c Media session for call 0 is destroyed
11:48:54.000 tdta001D5DF0 Destroying txdata Request msg ACK/cseq=31156
(tdta001D5DF0)
11:48:54.000 tdta001CC6A0 Destroying txdata Request msg
INVITE/cseq=31156 (tdta001CC6A0)
11:48:54.000 dlg001C98D4 Session count dec to 1 by mod-invite
11:48:59.000 tsx001CD714 Timeout timer event
11:48:59.000 tsx001CD714 State changed from Completed to Terminated,
event=TIMER
11:48:59.000 dlg001C98D4 Transaction tsx001CD714 state changed to
Terminated
11:48:59.000 dlg001C98D4 Dialog destroyed
11:48:59.000 tsx001CD714 Timeout timer event
11:48:59.000 tsx001CD714 State changed from Terminated to Destroyed,
event=TIMER
11:48:59.000 tdta001D6E00 Destroying txdata Request msg BYE/cseq=31157
(tdta001D6E00)
11:48:59.000 tsx001CD714 Transaction destroyed!
---------------------------------------------------------------------------------------------------------------------------------------------------------------------------------
And this is the console messages of pjsua-i686-pc-linux-gnu:
13:41:30.188 os_core_unix.c pjlib 1.0 for POSIX initialized
13:41:30.189 sip_endpoint.c Creating endpoint instance...
13:41:30.189 pjlib select() I/O Queue created (0x8d14130)
13:41:30.189 sip_endpoint.c Module "mod-msg-print" registered
13:41:30.189 sip_transport. Transport manager created.
13:41:30.189 sip_endpoint.c Module "mod-pjsua-log" registered
13:41:30.189 sip_endpoint.c Module "mod-tsx-layer" registered
13:41:30.189 sip_endpoint.c Module "mod-stateful-util" registered
13:41:30.189 sip_endpoint.c Module "mod-ua" registered
13:41:30.189 sip_endpoint.c Module "mod-100rel" registered
13:41:30.189 sip_endpoint.c Module "mod-pjsua" registered
13:41:30.189 sip_endpoint.c Module "mod-invite" registered
13:41:30.198 pasound.c PortAudio sound library initialized, status=0
13:41:30.198 pasound.c PortAudio host api count=1
13:41:30.198 pasound.c Sound device count=1
13:41:30.198 pjlib select() I/O Queue created (0x8d1c9b4)
13:41:30.199 sip_endpoint.c Module "mod-evsub" registered
13:41:30.199 sip_endpoint.c Module "mod-presence" registered
13:41:30.199 sip_endpoint.c Module "mod-refer" registered
13:41:30.199 sip_endpoint.c Module "mod-pjsua-pres" registered
13:41:30.199 sip_endpoint.c Module "mod-pjsua-im" registered
13:41:30.199 sip_endpoint.c Module "mod-pjsua-options" registered
13:41:30.199 pjsua_core.c 1 SIP worker threads created
13:41:30.199 pjsua_core.c pjsua version 1.0 for i686-pc-linux-gnu
initialized
13:41:30.199 pjsua_core.c SIP UDP socket reachable at
10.166.113.193:5060
13:41:30.199 udp0x8d2a1e8 SIP UDP transport started, published address
is 10.166.113.193:5060
13:41:30.199 pjsua_acc.c Account <sip:10.166.113.193:5060> added with
id 0
13:41:30.200 pjsua_media.c RTP socket reachable at 10.166.113.193:4000
13:41:30.200 pjsua_media.c RTCP socket reachable at 10.166.113.193:4001
13:41:30.200 pjsua_media.c RTP socket reachable at 10.166.113.193:4002
13:41:30.200 pjsua_media.c RTCP socket reachable at 10.166.113.193:4003
13:41:30.200 pjsua_media.c RTP socket reachable at 10.166.113.193:4004
13:41:30.200 pjsua_media.c RTCP socket reachable at 10.166.113.193:4005
13:41:30.200 pjsua_media.c RTP socket reachable at 10.166.113.193:4006
13:41:30.200 pjsua_media.c RTCP socket reachable at 10.166.113.193:4007
13:41:30.200 pjsua_media.c pjsua_set_snd_dev(): attempting to open
devices @8000 Hz
13:41:30.200 pjsua_media.c ..failed: Invalid sample rate
13:41:30.200 pjsua_media.c pjsua_set_snd_dev(): attempting to open
devices @44100 Hz
13:41:30.246 sound_port.c Echo canceller is now disabled in the sound
port
>>>>
Account list:
*[ 0] <sip:10.166.113.193:5060>: does not register
Online status: Online
Buddy list:
-none-
+=============================================================================+
| Call Commands: | Buddy, IM & Presence: |
Account: |
| |
| |
| m Make new call | +b Add new buddy .| +a Add new
accnt |
| M Make multiple calls | -b Delete buddy | -a Delete
accnt. |
| a Answer call | i Send IM | !a Modify
accnt. |
| h Hangup call (ha=all) | s Subscribe presence | rr
(Re-)register |
| H Hold call | u Unsubscribe presence | ru
Unregister |
| v re-inVite (release hold) | t ToGgle Online status | > Cycle next
ac.|
| U send UPDATE | T Set online status | < Cycle prev
ac.|
| ],[ Select next/prev call
+--------------------------+-------------------+
| x Xfer call | Media Commands: | Status &
Config: |
| X Xfer with Replaces |
| |
| # Send RFC 2833 DTMF | cl List ports | d Dump
status |
| * Send DTMF with INFO | cc Connect port | dd Dump
detailed |
| dq Dump curr. call quality | cd Disconnect port | dc Dump
config |
| | V Adjust audio Volume | f Save
config |
| S Send arbitrary REQUEST | Cp Codec priorities | f Save
config |
+------------------------------+--------------------------+-------------------+
| q QUIT sleep MS echo [0|1|txt] n: detect NAT
type |
+=============================================================================+
You have 0 active call
>>> 13:41:47.118 pjsua_core.c RX 916 bytes Request msg INVITE/cseq=15721
(rdata0x8d2a65c) from UDP 10.166.113.192:5060:
INVITE sip:10.166.113.193 SIP/2.0
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport;branch=z9hG4bKPjQ0yXDPo8CZEaiimhg1mWTvU8s33.cMag
Max-Forwards: 70
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: sip:10.166.113.193
Contact: <sip:84.124.50.13:2134>
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
CSeq: 15721 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
User-Agent: Sipek on PJSUA v1.0.1/win32-wince
Content-Type: application/sdp
Content-Length: 352
v=0
o=- 3447488505 3447488505 IN IP4 84.124.50.13
s=pjmedia
c=IN IP4 84.124.50.13
t=0 0
a=X-nat:8
m=audio 2135 RTP/AVP 102 117 0 8 101
a=rtcp:2136 IN IP4 84.124.50.13
a=rtpmap:102 speex/8000
a=rtpmap:117 iLBC/8000
a=fmtp:117 mode=30
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
13:41:47.140 pjsua_media.c Media index 0 selected for call 0
13:41:47.140 pjsua_core.c TX 314 bytes Response msg
100/INVITE/cseq=15721 (tdta0x8d3f968) to UDP 10.166.113.192:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport=5060;received=10.166.113.192;branch=z9hG4bKPjQ0yXDPo8CZEaiimhg1mWTvU8s33.cMag
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: <sip:10.166.113.193>
CSeq: 15721 INVITE
Content-Length: 0
--end msg--
13:41:47.140 pjsua_app.c Call 0 state changed to INCOMING
13:41:47.140 conference.c Port 2 (ring) transmitting to port 0 (system
(44KHz))
13:41:47.141 strm0x8d42eac Encoder stream started
13:41:47.141 strm0x8d42eac Decoder stream started
13:41:47.141 pjsua_media.c Media updates, stream #0: speex (sendrecv)
13:41:47.141 conference.c Port 2 (ring) stop transmitting to port 0
(system (44KHz))
13:41:47.141 conference.c Port 3 (sip:84.124.50.13) transmitting to port
0 (system (44KHz))
13:41:47.141 conference.c Port 0 (system (44KHz)) transmitting to port 3
(sip:84.124.50.13)
13:41:47.141 pjsua_app.c Media for call 0 is active
13:41:47.141 pjsua_core.c TX 812 bytes Response msg
200/INVITE/cseq=15721 (tdta0x8d3f968) to UDP 10.166.113.192:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport=5060;received=10.166.113.192;branch=z9hG4bKPjQ0yXDPo8CZEaiimhg1mWTvU8s33.cMag
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: <sip:10.166.113.193>;tag=AanLWodg1WMMb4C6YaYFiho9dsVi5aCy
CSeq: 15721 INVITE
Contact: <sip:10.166.113.193:5060>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Type: application/sdp
Content-Length: 262
v=0
o=- 3447488507 3447488508 IN IP4 10.166.113.193
s=pjmedia
c=IN IP4 10.166.113.193
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 101
a=rtcp:4001 IN IP4 10.166.113.193
a=rtpmap:102 speex/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
13:41:47.141 pjsua_app.c Call 0 state changed to CONNECTING
13:41:47.642 pjsua_core.c TX 812 bytes Response msg
200/INVITE/cseq=15721 (tdta0x8d3f968) to UDP 10.166.113.192:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport=5060;received=10.166.113.192;branch=z9hG4bKPjQ0yXDPo8CZEaiimhg1mWTvU8s33.cMag
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: <sip:10.166.113.193>;tag=AanLWodg1WMMb4C6YaYFiho9dsVi5aCy
CSeq: 15721 INVITE
Contact: <sip:10.166.113.193:5060>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Type: application/sdp
Content-Length: 262
v=0
o=- 3447488507 3447488508 IN IP4 10.166.113.193
s=pjmedia
c=IN IP4 10.166.113.193
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 101
a=rtcp:4001 IN IP4 10.166.113.193
a=rtpmap:102 speex/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
13:41:48.618 udp0x8d2b808 Remote RTCP address switched to
10.166.113.192:4001
13:41:48.645 pjsua_core.c TX 812 bytes Response msg
200/INVITE/cseq=15721 (tdta0x8d3f968) to UDP 10.166.113.192:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport=5060;received=10.166.113.192;branch=z9hG4bKPjQ0yXDPo8CZEaiimhg1mWTvU8s33.cMag
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: <sip:10.166.113.193>;tag=AanLWodg1WMMb4C6YaYFiho9dsVi5aCy
CSeq: 15721 INVITE
Contact: <sip:10.166.113.193:5060>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Type: application/sdp
Content-Length: 262
v=0
o=- 3447488507 3447488508 IN IP4 10.166.113.193
s=pjmedia
c=IN IP4 10.166.113.193
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 102 101
a=rtcp:4001 IN IP4 10.166.113.193
a=rtpmap:102 speex/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
--end msg--
-----------------------------------WHY!!!???!!!------------------------------------------------------------------------------
13:41:49.128 udp0x8d2b808 Remote RTP address switched to
10.166.113.192:4000
13:41:49.142 pjsua_app.c Call 0 is DISCONNECTED [reason=408 (Request
Timeout)]
13:41:49.142 pjsua_app.c
[DISCONNCTD] To: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
-----------------------------------------------------------------------------------------------------------------------------------
Call time: 00h:00m:00s, 1st res in 22 ms, conn in 0ms
SRTP status: Not active Crypto-suite: (null)
#0 speex @8KHz, sendrecv, peer=10.166.113.192:4000
RX pt=102, stat last update: 00h:00m:00.014s ago
total 10pkt 280B (680B +IP hdr) @avg=1.1Kbps/2.7Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : -0.001 0.000 0.000 0.000 0.000
TX pt=102, ptime=20ms, stat last update: never
total 100pkt 3.8KB (7.8KB +IP hdr) @avg 15.1Kbps/31.1Kbps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
13:41:49.142 pjsua_media.c Media session for call 0 is destroyed
13:41:50.683 pjsua_core.c RX 352 bytes Request msg ACK/cseq=15721
(rdata0x8d2a65c) from UDP 10.166.113.192:5060:
ACK sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport;branch=z9hG4bKPja0g5zF00Uq8bl.zgSf4-fjBoVSr9S.pC
Max-Forwards: 70
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: sip:10.166.113.193;tag=AanLWodg1WMMb4C6YaYFiho9dsVi5aCy
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
CSeq: 15721 ACK
Content-Length: 0
--end msg--
13:41:51.358 pjsua_core.c RX 352 bytes Request msg ACK/cseq=15721
(rdata0x8d2a65c) from UDP 10.166.113.192:5060:
ACK sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport;branch=z9hG4bKPja0g5zF00Uq8bl.zgSf4-fjBoVSr9S.pC
Max-Forwards: 70
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: sip:10.166.113.193;tag=AanLWodg1WMMb4C6YaYFiho9dsVi5aCy
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
CSeq: 15721 ACK
Content-Length: 0
--end msg--
13:41:52.097 pjsua_core.c RX 352 bytes Request msg ACK/cseq=15721
(rdata0x8d2a65c) from UDP 10.166.113.192:5060:
ACK sip:10.166.113.193:5060 SIP/2.0
Via: SIP/2.0/UDP 84.124.50.13:2134
;rport;branch=z9hG4bKPja0g5zF00Uq8bl.zgSf4-fjBoVSr9S.pC
Max-Forwards: 70
From: <sip:84.124.50.13>;tag=DYv2zZMrWtzpiUXscjbkUPUfpy3ZLZcq
To: sip:10.166.113.193;tag=AanLWodg1WMMb4C6YaYFiho9dsVi5aCy
Call-ID: nMjSI-hRitsNCmlSD83qksoxjE4QRY8y
CSeq: 15721 ACK
Content-Length: 0
--end msg--
-------------------------------------------------------------------------------------------------------------------------------------------------
Someone knows why pjsua disconnect?
Thanks.
PD: Sorry for my english...
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20090331/28ccfdd1/attachment-0001.html>
