One way Audio on WM6 emulator

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

 



Hi,

I am using PJSUA APIs in a softphone application on Windows Mobile 6 device. When I make calls from this device to an Xlite running on a Windows desktop using G711 codec, it works fine.

However, if I deploy the same application to a Windows Mobile 6 emulator running on a standard windows desktop, the Voice is transmitting only from Xlite to PJSUA App and not vice versa. Looking at the Wireshark traces, I found that there were just 10-15 RTP packets sent by PJSUA App to Xlite at the start of the media flow; thereafter it was sending one RTP packet periodically every 5 seconds with Marker bit set (which I believe indicates silence). In the reverse direction, RTP packet flow from Xlite to emulator is perfectly fine and I am able to hear it correctly at emulator end.

It seems to me that limited processing power of Emulator machine is contributing to this media problem. Another potential issue may be that Sound Device callbacks are not happening periodically on Emulator. Please suggest how to find the root cause of this issue. I also checked for underflow and overflow in emulator and found following message in log file "Closing M - Input: 0 underflow, 0 overflow".

Following are the traces of the pjsip log files for device and emulator (I have purposefully not included Sip related log messages in traces) :-

Device
  18:25:05.000    inv004F2864 SDP negotiation done, status=0
 18:25:05.000   pjsua_call.c Call 0: remote NAT type is 0 (Unknown)
 18:25:05.000   strm004F88C4 VAD temporarily disabled
 18:25:05.000          rtp.c pjmedia_rtp_session_init: ses=004F9990, default_pt=8, ssrc=0x4ae13d6c
 18:25:05.000          rtp.c pjmedia_rtp_session_init: ses=004FA598, default_pt=8, ssrc=0x4ae13d6c
 18:25:05.000       stream.c Stream strm004F88C4 created
 18:25:05.000   strm004F88C4 Encoder stream started
 18:25:05.000   strm004F88C4 Decoder stream started
 18:25:05.000  pjsua_media.c Media updates, stream #0: PCMA (sendrecv)
 18:25:05.000   strm004F88C4 Jitter buffer empty (prefetch=15)
 18:25:05.000   strm004F88C4 Start talksprut..
 18:25:05.000   ecsu00493B88 Vad cur_threshold updated 1-->4. Signal lo=6
 18:25:05.000   strm004F88C4 RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0
 18:25:05.000   strm004F88C4 Jitter buffer is bufferring (prefetch=15)..
 18:25:05.000    tsx004BC7B4 Timeout timer event
 18:25:05.000    tsx004BC7B4 State changed from Terminated to Destroyed, event=TIMER
 18:25:05.000   tdta004F4420 Destroying txdata Request msg INVITE/cseq=2083 (tdta004F4420)
 18:25:05.000    tsx004BC7B4 Transaction destroyed!
 18:25:05.000   strm004F88C4 Jitter buffer is bufferring (prefetch=15)..
 18:25:05.000 echo_suppress. Stop suppressing..
 18:25:06.000   strm004F88C4 VAD re-enabled
 18:25:06.000 echo_suppress. Start suppressing..
 18:25:07.000   strm004F88C4 Starting silence
 18:25:08.000                Remote RTCP address switched to 210.56.101.254:10884
 18:25:08.000   strm004F88C4 Start talksprut..
 18:25:08.000   strm004F88C4 Starting silence
 18:25:09.000   strm004F88C4 Start talksprut..
 18:25:09.000   strm004F88C4 Starting silence
 18:25:09.000   ecsu00493B88 Vad cur_threshold updated 4-->5. Signal lo=5
 18:25:10.000   strm004F88C4 Start talksprut..
 18:25:10.000   strm004F88C4 Starting silence
 18:25:10.000 echo_suppress. Stop suppressing..
 18:25:11.000   strm004F88C4 Start talksprut..
 18:25:13.000   silencedet.c Vad cur_threshold updated 4-->16. Signal lo=27
 18:25:15.000   silencedet.c Vad cur_threshold updated 16-->18. Signal lo=20
 18:25:17.000   silencedet.c Vad cur_threshold updated 18-->20. Signal lo=21
 18:25:19.000   silencedet.c Vad cur_threshold updated 20-->21. Signal lo=21
 18:25:23.000   silencedet.c Vad cur_threshold updated 21-->22. Signal lo=22
 18:25:25.000   strm004F88C4 Internal RTCP NTP clock skew detected: lsr=2712D1EB, now=27150000, dlsr=000255C2 (2:334ms), diff=10157
 18:25:28.000 echo_suppress. Start suppressing..


Emulator

 18:16:16.000   sound_port.c EC activated
 18:16:16.000 echo_suppress. Start suppressing..
 18:16:19.000   ecsu004A1AF8 Vad cur_threshold updated 3-->5. Signal lo=6
 18:16:21.000    pjsua_acc.c Sending 2 bytes keep-alive packet for acc 0 to 69.90.155.70:5060
 18:16:21.000   tdta004B5700 Destroying txdata raw
 18:16:22.000   ecsu004A1AF8 Vad cur_threshold updated 5-->6. Signal lo=6
 18:16:24.000 echo_suppress. Stop suppressing..
 18:16:24.000   wav_player.c File port \Program Files\Emulator Build\resources\sound\ring.wav EOF, rewinding..
 18:16:24.000    inv00490094 SDP negotiation done, status=0
 18:16:24.000   pjsua_call.c Call 0: remote NAT type is 0 (Unknown)
 18:16:24.000   strm00584C44 VAD temporarily disabled
 18:16:24.000          rtp.c pjmedia_rtp_session_init: ses=00585D10, default_pt=8, ssrc=0xbb32ea6
 18:16:24.000          rtp.c pjmedia_rtp_session_init: ses=00586918, default_pt=8, ssrc=0xbb32ea6
 18:16:24.000       stream.c Stream strm00584C44 created
 18:16:24.000   strm00584C44 Encoder stream started
 18:16:24.000   strm00584C44 Decoder stream started
 18:16:24.000  pjsua_media.c Media updates, stream #0: PCMA (sendrecv)
 18:16:24.000   strm00584C44 Jitter buffer empty (prefetch=15)
 18:16:24.000   strm00584C44 Start talksprut..
 18:16:24.000 echo_suppress. Start suppressing..
 18:16:25.000   strm00584C44 RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0
 18:16:25.000   strm00584C44 Jitter buffer is bufferring (prefetch=15)..
 18:16:25.000   strm00584C44 Jitter buffer is bufferring (prefetch=15)..
 18:16:25.000   strm00584C44 Jitter buffer is bufferring (prefetch=15)..
 18:16:25.000   strm00584C44 Jitter buffer is bufferring (prefetch=15)..
 18:16:25.000   strm00584C44 Jitter buffer is bufferring (prefetch=15)..
 18:16:25.000   strm00584C44 VAD re-enabled
 18:16:25.000   strm00584C44 Starting silence
 18:16:26.000 echo_suppress. Stop suppressing..
 18:16:26.000   strm00584C44 Frame lost!
 18:16:26.000   strm00584C44 Frame lost!
 18:16:26.000   strm00584C44 Start talksprut..
 18:16:26.000   strm00584C44 Starting silence
 18:16:27.000 echo_suppress. Start suppressing..
 18:16:27.000   strm00584C44 Frame lost!
 18:16:27.000   strm00584C44 Frame lost!
 18:16:27.000   strm00584C44 Start talksprut..
 18:16:27.000   strm00584C44 Starting silence
 18:16:27.000 echo_suppress. Stop suppressing..
 18:16:28.000   strm00584C44 Frame lost!
 18:16:28.000   strm00584C44 Frame lost!
 18:16:28.000   strm00584C44 Start talksprut..
 18:16:28.000   strm00584C44 Starting silence
 18:16:29.000 echo_suppress. Start suppressing..
 18:16:29.000   strm00584C44 Frame lost!
 18:16:29.000   strm00584C44 Frame lost!
 18:16:29.000 echo_suppress. Stop suppressing..
 18:16:29.000   silencedet.c Vad cur_threshold updated 4-->3. Signal lo=-1
 18:16:29.000   strm00584C44 Start talksprut..
 18:16:29.000   strm00584C44 Starting silence
 18:16:30.000   strm00584C44 Frame lost!
 18:16:30.000   strm00584C44 Frame lost!
 18:16:30.000   strm00584C44 Start talksprut..
 18:16:30.000   strm00584C44 Starting silence
 18:16:31.000 echo_suppress. Start suppressing..
 18:16:31.000 echo_suppress. Stop suppressing..
 18:16:31.000   strm00584C44 Start talksprut..
 18:16:31.000   strm00584C44 Starting silence
 18:16:32.000   strm00584C44 Frame lost!
 18:16:32.000   strm00584C44 Frame lost!
 18:16:32.000 echo_suppress. Start suppressing..
 18:16:32.000   strm00584C44 Start talksprut..
 18:16:32.000   strm00584C44 Starting silence
 18:16:33.000 echo_suppress. Stop suppressing..
 18:16:33.000   strm00584C44 Frame lost!
 18:16:33.000   strm00584C44 Frame lost!
 18:16:33.000   silencedet.c Vad cur_threshold updated 3-->2. Signal lo=-1
 18:16:34.000   strm00584C44 Start talksprut..
 18:16:34.000   strm00584C44 Starting silence
 18:16:34.000   strm00584C44 Frame lost!
 18:16:34.000   strm00584C44 Frame lost!
 18:16:35.000   strm00584C44 Start talksprut..
 18:16:35.000   strm00584C44 Starting silence
 18:16:35.000   strm00584C44 Frame lost!
 18:16:35.000   strm00584C44 Frame lost!
 18:16:36.000    pjsua_acc.c Sending 2 bytes keep-alive packet for acc 0 to 69.90.155.70:5060
 18:16:36.000   tdta00581040 Destroying txdata raw
 18:16:36.000   strm00584C44 Start talksprut..
 18:16:36.000   strm00584C44 Starting silence
 18:16:36.000   strm00584C44 Frame lost!
 18:16:36.000   strm00584C44 Frame lost!
 18:16:37.000   strm00584C44 Start talksprut..
 18:16:37.000   strm00584C44 Starting silence
 18:16:37.000   strm00584C44 Frame lost!
 18:16:37.000   strm00584C44 Frame lost!
 18:16:38.000   strm00584C44 Start talksprut..
 18:16:38.000   strm00584C44 Starting silence
 18:16:38.000   strm00584C44 Frame lost!
 18:16:38.000   strm00584C44 Frame lost!
 18:16:38.000   strm00584C44 Internal RTCP NTP clock skew detected: lsr=25040000, now=25060000, dlsr=00029C6A (2:610ms), diff=40042
 18:16:39.000   strm00584C44 Start talksprut..
 18:16:39.000   strm00584C44 Starting silence
 18:16:39.000   strm00584C44 Frame lost!
 18:16:39.000   strm00584C44 Frame lost!
 18:16:40.000   strm00584C44 Start talksprut..
 18:16:40.000   strm00584C44 Starting silence
 18:16:40.000   strm00584C44 Frame lost!
 18:16:40.000   strm00584C44 Frame lost!
 18:16:41.000   strm00584C44 Start talksprut..
 18:16:41.000   strm00584C44 Starting silence
 18:16:41.000 echo_suppress. Start suppressing..
 18:16:41.000   strm00584C44 Frame lost!
 18:16:41.000   strm00584C44 Frame lost!
 18:16:42.000   strm00584C44 Internal RTCP NTP clock skew detected: lsr=25040000, now=250A0000, dlsr=000606A7 (6:025ms), diff=1703
 18:16:42.000   strm00584C44 Start talksprut..
 18:16:42.000   strm00584C44 Starting silence
 18:16:42.000   strm00584C44 Frame lost!
 18:16:42.000   strm00584C44 Frame lost!
 18:16:43.000   strm00584C44 Start talksprut..
 18:16:43.000   strm00584C44 Starting silence
 18:16:43.000   strm00584C44 Frame lost!
 18:16:43.000   strm00584C44 Frame lost!
 18:16:44.000   strm00584C44 Start talksprut..
 18:16:44.000   strm00584C44 Starting silence
 18:16:44.000   ecsu004A1AF8 Vad cur_threshold updated 6-->7. Signal lo=8
 18:16:45.000 echo_suppress. Stop suppressing..
 18:16:45.000   strm00584C44 Frame lost!
 18:16:45.000   strm00584C44 Frame lost!
 18:16:45.000   strm00584C44 Start talksprut..
 18:16:45.000   strm00584C44 Starting silence
 18:16:45.000   strm00584C44 Internal RTCP NTP clock skew detected: lsr=25040000, now=250D0000, dlsr=000970E5 (9:440ms), diff=28901



Regards
Girish






**************** CAUTION - Disclaimer *****************
This e-mail contains PRIVILEGED AND CONFIDENTIAL INFORMATION intended solely 
for the use of the addressee(s). If you are not the intended recipient, please 
notify the sender by e-mail and delete the original message. Further, you are not 
to copy, disclose, or distribute this e-mail or its contents to any other person and 
any such actions are unlawful. This e-mail may contain viruses. Infosys has taken 
every reasonable precaution to minimize this risk, but is not liable for any damage 
you may sustain as a result of any virus in this e-mail. You should carry out your 
own virus checks before opening the e-mail or attachment. Infosys reserves the 
right to monitor and review the content of all messages sent to or from this e-mail 
address. Messages sent to or from this e-mail address may be stored on the 
Infosys e-mail system.
***INFOSYS******** End of Disclaimer ********INFOSYS***
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20080917/53639d54/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