too many "samples reduced" in Win6.1

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

 



Why there are so many "samples reduced" in AT&T Incite Win6.1 and can only
heard noise from the other party?
The cpu has 500 Mhz, and cpu load only 40%.
Has anyone seen this probelm before in WM6 with pjsip 1.0.3, or any 1.0.x?

This problem does not happend in Win5.0 Hp/CPQ.

Thankk,

-fcch


22:46:47.148 pjsua_media.c pjsua_set_snd_dev(): attempting to open devices
@8000 Hz

22:46:47.194 pasound.c Opened device A(MME)/A(MME) for recording and
playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input
latency=100 ms, output latency=100 ms

22:46:47.199 pasound.c Starting A stream..

22:46:47.239 pasound.c Player thread started

22:46:47.271 pasound.c Done, status=0

22:46:47.274 ec01AC2930 Creating Echo suppressor

22:46:47.278 ec01AC2930 Echo suppressor created, clock_rate=8000, channel=1,
samples per frame=160, tail length=256 ms, latency=100 ms

22:46:47.281 pjsua_call.c Making call with acc #0 to sip:192.168.2.102

22:46:47.289 dlg01AC5284 UAC dialog created

22:46:47.475 ec01AC2930 Latency bufferring complete

22:46:47.734 pasound.c Recorder thread started

22:46:47.801 pjsua_media.c Media index 0 selected for call 0

22:46:47.805 dlg01AC5284 Module mod-invite added as dialog usage,
data=01AC58DC

22:46:47.806 dlg01AC5284 Session count inc to 3 by mod-invite

22:46:47.807 dlg01AC5284 Module mod-100rel added as dialog usage,
data=01AC81B4

22:46:47.808 dlg01AC5284 100rel module attached

22:46:47.808 inv01AC5284 UAC invite session created for dialog dlg01AC5284

22:46:47.810 endpoint Request msg INVITE/cseq=24690 (tdta01AC8390) created.

22:46:47.811 inv01AC5284 Sending Request msg INVITE/cseq=24690
(tdta01AC8390)

22:46:47.812 dlg01AC5284 Sending Request msg INVITE/cseq=24690
(tdta01AC8390)

22:46:47.821 ec01AC2930 239 samples reduced, buf_cnt=721

22:46:47.822 ec01AC2930 Buffer size adjusted from 960 to 721 (eff_cnt=560)

22:46:47.825 tsx01AC9404 Transaction created for Request msg
INVITE/cseq=24689 (tdta01AC8390)

22:46:47.826 tsx01AC9404 Sending Request msg INVITE/cseq=24689
(tdta01AC8390) in state Null

22:46:47.827 sip_resolve.c Target '192.168.2.102:0' type=Unspecified
resolved to '192.168.2.102:5060' type=UDP (UDP transport)

22:46:47.829 pjsua_core.c TX 950 bytes Request msg INVITE/cseq=24689
(tdta01AC8390) to UDP 192.168.2.102:5060:

INVITE sip:192.168.2.102 SIP/2.0

Via: SIP/2.0/UDP 192.168.2.109:5060
;rport;branch=z9hG4bKPjCMYjp8HgJKxISw8cNLYWF92xM7.2iug8

Max-Forwards: 70

From: <sip:192.168.2.109>;tag=DuIGTRI4k6dwrkM8a.VUqlvyANQ5xoGA

To: sip:192.168.2.102

Contact: <sip:192.168.2.109:5060>

Call-ID: 3wXeu2ZeDOXZ4W7p79fUqGnbRNpvzMf6

CSeq: 24689 INVITE

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS

Supported: replaces, 100rel, norefersub

Content-Type: application/sdp

Content-Length: 432

v=0

o=- 3465154007 3465154007 IN IP4 192.168.2.109

s=pjmedia

c=IN IP4 192.168.2.109

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 0 8 102 117 103 9 3 101

a=rtcp:4001 IN IP4 192.168.2.109

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:9 G722/8000

a=rtpmap:3 GSM/8000

a=sendrecv

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-15

--end msg--

22:46:47.847 tsx01AC9404 State changed from Null to Calling, event=TX_MSG

22:46:47.848 dlg01AC5284 Transaction tsx01AC9404 state changed to Calling

22:46:47.940 ec01AC2930 240 samples reduced, buf_cnt=801

22:46:47.945 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:47.950 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:47.955 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.000 sip_endpoint.c Processing incoming message: Response msg
100/INVITE/cseq=24689 (rdata01AAB004)

22:46:48.001 pjsua_core.c RX 314 bytes Response msg 100/INVITE/cseq=24689
(rdata01AAB004) from UDP 192.168.2.102:5060:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 192.168.2.109:5060
;rport=5060;received=192.168.2.109;branch=z9hG4bKPjCMYjp8HgJKxISw8cNLYWF92xM7.2iug8

Call-ID: 3wXeu2ZeDOXZ4W7p79fUqGnbRNpvzMf6

From: <sip:192.168.2.109>;tag=DuIGTRI4k6dwrkM8a.VUqlvyANQ5xoGA

To: <sip:192.168.2.102>

CSeq: 24689 INVITE

Content-Length: 0



--end msg--

22:46:48.002 tsx01AC9404 Incoming Response msg 100/INVITE/cseq=24689
(rdata01AAB004) in state Calling

22:46:48.003 tsx01AC9404 State changed from Calling to Proceeding,
event=RX_MSG

22:46:48.005 dlg01AC5284 Received Response msg 100/INVITE/cseq=24689
(rdata01AAB004)

22:46:48.005 dlg01AC5284 Transaction tsx01AC9404 state changed to Proceeding

22:46:48.040 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.162 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:48.162 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:48.172 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:48.179 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.264 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.383 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.391 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.398 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.406 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.413 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.488 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:48.489 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:48.603 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:48.612 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.619 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.704 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.831 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.860 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.875 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.897 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.912 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.929 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.944 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.960 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:48.974 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:48.975 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:49.052 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:49.065 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.080 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.093 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.152 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.271 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:49.272 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:49.290 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:49.303 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.350 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.471 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.484 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.499 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.512 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.527 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.572 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.690 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:49.692 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:49.709 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:49.724 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.790 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.911 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.924 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.939 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.952 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:49.983 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.012 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:50.013 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:50.132 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:50.148 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.161 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.230 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.361 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:50.363 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:50.380 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:50.393 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.452 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.571 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.586 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.599 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.614 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.627 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.670 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.789 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:50.792 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:50.808 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:50.823 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:50.892 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.011 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.026 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.039 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.054 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.067 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.110 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:51.112 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:51.231 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:51.246 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.261 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.332 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.467 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.480 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.495 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.508 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.523 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.551 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:51.553 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:51.671 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:51.686 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.701 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.773 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.891 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:51.892 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:51.909 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:51.923 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:51.991 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.109 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.124 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.137 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.152 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.167 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.220 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:52.221 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:52.333 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:52.348 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.361 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.431 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.549 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.578 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.593 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.608 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.621 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.652 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:52.653 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:52.773 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:52.787 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.802 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.871 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:52.989 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:52.991 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:53.008 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:53.023 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.092 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.211 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.240 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.259 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.272 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.291 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.329 sip_endpoint.c Processing incoming message: Response msg
200/INVITE/cseq=24689 (rdata01AAB004)

22:46:53.330 pjsua_core.c RX 803 bytes Response msg 200/INVITE/cseq=24689
(rdata01AAB004) from UDP 192.168.2.102:5060:

SIP/2.0 200 OK

Via: SIP/2.0/UDP 192.168.2.109:5060
;rport=5060;received=192.168.2.109;branch=z9hG4bKPjCMYjp8HgJKxISw8cNLYWF92xM7.2iug8

Call-ID: 3wXeu2ZeDOXZ4W7p79fUqGnbRNpvzMf6

From: <sip:192.168.2.109>;tag=DuIGTRI4k6dwrkM8a.VUqlvyANQ5xoGA

To: <sip:192.168.2.102>;tag=debed56f3fd5455eb936c4528132ceda

CSeq: 24689 INVITE

Contact: <sip:192.168.2.102:5060>

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER,
MESSAGE, OPTIONS

Supported: replaces, 100rel, norefersub

Content-Type: application/sdp

Content-Length: 254

v=0

o=- 3465154013 3465154014 IN IP4 192.168.2.102

s=pjmedia

c=IN IP4 192.168.2.102

t=0 0

a=X-nat:0

m=audio 4004 RTP/AVP 0 101

a=rtcp:4005 IN IP4 192.168.2.102

a=rtpmap:0 PCMU/8000

a=sendrecv

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-15

--end msg--

22:46:53.338 tsx01AC9404 Incoming Response msg 200/INVITE/cseq=24689
(rdata01AAB004) in state Proceeding

22:46:53.340 tsx01AC9404 State changed from Proceeding to Terminated,
event=RX_MSG

22:46:53.341 dlg01AC5284 Received Response msg 200/INVITE/cseq=24689
(rdata01AAB004)

22:46:53.342 dlg01AC5284 Route-set updated

22:46:53.343 dlg01AC5284 Route-set frozen

22:46:53.344 dlg01AC5284 Transaction tsx01AC9404 state changed to Terminated

22:46:53.352 udp01AADBD0 Remote RTP address switched to 192.168.2.102:4004

22:46:53.358 udp01AADBD0 Remote RTCP address switched to 192.168.2.102:4005

22:46:53.408 inv01AC5284 Got SDP answer in Response msg
200/INVITE/cseq=24689 (rdata01AAB004)

22:46:53.446 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:53.448 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:53.470 ec01AC2930 241 samples reduced, buf_cnt=801

22:46:53.488 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.500 inv01AC5284 SDP negotiation done, status=0

22:46:53.501 pjsua_call.c Call 0: remote NAT type is 0 (Unknown)

22:46:53.509 strm01ACC694 VAD temporarily disabled

22:46:53.510 rtp.c pjmedia_rtp_session_init: ses=01ACDED8, default_pt=0,
ssrc=0x7a833393

22:46:53.524 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.512 rtp.c pjmedia_rtp_session_init: ses=01ACE4FC, default_pt=0,
ssrc=0x7a833393

22:46:53.528 stream.c Stream strm01ACC694 created

22:46:53.528 strm01ACC694 Encoder stream started

22:46:53.529 strm01ACC694 Decoder stream started

22:46:53.535 pjsua_media.c Media updates, stream #0: PCMU (sendrecv)

22:46:53.537 conference.c Port 1 (sip:192.168.2.102) transmitting to port 0
(A)

22:46:53.538 conference.c Port 0 (A) transmitting to port 1
(sip:192.168.2.102)

22:46:53.539 inv01AC5284 Received Response msg 200/INVITE/cseq=24689
(rdata01AAB004), sending ACK

22:46:53.541 endpoint Request msg ACK/cseq=24689 (tdta01ACF750) created.

22:46:53.542 dlg01AC5284 Sending Request msg ACK/cseq=24689 (tdta01ACF750)

22:46:53.543 sip_resolve.c Target '192.168.2.102:5060' type=Unspecified
resolved to '192.168.2.102:5060' type=UDP (UDP transport)

22:46:53.545 pjsua_core.c TX 352 bytes Request msg ACK/cseq=24689
(tdta01ACF750) to UDP 192.168.2.102:5060:

ACK sip:192.168.2.102:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.2.109:5060
;rport;branch=z9hG4bKPjfkReB8oYooJ3wZexkKifQz.VuYoB3aAI

Max-Forwards: 70

From: <sip:192.168.2.109>;tag=DuIGTRI4k6dwrkM8a.VUqlvyANQ5xoGA

To: sip:192.168.2.102;tag=debed56f3fd5455eb936c4528132ceda

Call-ID: 3wXeu2ZeDOXZ4W7p79fUqGnbRNpvzMf6

CSeq: 24689 ACK

Content-Length: 0



--end msg--

22:46:53.559 strm01ACC694 RTP status: badpt=0, badssrc=0, dup=0, outorder=0,
probation=-1, restart=0

22:46:53.615 tsx01AC9404 Timeout timer event

22:46:53.621 tsx01AC9404 State changed from Terminated to Destroyed,
event=TIMER

22:46:53.622 tsx01AC9404 Transaction destroyed!

22:46:53.638 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.646 strm01ACC694 Start talksprut..

22:46:53.657 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.659 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.685 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.687 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.704 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.705 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.721 ec01AC2930 160 samples reduced, buf_cnt=801

22:46:53.846 ec01AC2930 239 samples reduced, buf_cnt=562

22:46:53.847 ec01AC2930 Buffer size adjusted from 801 to 562 (eff_cnt=560)

22:46:53.850 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.872 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.887 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.920 ec01AC2930 159 samples reduced, buf_cnt=883

22:46:53.922 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:53.946 ec01AC2930 160 samples reduced, buf_cnt=883

22:46:54.068 ec01AC2930 159 samples reduced, buf_cnt=724

22:46:54.069 ec01AC2930 Buffer size adjusted from 883 to 724 (eff_cnt=560)

22:46:54.071 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.087 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.110 ec01AC2930 160 samples reduced, buf_cnt=884

22:46:54.118 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.140 ec01AC2930 160 samples reduced, buf_cnt=884

22:46:54.238 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.260 ec01AC2930 203 samples reduced, buf_cnt=841

22:46:54.262 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.284 ec01AC2930 159 samples reduced, buf_cnt=842

22:46:54.292 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.303 strm01ACC694 jb updated(2), prefetch=8, size=47

22:46:54.304 strm01ACC694 JB shrinking 1 frame(s), cur size=46

22:46:54.319 ec01AC2930 118 samples reduced, buf_cnt=884

22:46:54.442 strm01ACC694 jb updated(2), prefetch=14, size=46

22:46:54.445 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.478 ec01AC2930 160 samples reduced, buf_cnt=884

22:46:54.487 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.510 ec01AC2930 160 samples reduced, buf_cnt=884

22:46:54.536 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:54.625 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.662 ec01AC2930 161 samples reduced, buf_cnt=883

22:46:54.673 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.697 ec01AC2930 239 samples reduced, buf_cnt=804

22:46:54.781 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.826 strm01ACC694 JB shrinking 1 frame(s), cur size=45

22:46:54.841 ec01AC2930 160 samples reduced, buf_cnt=804

22:46:54.941 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:54.965 ec01AC2930 43 samples reduced, buf_cnt=921

22:46:54.979 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.003 ec01AC2930 160 samples reduced, buf_cnt=921

22:46:55.036 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:55.081 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.118 ec01AC2930 196 samples reduced, buf_cnt=885

22:46:55.127 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.151 ec01AC2930 203 samples reduced, buf_cnt=842

22:46:55.228 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.242 strm01ACC694 JB shrinking 1 frame(s), cur size=35

22:46:55.257 ec01AC2930 160 samples reduced, buf_cnt=842

22:46:55.361 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.384 ec01AC2930 197 samples reduced, buf_cnt=805

22:46:55.400 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.422 ec01AC2930 43 samples reduced, buf_cnt=922

22:46:55.501 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.512 strm01ACC694 VAD re-enabled

22:46:55.517 silencedet.c Starting talk burst (level=1380 threshold=1000)

22:46:55.540 ec01AC2930 242 samples reduced, buf_cnt=840

22:46:55.550 strm01ACC694 JB shrinking 1 frame(s), cur size=46

22:46:55.641 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.665 ec01AC2930 75 samples reduced, buf_cnt=925

22:46:55.681 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.711 ec01AC2930 199 samples reduced, buf_cnt=886

22:46:55.756 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:55.781 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.817 ec01AC2930 240 samples reduced, buf_cnt=806

22:46:55.826 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.849 ec01AC2930 42 samples reduced, buf_cnt=924

22:46:55.930 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:55.955 strm01ACC694 JB shrinking 1 frame(s), cur size=34

22:46:55.965 ec01AC2930 276 samples reduced, buf_cnt=808

22:46:56.057 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.087 ec01AC2930 43 samples reduced, buf_cnt=925

22:46:56.095 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.118 ec01AC2930 199 samples reduced, buf_cnt=886

22:46:56.203 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.236 ec01AC2930 118 samples reduced, buf_cnt=928

22:46:56.245 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.267 strm01ACC694 JB shrinking 1 frame(s), cur size=45

22:46:56.291 ec01AC2930 281 samples reduced, buf_cnt=807

22:46:56.360 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.382 ec01AC2930 88 samples reduced, buf_cnt=879

22:46:56.456 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:56.483 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.522 strm01ACC694 Lost frame recovered

22:46:56.534 strm01ACC694 Lost frame recovered

22:46:56.543 ec01AC2930 193 samples reduced, buf_cnt=846

22:46:56.556 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.580 ec01AC2930 119 samples reduced, buf_cnt=887

22:46:56.622 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.671 strm01ACC694 JB shrinking 1 frame(s), cur size=37

22:46:56.680 ec01AC2930 233 samples reduced, buf_cnt=814

22:46:56.756 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.781 ec01AC2930 125 samples reduced, buf_cnt=849

22:46:56.796 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.818 ec01AC2930 78 samples reduced, buf_cnt=931

22:46:56.897 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.920 ec01AC2930 194 samples reduced, buf_cnt=897

22:46:56.933 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:56.948 strm01ACC694 JB shrinking 1 frame(s), cur size=42

22:46:56.957 ec01AC2930 245 samples reduced, buf_cnt=812

22:46:57.047 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.078 ec01AC2930 42 samples reduced, buf_cnt=930

22:46:57.178 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.201 ec01AC2930 159 samples reduced, buf_cnt=931

22:46:57.211 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:57.215 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.237 ec01AC2930 160 samples reduced, buf_cnt=931

22:46:57.317 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.331 ec01AC2930 240 samples reduced, buf_cnt=851

22:46:57.342 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.373 ec01AC2930 116 samples reduced, buf_cnt=895

22:46:57.458 strm01ACC694 JB shrinking 1 frame(s), cur size=42

22:46:57.477 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.491 ec01AC2930 205 samples reduced, buf_cnt=850

22:46:57.597 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.619 ec01AC2930 199 samples reduced, buf_cnt=811

22:46:57.632 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.653 ec01AC2930 153 samples reduced, buf_cnt=818

22:46:57.725 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:57.737 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.772 ec01AC2930 160 samples reduced, buf_cnt=818

22:46:57.877 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.890 ec01AC2930 169 samples reduced, buf_cnt=809

22:46:57.899 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:57.931 ec01AC2930 27 samples reduced, buf_cnt=942

22:46:57.936 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:58.017 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.050 ec01AC2930 290 samples reduced, buf_cnt=812

22:46:58.060 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.080 ec01AC2930 119 samples reduced, buf_cnt=853

22:46:58.166 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.178 strm01ACC694 JB shrinking 1 frame(s), cur size=39

22:46:58.195 ec01AC2930 207 samples reduced, buf_cnt=806

22:46:58.296 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.320 ec01AC2930 123 samples reduced, buf_cnt=843

22:46:58.332 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.356 ec01AC2930 199 samples reduced, buf_cnt=804

22:46:58.426 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:58.436 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.459 ec01AC2930 38 samples reduced, buf_cnt=926

22:46:58.471 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.493 ec01AC2930 200 samples reduced, buf_cnt=886

22:46:58.585 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.629 ec01AC2930 163 samples reduced, buf_cnt=883

22:46:58.645 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:58.716 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.751 ec01AC2930 116 samples reduced, buf_cnt=927

22:46:58.760 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.782 ec01AC2930 279 samples reduced, buf_cnt=808

22:46:58.857 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:58.905 strm01ACC694 JB shrinking 1 frame(s), cur size=42

22:46:58.914 ec01AC2930 83 samples reduced, buf_cnt=885

22:46:58.996 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.019 ec01AC2930 159 samples reduced, buf_cnt=886

22:46:59.032 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.065 ec01AC2930 162 samples reduced, buf_cnt=884

22:46:59.136 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.160 ec01AC2930 241 samples reduced, buf_cnt=803

22:46:59.168 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:59.173 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.194 ec01AC2930 122 samples reduced, buf_cnt=841

22:46:59.287 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.311 ec01AC2930 124 samples reduced, buf_cnt=877

22:46:59.425 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.447 strm01ACC694 JB shrinking 1 frame(s), cur size=42

22:46:59.458 ec01AC2930 201 samples reduced, buf_cnt=836

22:46:59.470 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.492 ec01AC2930 37 samples reduced, buf_cnt=959

22:46:59.556 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.580 ec01AC2930 159 samples reduced, buf_cnt=960

22:46:59.593 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.627 ec01AC2930 281 samples reduced, buf_cnt=839

22:46:59.686 strm01ACC694 JB shrinking 1 frame(s), cur size=38

22:46:59.705 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.741 ec01AC2930 40 samples reduced, buf_cnt=959

22:46:59.836 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.860 ec01AC2930 242 samples reduced, buf_cnt=877

22:46:59.907 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:46:59.918 strm01ACC694 JB shrinking 1 frame(s), cur size=40

22:46:59.936 ec01AC2930 121 samples reduced, buf_cnt=916

22:46:59.976 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:47:00.025 ec01AC2930 161 samples reduced, buf_cnt=915

22:47:00.116 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:47:00.141 ec01AC2930 238 samples reduced, buf_cnt=837

22:47:00.155 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:47:00.177 strm01ACC694 JB shrinking 1 frame(s), cur size=43

22:47:00.190 ec01AC2930 160 samples reduced, buf_cnt=837

22:47:00.258 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:47:00.290 silencedet.c Starting silence (level=728 threshold=1256)

22:47:00.291 strm01ACC694 Starting silence

22:47:00.300 ec01AC2930 39 samples reduced, buf_cnt=958

22:47:00.314 endpoint Request msg BYE/cseq=24691 (tdta01AD0760) created.

22:47:00.315 inv01AC5284 Sending Request msg BYE/cseq=24691 (tdta01AD0760)

22:47:00.316 dlg01AC5284 Sending Request msg BYE/cseq=24691 (tdta01AD0760)

22:47:00.317 tsx01ACAD44 Transaction created for Request msg BYE/cseq=24690
(tdta01AD0760)

22:47:00.318 tsx01ACAD44 Sending Request msg BYE/cseq=24690 (tdta01AD0760)
in state Null

22:47:00.320 sip_resolve.c Target '192.168.2.102:5060' type=Unspecified
resolved to '192.168.2.102:5060' type=UDP (UDP transport)

22:47:00.334 pjsua_core.c TX 352 bytes Request msg BYE/cseq=24690
(tdta01AD0760) to UDP 192.168.2.102:5060:

BYE sip:192.168.2.102:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.2.109:5060;rport;branch=
z9hG4bKPjIVdvAnAH1dLqMh.Pl3Qm5bchIZm02.bR

Max-Forwards: 70

From: <sip:192.168.2.109>;tag=DuIGTRI4k6dwrkM8a.VUqlvyANQ5xoGA

To: sip:192.168.2.102;tag=debed56f3fd5455eb936c4528132ceda

Call-ID: 3wXeu2ZeDOXZ4W7p79fUqGnbRNpvzMf6

CSeq: 24690 BYE

Content-Length: 0



--end msg--

22:47:00.337 tsx01ACAD44 State changed from Null to Calling, event=TX_MSG

22:47:00.338 dlg01AC5284 Transaction tsx01ACAD44 state changed to Calling

22:47:00.348 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:47:00.405 ec01AC2930 240 samples reduced, buf_cnt=878

22:47:00.412 Master/sound Underflow, buf_cnt=0, will generate 1 frame

22:47:00.432 strm01ACC694 JB shrinking 1 frame(s), cur size=44

22:47:00.441 ec01AC2930 122 samples reduced, buf_cnt=916

22:47:00.448 sip_endpoint.c Processing incoming message: Response msg
200/BYE/cseq=24690 (rdata01AAB004)

22:47:00.449 pjsua_core.c RX 344 bytes Response msg 200/BYE/cseq=24690
(rdata01AAB004) from UDP 192.168.2.102:5060:

SIP/2.0 200 OK

Via: SIP/2.0/UDP 192.168.2.109:5060
;rport=5060;received=192.168.2.109;branch=
z9hG4bKPjIVdvAnAH1dLqMh.Pl3Qm5bchIZm02.bR

Call-ID: 3wXeu2ZeDOXZ4W7p79fUqGnbRNpvzMf6

From: <sip:192.168.2.109>;tag=DuIGTRI4k6dwrkM8a.VUqlvyANQ5xoGA

To: <sip:192.168.2.102>;tag=debed56f3fd5455eb936c4528132ceda

CSeq: 24690 BYE

Content-Length: 0



--end msg--

22:47:00.452 tsx01ACAD44 Incoming Response msg 200/BYE/cseq=24690
(rdata01AAB004) in state Calling

22:47:00.453 tsx01ACAD44 State changed from Calling to Completed,
event=RX_MSG

22:47:00.454 dlg01AC5284 Received Response msg 200/BYE/cseq=24690
(rdata01AAB004)

22:47:00.454 dlg01AC5284 Transaction tsx01ACAD44 state changed to Completed

22:47:00.508 strm01ACC694

JB summary:

size=42 prefetch=14

delay (min/max/avg/dev)=220/500/442/42 ms

burst (min/max/avg/dev)=2/14/8/3 frames

lost=2 discard=458 empty=0

22:47:00.511 pjsua_media.c Media session for call 0 is destroyed

22:47:00.512 tdta01ACF750 Destroying txdata Request msg ACK/cseq=24689
(tdta01ACF750)

22:47:00.513 tdta01AC8390 Destroying txdata Request msg INVITE/cseq=24689
(tdta01AC8390)

22:47:00.515 dlg01AC5284 Session count dec to 1 by mod-invite

22:47:00.546 ec01AC2930 197 samples reduced, buf_cnt=879

22:47:00.565 ec01AC2930 161 samples reduced, buf_cnt=878

22:47:00.686 ec01AC2930 121 samples reduced, buf_cnt=917

22:47:00.702 ec01AC2930 243 samples reduced, buf_cnt=834

22:47:00.826 ec01AC2930 161 samples reduced, buf_cnt=833

22:47:00.838 ec01AC2930 78 samples reduced, buf_cnt=915

22:47:00.972 ec01AC2930 122 samples reduced, buf_cnt=953

22:47:00.993 ec01AC2930 312 samples reduced, buf_cnt=801

22:47:01.127 ec01AC2930 1 samples reduced, buf_cnt=960

22:47:01.144 ec01AC2930 319 samples reduced, buf_cnt=801

22:47:01.272 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.411 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.428 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.552 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.691 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.712 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.832 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.882 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:01.971 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.103 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.112 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.121 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.129 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.136 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.144 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.152 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.232 pjsua Thread stack max usage=7392 by ..\..\src\pj\string.c:174

22:47:02.244 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.251 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.261 ec01AC2930 160 samples reduced, buf_cnt=801

22:47:02.284 pjsua_media.c Closing (null) sound playback device and (null)
sound capture device

22:47:02.622 pasound.c Stopping stream..

22:47:02.623 pasound.c Done, status=0

22:47:02.624 pasound.c Closing A: 86 underflow, 40 overflow

22:47:02.642 media Thread stack max usage=4040 by ..\..\src\pj\string.c:174

22:47:02.647 pasound.c PortAudio sound library shutting down..

22:47:02.648 pjsua_core.c Shutting down...

22:47:03.660 pjsua_core.c Destroying...

22:47:03.662 sip_endpoint.c Destroying endpoing instance..

22:47:03.664 sip_transactio Stopping transaction layer module

22:47:03.666 tsx01ACAD44 Request to terminate transaction

22:47:03.668 tsx01ACAD44 State changed from Completed to Terminated,
event=USER

22:47:03.670 dlg01AC5284 Transaction tsx01ACAD44 state changed to Terminated

22:47:03.672 dlg01AC5284 Dialog destroyed

22:47:03.674 tdta01AD0760 Destroying txdata Request msg BYE/cseq=24690
(tdta01AD0760)

22:47:03.675 tsx01ACAD44 Transaction destroyed!

22:47:03.677 sip_endpoint.c Module "mod-pjsua-options" unregistered

22:47:03.679 sip_endpoint.c Module "mod-pjsua-im" unregistered

22:47:03.681 sip_endpoint.c Module "mod-pjsua-pres" unregistered

22:47:03.683 sip_endpoint.c Module "mod-pjsua" unregistered

22:47:03.684 sip_endpoint.c Module "mod-stateful-util" unregistered

22:47:03.687 sip_endpoint.c Module "mod-refer" unregistered

22:47:03.689 sip_endpoint.c Module "mod-presence" unregistered

22:47:03.691 sip_endpoint.c Module "mod-evsub" unregistered

22:47:03.692 sip_endpoint.c Module "mod-invite" unregistered

22:47:03.694 sip_endpoint.c Module "mod-100rel" unregistered

22:47:03.696 sip_endpoint.c Module "mod-ua" unregistered

22:47:03.698 sip_transactio Transaction layer module destroyed

22:47:03.701 sip_endpoint.c Module "mod-tsx-layer" unregistered

22:47:03.702 sip_endpoint.c Module "mod-msg-print" unregistered

22:47:03.704 sip_endpoint.c Module "mod-pjsua-log" unregistered

22:47:03.706 sip_transport. Destroying transport manager

22:47:03.714 sip_endpoint.c Endpoint 01A833A4 destroyed

22:47:03.718 pjsua Pool is not released by application, releasing now

22:47:03.721 pjsua_core.c PJSUA destroyed...
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20091021/a9acb622/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