RTP recv() error with error code 130054

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Hi all:
    In my application I'm also facing a problem with audio. Once the call
has been bridged I have only one way of audio, (i.e) I can hear the Remote
end while the Remote end can't hear what i say. Can anybody tell me the fix
for this issue?
    After check the log file, i found there are many lines show such as : RTP
recv() error: Connection reset by peer (WSAECONNRESET) [err:130054]
    Any help is greatly appreciated!!*
*
The logs:

[2009-07-06] : 11:02:08.265   pjsua_core.c  RX 906 bytes Request msg
INVITE/cseq=5207 (rdata00B3FC2C) from UDP 202.109.211.242:5060:
INVITE sip:059188244006 at 82.34.1.0:0;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 202.109.211.242:5060;branch=z9hG4bK8c9adaf2ff22ed4a
Via: SIP/2.0/UDP 10.32.101.253:5060
;received=10.32.101.253;branch=z9hG4bK152d4cb3.0
To: "59188244006"<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>
From: "87678926"<sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
CSeq: 5207 INVITE
Max-Forwards: 9
Contact: <sip:87678926 at 202.109.211.242:5060>
Record-Route: <sip:202.109.211.242;lr>
Record-Route: <sip:10.32.101.253;lr>
Supported: 100rel,timer,path
Session-Expires: 3600
Min-SE: 58
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,INFO,REFER,NOTIFY,PRACK,UPDATE
User-Agent: ZTE Softswitch/1.0.0
Content-Type: application/sdp
Content-Length: 129

v=0
o=ZTE 3 23210 IN IP4 202.109.211.242
s=phone-call
c=IN IP4 202.109.211.242
t=0 0
m=audio 32412 RTP/AVP 0 8
a=ptime:20

--end msg--
[2009-07-06] : 11:02:08.265 sip_endpoint.c   xutm ............... the module
is 'mod-tsx-layer'
[2009-07-06] : 11:02:08.265 sip_endpoint.c   xutm ............... the module
is 'mod-ua'
[2009-07-06] : 11:02:08.265 sip_endpoint.c   xutm ............... the module
is 'mod-invite'
[2009-07-06] : 11:02:08.265 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua'
[2009-07-06] : 11:02:08.265  pjsua_media.c  Media index 0 selected for call
0
[2009-07-06] : 11:02:08.265    tsx00B5129C  Transaction created for Request
msg INVITE/cseq=5207 (rdata00B3FC2C)
[2009-07-06] : 11:02:08.265    tsx00B5129C  Incoming Request msg
INVITE/cseq=5207 (rdata00B3FC2C) in state Null
[2009-07-06] : 11:02:08.265    tsx00B5129C  State changed from Null to
Trying, event=RX_MSG
[2009-07-06] : 11:02:08.265    dlg00B5015C  Transaction tsx00B5129C state
changed to Trying
[2009-07-06] : 11:02:08.265    dlg00B5015C  UAS dialog created
[2009-07-06] : 11:02:08.265    dlg00B5015C  Module mod-invite added as
dialog usage, data=00B4C064
[2009-07-06] : 11:02:08.265    dlg00B5015C  Session count inc to 2 by
mod-invite
[2009-07-06] : 11:02:08.265    inv00B5015C  UAS invite session created for
dialog dlg00B5015C
[2009-07-06] : 11:02:08.265   pjsua_call.c  Call 0: remote NAT type is 0
(Unknown)
[2009-07-06] : 11:02:08.265       endpoint  Response msg
180/INVITE/cseq=5207 (tdta00B53280) created
[2009-07-06] : 11:02:08.265    dlg00B5015C  Initial answer Response msg
180/INVITE/cseq=5207 (tdta00B53280)
[2009-07-06] : 11:02:08.265    inv00B5015C  Sending Response msg
180/INVITE/cseq=5207 (tdta00B53280)
[2009-07-06] : 11:02:08.265    dlg00B5015C  Sending Response msg
180/INVITE/cseq=5207 (tdta00B53280)
[2009-07-06] : 11:02:08.265    tsx00B5129C  Sending Response msg
180/INVITE/cseq=5207 (tdta00B53280) in state Trying
[2009-07-06] : 11:02:08.265    tsx00B5129C  xutm here we check if the event
is PJSIP_EVENT_TX_MSG 1111 .........
[2009-07-06] : 11:02:08.265  sip_resolve.c  Target '202.109.211.242:5060'
type=UDP resolved to '202.109.211.242:5060' type=UDP (UDP transport)
[2009-07-06] : 11:02:08.265   pjsua_core.c  TX 602 bytes Response msg
180/INVITE/cseq=5207 (tdta00B53280) to UDP 202.109.211.242:5060:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 202.109.211.242:5060
;received=202.109.211.242;branch=z9hG4bK8c9adaf2ff22ed4a
Via: SIP/2.0/UDP 10.32.101.253:5060
;received=10.32.101.253;branch=z9hG4bK152d4cb3.0
Record-Route: <sip:202.109.211.242;lr>
Record-Route: <sip:10.32.101.253;lr>
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
From: "87678926" <sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
To: "59188244006"
<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>;tag=ab8d6c7c57c54e3387d2a85c346d6fc1
CSeq: 5207 INVITE
Contact: <sip:059188244006 at 191.168.17.14:1394;transport=UDP>
Content-Length:  0


--end msg--
[2009-07-06] : 11:02:08.265    tsx00B5129C  State changed from Trying to
Proceeding, event=TX_MSG
[2009-07-06] : 11:02:08.265    dlg00B5015C  Transaction tsx00B5129C state
changed to Proceeding
[2009-07-06] : 11:02:08.281    dlg00B5015C   xutm ........ the dialog usage
is 'mod-invite'
[2009-07-06] : 11:02:08.281  pjsua_media.c   xutm ......... open the sound
device ...........
[2009-07-06] : 11:02:08.281  pjsua_media.c  Opening sound device PCM at 16000
/1/20ms
[2009-07-06] : 11:02:08.359       pa_dev.c  Opened device Microsoft ????? -
Input(MME)/Microsoft ????? - Output(MME) for recording and playback, sample
rate=16000, ch=1, bits=16, 320 samples per frame, input latency=100 ms,
output latency=100 ms
[2009-07-06] : 11:02:08.359     ec00B354B8  Creating AEC
[2009-07-06] : 11:02:08.359     ec00B354B8  AEC created, clock_rate=16000,
channel=1, samples per frame=320, tail length=200 ms, latency=100 ms
[2009-07-06] : 11:02:08.359       pa_dev.c  Starting Microsoft ????? - Input
stream..
[2009-07-06] : 11:02:08.359       pa_dev.c  PA message: Pa_StartStream:
waveInStart returned = 0x0.

[2009-07-06] : 11:02:08.359       pa_dev.c  Done, status=0
[2009-07-06] : 11:02:08.359   conference.c  Port 2 (ring) transmitting to
port 0 (Microsoft ????? - Input)
[2009-07-06] : 11:02:08.359    pjsua_app.c  Incoming call for account 2!
From: "87678926" <sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>
To: "59188244006"
<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>
Press a to answer or h to reject call
[2009-07-06] : 11:02:08.406       pa_dev.c  Player thread started
[2009-07-06] : 11:02:08.421       pa_dev.c  Recorder thread started
[2009-07-06] : 11:02:08.421     ec00B354B8  Prefetching..
[2009-07-06] : 11:02:08.453     ec00B354B8  Prefetching..
[2009-07-06] : 11:02:08.453     ec00B354B8  Prefetching..
[2009-07-06] : 11:02:08.484     ec00B354B8  Prefetching..
[2009-07-06] : 11:02:08.500     ec00B354B8  Prefetching..
[2009-07-06] : 11:02:08.500     ec00B354B8  Latency bufferring complete
[2009-07-06] : 11:02:08.765 sip_endpoint.c  Processing incoming message:
Request msg INVITE/cseq=5207 (rdata00B3FC2C)
[2009-07-06] : 11:02:08.765 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-log'
[2009-07-06] : 11:02:08.765   pjsua_core.c  RX 899 bytes Request msg
INVITE/cseq=5207 (rdata00B3FC2C) from UDP 202.109.211.242:5060:
INVITE sip:059188244006 at 82.34.1.0:0;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 202.109.211.242:5060;branch=z9hG4bK8c9adaf2ff22ed4a
Via: SIP/2.0/UDP 218.5.1.5:1035;received=218.5.1.5;branch=z9hG4bK152d4cb3.0
To: "59188244006"<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>
From: "87678926"<sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
CSeq: 5207 INVITE
Max-Forwards: 9
Contact: <sip:87678926 at 202.109.211.242:5060>
Record-Route: <sip:202.109.211.242;lr>
Record-Route: <sip:218.5.1.5:1035;lr>
Supported: 100rel,timer,path
Session-Expires: 3600
Min-SE: 58
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,INFO,REFER,NOTIFY,PRACK,UPDATE
User-Agent: ZTE Softswitch/1.0.0
Content-Type: application/sdp
Content-Length: 129

v=0
o=ZTE 3 23210 IN IP4 202.109.211.242
s=phone-call
c=IN IP4 202.109.211.242
t=0 0
m=audio 32412 RTP/AVP 0 8
a=ptime:20

--end msg--
[2009-07-06] : 11:02:08.765 sip_endpoint.c   xutm ............... the module
is 'mod-tsx-layer'
[2009-07-06] : 11:02:08.765 sip_transactio   xutm ............ here in
mod_tsx_layer_on_rx_request ...........
[2009-07-06] : 11:02:08.765    tsx00B5129C  Incoming Request msg
INVITE/cseq=5207 (rdata00B3FC2C) in state Proceeding
[2009-07-06] : 11:02:08.765    tsx00B5129C  ************** xutm here we
check if the event is PJSIP_EVENT_RX_MSG .........
[2009-07-06] : 11:02:08.781    tsx00B5129C  enter into else
flow....................................
[2009-07-06] : 11:02:08.781    tsx00B5129C  xutm ........... generate new
response here........................
[2009-07-06] : 11:02:08.781       endpoint  Response msg
180/INVITE/cseq=5207 (tdta00B84868) created
[2009-07-06] : 11:02:08.781   pjsua_core.c  TX 496 bytes Response msg
180/INVITE/cseq=5207 (tdta00B84868) to UDP 202.109.211.242:5060:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 202.109.211.242:5060
;received=202.109.211.242;branch=z9hG4bK8c9adaf2ff22ed4a
Via: SIP/2.0/UDP 218.5.1.5:1035;received=218.5.1.5;branch=z9hG4bK152d4cb3.0
Record-Route: <sip:202.109.211.242;lr>
Record-Route: <sip:218.5.1.5:1035;lr>
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
From: "87678926" <sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
To: "59188244006"
<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>
CSeq: 5207 INVITE
Content-Length:  0


--end msg--
[2009-07-06] : 11:02:08.796     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:09.609     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:10.859     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:12.015     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:12.812     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:14.000     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:14.015    pjsua_acc.c  Sending 2 bytes keep-alive
packet for acc 2 to 202.109.211.242:5060
[2009-07-06] : 11:02:14.015   tdta00B4E1A8  Destroying txdata raw
[2009-07-06] : 11:02:14.093 sip_endpoint.c  Processing incoming message:
Request msg OPTIONS/cseq=10000 (rdata00B3FC2C)
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-log'
[2009-07-06] : 11:02:14.093   pjsua_core.c  RX 357 bytes Request msg
OPTIONS/cseq=10000 (rdata00B3FC2C) from UDP 202.109.211.242:5060:
OPTIONS sip:059188244006 at 191.168.17.14:1394 SIP/2.0
Via: SIP/2.0/UDP 202.109.211.242:5060;branch=z9hG4bK537e2a5d36ac388d
Max-Forwards: 70
To: <sip:059188244006 at 202.109.211.242 <sip%3A059188244006 at 202.109.211.242>>
From: BgwLinkTest25922<sip:bgw@202.109.211.242 <sip%3Abgw at 202.109.211.242>
>;tag=200307191120
Call-ID: 6a46200307191120 at 202.109.211.242
CSeq: 10000 OPTIONS
Accept: application/sdp
Content-Length: 0


--end msg--
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-tsx-layer'
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-ua'
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-invite'
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua'
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-pres'
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-im'
[2009-07-06] : 11:02:14.093 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-options'
[2009-07-06] : 11:02:14.093       endpoint  Response msg
200/OPTIONS/cseq=10000 (tdta00B4E1A8) created
[2009-07-06] : 11:02:14.093  sip_resolve.c  Target '202.109.211.242:5060'
type=UDP resolved to '202.109.211.242:5060' type=UDP (UDP transport)
[2009-07-06] : 11:02:14.093   pjsua_core.c  TX 949 bytes Response msg
200/OPTIONS/cseq=10000 (tdta00B4E1A8) to UDP 202.109.211.242:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 202.109.211.242:5060
;received=202.109.211.242;branch=z9hG4bK537e2a5d36ac388d
Call-ID: 6a46200307191120 at 202.109.211.242
From: "BgwLinkTest25922" <sip:bgw@202.109.211.242<sip%3Abgw at 202.109.211.242>
>;tag=200307191120
To: <sip:059188244006 at 202.109.211.242 <sip%3A059188244006 at 202.109.211.242>>
CSeq: 10000 OPTIONS
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Accept: application/sdp, application/pidf+xml, application/xpidf+xml,
message/sipfrag;version=2.0, application/im-iscomposing+xml, text/plain
Supported: eventlist
Allow-Events: presence, refer
User-Agent: PJSUA v1.1/win32
Content-Type: application/sdp
Content-Length:   291

v=0
o=- 3455866934 3455866934 IN IP4 191.168.17.14
s=pjmedia
c=IN IP4 191.168.17.14
t=0 0
m=audio 4000 RTP/AVP 0 8 9 101
a=rtcp:4001 IN IP4 191.168.17.14
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv

--end msg--
[2009-07-06] : 11:02:14.093   tdta00B4E1A8  Destroying txdata Response msg
200/OPTIONS/cseq=10000 (tdta00B4E1A8)
[2009-07-06] : 11:02:15.218     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:15.796    inv00B5015C  SDP negotiation done, status=0
[2009-07-06] : 11:02:15.796   pjsua_call.c  Call 0: remote NAT type is 0
(Unknown)
[2009-07-06] : 11:02:15.796   strm00B861E4  VAD temporarily disabled
[2009-07-06] : 11:02:15.796          rtp.c  pjmedia_rtp_session_init:
ses=00B87A1C, default_pt=0, ssrc=0x18be6784
[2009-07-06] : 11:02:15.796          rtp.c  pjmedia_rtp_session_init:
ses=00B88040, default_pt=0, ssrc=0x18be6784
[2009-07-06] : 11:02:15.796       stream.c  Stream strm00B861E4 created
[2009-07-06] : 11:02:15.796   strm00B861E4  Encoder stream started
[2009-07-06] : 11:02:15.796   strm00B861E4  Decoder stream started
[2009-07-06] : 11:02:15.796     resample.c  resample created: high qualiy,
large filter, in/out rate=8000/16000
[2009-07-06] : 11:02:15.796     resample.c  resample created: high qualiy,
large filter, in/out rate=16000/8000
[2009-07-06] : 11:02:15.796  pjsua_media.c  Media updates, stream #0: PCMU
(sendrecv)
[2009-07-06] : 11:02:15.796   conference.c  Port 2 (ring) stop transmitting
to port 0 (Microsoft ????? - Input)
[2009-07-06] : 11:02:15.796   conference.c  Port 3 (
sip:87678926 at 202.109.211.242 <sip%3A87678926 at 202.109.211.242>) transmitting
to port 0 (Microsoft ????? - Input)
[2009-07-06] : 11:02:15.812   conference.c  Port 0 (Microsoft ????? - Input)
transmitting to port 3
(sip:87678926 at 202.109.211.242<sip%3A87678926 at 202.109.211.242>
)
[2009-07-06] : 11:02:15.812    pjsua_app.c  Media for call 0 is active
[2009-07-06] : 11:02:15.812    inv00B5015C  Sending Response msg
200/INVITE/cseq=5207 (tdta00B84868)
[2009-07-06] : 11:02:15.812    dlg00B5015C  Sending Response msg
200/INVITE/cseq=5207 (tdta00B84868)
[2009-07-06] : 11:02:15.812   Master/sound  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:15.812    tsx00B5129C  Sending Response msg
200/INVITE/cseq=5207 (tdta00B84868) in state Proceeding
[2009-07-06] : 11:02:15.812   strm00B861E4  Jitter buffer empty (prefetch=0)
[2009-07-06] : 11:02:15.812    tsx00B5129C  xutm here we check if the event
is PJSIP_EVENT_TX_MSG 1111 .........
[2009-07-06] : 11:02:15.812   pjsua_core.c  TX 936 bytes Response msg
200/INVITE/cseq=5207 (tdta00B84868) to UDP 202.109.211.242:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 202.109.211.242:5060
;received=202.109.211.242;branch=z9hG4bK8c9adaf2ff22ed4a
Via: SIP/2.0/UDP 218.5.1.5:1035;received=218.5.1.5;branch=z9hG4bK152d4cb3.0
Record-Route: <sip:202.109.211.242;lr>
Record-Route: <sip:218.5.1.5:1035;lr>
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
From: "87678926" <sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
To: "59188244006"
<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>;tag=ab8d6c7c57c54e3387d2a85c346d6fc1
CSeq: 5207 INVITE
Contact: <sip:059188244006 at 191.168.17.14:1394;transport=UDP>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS
Supported: eventlist
Content-Type: application/sdp
Content-Length:   198

v=0
o=- 3455866928 3455866929 IN IP4 191.168.17.14
s=pjmedia
c=IN IP4 191.168.17.14
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 0
a=rtcp:4001 IN IP4 191.168.17.14
a=rtpmap:0 PCMU/8000
a=sendrecv

--end msg--
[2009-07-06] : 11:02:15.812    tsx00B5129C  State changed from Proceeding to
Completed, event=TX_MSG
[2009-07-06] : 11:02:15.812    dlg00B5015C  Transaction tsx00B5129C state
changed to Completed
[2009-07-06] : 11:02:15.812    dlg00B5015C   xutm ........ the dialog usage
is 'mod-invite'
[2009-07-06] : 11:02:15.812    pjsua_app.c  Call 0 state changed to
CONNECTING
[2009-07-06] : 11:02:15.812     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:15.828 sip_endpoint.c  Processing incoming message:
Request msg ACK/cseq=5207 (rdata00B3FC2C)
[2009-07-06] : 11:02:15.828 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-log'
[2009-07-06] : 11:02:15.828   pjsua_core.c  RX 509 bytes Request msg
ACK/cseq=5207 (rdata00B3FC2C) from UDP 202.109.211.242:5060:
ACK sip:059188244006 at 82.34.1.0:0;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 202.109.211.242:5060;branch=z9hG4bK9fd1d872104c5569
Via: SIP/2.0/UDP 218.5.1.5:1035;received=218.5.1.5;branch=z9hG4bK7597262c.0
To: "59188244006"<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>;tag=ab8d6c7c57c54e3387d2a85c346d6fc1
From: "87678926"<sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
CSeq: 5207 ACK
Max-Forwards: 9
User-Agent: ZTE Softswitch/1.0.0
Content-Length: 0


--end msg--
[2009-07-06] : 11:02:15.828 sip_endpoint.c   xutm ............... the module
is 'mod-tsx-layer'
[2009-07-06] : 11:02:15.828 sip_endpoint.c   xutm ............... the module
is 'mod-ua'
[2009-07-06] : 11:02:15.843     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:15.843    dlg00B5015C  Received Request msg
ACK/cseq=5207 (rdata00B3FC2C)
[2009-07-06] : 11:02:15.843    tsx00B5129C  Request to terminate transaction
[2009-07-06] : 11:02:15.843    tsx00B5129C  State changed from Completed to
Terminated, event=USER
[2009-07-06] : 11:02:15.843    dlg00B5015C  Transaction tsx00B5129C state
changed to Terminated
[2009-07-06] : 11:02:15.843    dlg00B5015C   xutm ........ the dialog usage
is 'mod-invite'
[2009-07-06] : 11:02:15.859     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:15.859   strm00B861E4  Start talksprut..
[2009-07-06] : 11:02:15.843    pjsua_app.c  Call 0 state changed to
CONFIRMED
[2009-07-06] : 11:02:15.906    tsx00B5129C  Timeout timer event
[2009-07-06] : 11:02:15.906    tsx00B5129C  State changed from Terminated to
Destroyed, event=TIMER
[2009-07-06] : 11:02:15.906   tdta00B84868  Destroying txdata Response msg
200/INVITE/cseq=5207 (tdta00B84868)
[2009-07-06] : 11:02:15.906    tsx00B5129C  Transaction destroyed!
[2009-07-06] : 11:02:15.984   strm00B861E4  RTP status: badpt=0, badssrc=0,
dup=0, outorder=0, probation=-1, restart=0
[2009-07-06] : 11:02:16.000   strm00B861E4  jb updated(2), prefetch=1,
size=2
[2009-07-06] : 11:02:16.000   strm00B861E4  PUT prefetch_cnt=1/1
[2009-07-06] : 11:02:16.015   strm00B861E4  jb updated(2), prefetch=2,
size=2
[2009-07-06] : 11:02:16.031   strm00B861E4  PUT prefetch_cnt=2/2
[2009-07-06] : 11:02:16.109   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:16.171   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:16.203   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:16.375   strm00B861E4  jb updated(2), prefetch=4,
size=4
[2009-07-06] : 11:02:16.390   strm00B861E4  PUT prefetch_cnt=3/4
[2009-07-06] : 11:02:16.390   strm00B861E4  PUT prefetch_cnt=4/4
[2009-07-06] : 11:02:16.468   strm00B861E4  VAD re-enabled
[2009-07-06] : 11:02:16.484   strm00B861E4  Starting silence
[2009-07-06] : 11:02:17.156   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:17.875   silencedet.c  Starting talk burst (level=1425
threshold=1000)
[2009-07-06] : 11:02:17.875   strm00B861E4  Start talksprut..
[2009-07-06] : 11:02:17.890   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:17.937     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:17.984   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:18.296   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:18.484   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:18.828   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:19.093   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:19.156     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:19.562   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:19.578   Master/sound  226 samples reduced,
buf_cnt=1374
[2009-07-06] : 11:02:19.578   Master/sound  Buffer size adjusted from 1600
to 1374 (eff_cnt=960)
[2009-07-06] : 11:02:19.578   Master/sound  239 samples reduced,
buf_cnt=1135
[2009-07-06] : 11:02:19.578   Master/sound  Buffer size adjusted from 1374
to 1135 (eff_cnt=960)
[2009-07-06] : 11:02:19.765   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:20.328   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:20.343     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:20.343   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:20.578   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:20.765   Master/sound  360 samples reduced,
buf_cnt=1095
[2009-07-06] : 11:02:20.765   Master/sound  Buffer size adjusted from 1455
to 1095 (eff_cnt=880)
[2009-07-06] : 11:02:21.140     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:21.296   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:21.531   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:21.875   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:21.953   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:21.953   Master/sound  357 samples reduced,
buf_cnt=1058
[2009-07-06] : 11:02:21.953   Master/sound  Buffer size adjusted from 1415
to 1058 (eff_cnt=820)
[2009-07-06] : 11:02:22.171   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:22.359     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:22.484   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:22.765   Master/sound  286 samples reduced,
buf_cnt=1092
[2009-07-06] : 11:02:22.765   Master/sound  Buffer size adjusted from 1378
to 1092 (eff_cnt=820)
[2009-07-06] : 11:02:22.765   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:23.015   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:23.531   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:23.546     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:23.546   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:23.812   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:23.968   Master/sound  340 samples reduced,
buf_cnt=1072
[2009-07-06] : 11:02:23.968   Master/sound  Buffer size adjusted from 1412
to 1072 (eff_cnt=775)
[2009-07-06] : 11:02:24.062   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:24.140   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:24.171   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:24.343   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:24.343     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:24.578   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:25.000   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:25.156   Master/sound  466 samples reduced, buf_cnt=926
[2009-07-06] : 11:02:25.156   Master/sound  Buffer size adjusted from 1392
to 926 (eff_cnt=775)
[2009-07-06] : 11:02:25.171   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:25.390   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:25.562     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:25.625   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:25.953   Master/sound  257 samples reduced, buf_cnt=989
[2009-07-06] : 11:02:25.953   Master/sound  Buffer size adjusted from 1246
to 989 (eff_cnt=775)
[2009-07-06] : 11:02:25.968   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:26.046   silencedet.c  Starting silence (level=33
threshold=600)
[2009-07-06] : 11:02:26.046   strm00B861E4  Starting silence
[2009-07-06] : 11:02:26.593   silencedet.c  Starting talk burst (level=860
threshold=600)
[2009-07-06] : 11:02:26.593   strm00B861E4  Start talksprut..
[2009-07-06] : 11:02:26.640   strm00B861E4  RTP recv() error: Connection
reset by peer (WSAECONNRESET) [err:130054]
[2009-07-06] : 11:02:26.750     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:26.750   strm00B861E4  JB shrinking 1 frame(s), size=6
[2009-07-06] : 11:02:26.984   strm00B861E4  JB shrinking 1 frame(s), size=5
[2009-07-06] : 11:02:27.140 sip_endpoint.c  Processing incoming message:
Request msg BYE/cseq=5208 (rdata00B3FC2C)
[2009-07-06] : 11:02:27.140 sip_endpoint.c   xutm ............... the module
is 'mod-pjsua-log'
[2009-07-06] : 11:02:27.140   pjsua_core.c  RX 509 bytes Request msg
BYE/cseq=5208 (rdata00B3FC2C) from UDP 202.109.211.242:5060:
BYE sip:059188244006 at 82.34.1.0:0;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 202.109.211.242:5060;branch=z9hG4bKca1b22d665dd6549
Via: SIP/2.0/UDP 218.5.1.5:1035;received=218.5.1.5;branch=z9hG4bK7a8f5cd6.0
To: "59188244006"<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>;tag=ab8d6c7c57c54e3387d2a85c346d6fc1
From: "87678926"<sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
CSeq: 5208 BYE
Max-Forwards: 9
User-Agent: ZTE Softswitch/1.0.0
Content-Length: 0


--end msg--
[2009-07-06] : 11:02:27.140 sip_endpoint.c   xutm ............... the module
is 'mod-tsx-layer'
[2009-07-06] : 11:02:27.140 sip_endpoint.c   xutm ............... the module
is 'mod-ua'
[2009-07-06] : 11:02:27.140    dlg00B5015C  Received Request msg
BYE/cseq=5208 (rdata00B3FC2C)
[2009-07-06] : 11:02:27.140    tsx00B5129C  Transaction created for Request
msg BYE/cseq=5208 (rdata00B3FC2C)
[2009-07-06] : 11:02:27.140    tsx00B5129C  Incoming Request msg
BYE/cseq=5208 (rdata00B3FC2C) in state Null
[2009-07-06] : 11:02:27.140    tsx00B5129C  State changed from Null to
Trying, event=RX_MSG
[2009-07-06] : 11:02:27.140    dlg00B5015C  Transaction tsx00B5129C state
changed to Trying
[2009-07-06] : 11:02:27.140    dlg00B5015C   xutm ........ the dialog usage
is 'mod-invite'
[2009-07-06] : 11:02:27.140       endpoint  Response msg 200/BYE/cseq=5208
(tdta00B84868) created
[2009-07-06] : 11:02:27.140    dlg00B5015C  Sending Response msg
200/BYE/cseq=5208 (tdta00B84868)
[2009-07-06] : 11:02:27.140    tsx00B5129C  Sending Response msg
200/BYE/cseq=5208 (tdta00B84868) in state Trying
[2009-07-06] : 11:02:27.140    tsx00B5129C  xutm here we check if the event
is PJSIP_EVENT_TX_MSG 1111 .........
[2009-07-06] : 11:02:27.140  sip_resolve.c  Target '202.109.211.242:5060'
type=UDP resolved to '202.109.211.242:5060' type=UDP (UDP transport)
[2009-07-06] : 11:02:27.140   pjsua_core.c  TX 446 bytes Response msg
200/BYE/cseq=5208 (tdta00B84868) to UDP 202.109.211.242:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 202.109.211.242:5060
;received=202.109.211.242;branch=z9hG4bKca1b22d665dd6549
Via: SIP/2.0/UDP 218.5.1.5:1035;received=218.5.1.5;branch=z9hG4bK7a8f5cd6.0
Call-ID: 00006b4000002c57-0001-0020 at 10.32.101.253
From: "87678926" <sip:87678926@202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
To: "59188244006"
<sip:59188244006 at 202.109.211.242<sip%3A59188244006 at 202.109.211.242>
>;tag=ab8d6c7c57c54e3387d2a85c346d6fc1
CSeq: 5208 BYE
Content-Length:  0


--end msg--
[2009-07-06] : 11:02:27.140    tsx00B5129C  State changed from Trying to
Completed, event=TX_MSG
[2009-07-06] : 11:02:27.140    dlg00B5015C  Transaction tsx00B5129C state
changed to Completed
[2009-07-06] : 11:02:27.140    dlg00B5015C   xutm ........ the dialog usage
is 'mod-invite'
[2009-07-06] : 11:02:27.140    pjsua_app.c  Call 0 is DISCONNECTED
[reason=200 (Normal call clearing)]
[2009-07-06] : 11:02:27.140    pjsua_app.c  Call 0 disconnected, dumping
media stats..
[2009-07-06] : 11:02:27.140    pjsua_app.c
[2009-07-06] :  [DISCONNCTD] To: "87678926"
<sip:87678926 at 202.109.211.242<sip%3A87678926 at 202.109.211.242>
>;tag=0a2065fd-0000523d000002af
    Call time: 00h:00m:11s, 1st res in 7531 ms, conn in 7578ms
    SRTP status: Not active Crypto-suite: (null)
    #0 PCMU @8KHz, sendrecv, peer=202.109.211.242:32412
       RX pt=0, stat last update: 00h:00m:01.906s ago
          total 558pkt 89.2KB (111.6KB +IP hdr) @avg=62.9Kbps/78.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.000   1.401  26.250   0.625   2.558
       TX pt=0, ptime=20ms, stat last update: 00h:00m:06.172s ago
          total 457pkt 73.1KB (91.4KB +IP hdr) @avg 51.5Kbps/64.4Kbps
          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.125   0.125   0.125   0.125   0.000
      RTT msec       :  13.351  13.351  13.351  13.351   0.000
[2009-07-06] : 11:02:27.156  pjsua_media.c  Media session for call 0 is
destroyed
[2009-07-06] : 11:02:27.156    dlg00B5015C  Session count dec to 3 by
mod-invite
[2009-07-06] : 11:02:27.562     ec00B354B8  Underflow, buf_cnt=0, will
generate 1 frame
[2009-07-06] : 11:02:28.156  pjsua_media.c  Closing sound device after idle
for 1 seconds
[2009-07-06] : 11:02:28.156  pjsua_media.c  Closing Microsoft ????? - Output
sound playback device and Microsoft ????? - Input sound capture device
[2009-07-06] : 11:02:28.171       pa_dev.c  Stopping stream..
[2009-07-06] : 11:02:28.171       pa_dev.c  PA message: WinMME StopStream:
waiting for background thread.

[2009-07-06] : 11:02:28.265       pa_dev.c  PA message: WinMME StopStream:
waiting for background thread.

[2009-07-06] : 11:02:28.265       pa_dev.c  Done, status=0
[2009-07-06] : 11:02:28.265       pa_dev.c  Closing Microsoft ????? - Input:
0 underflow, 0 overflow
[2009-07-06] : 11:02:29.015    pjsua_acc.c  Sending 2 bytes keep-alive
packet for acc 2 to 202.109.211.242:5060
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20090706/9c29a30f/attachment-0001.html>


[Index of Archives]     [Asterisk Users]     [Asterisk App Development]     [Linux ARM Kernel]     [Linux ARM]     [Linux Omap]     [Fedora ARM]     [IETF Annouce]     [Security]     [Bugtraq]     [Linux]     [Linux OMAP]     [Linux MIPS]     [Linux API]
  Powered by Linux