Slightly garbled audio

Status
Not open for further replies.

pcunite

Joined
Apr 12, 2010
Messages
29
Reaction score
0
Running Skype client 4.2.0.158 on WIndows XP PRO x64, 3CX 8.0.10824.716, and Skype Gateway 2.0.9919.0.

The XP box is an Intel QUAD Q6600 with 8GB ram, two sata II 500 gig drives mirrored.

The XP box has no one logged in and I am connected to the 3CX pbx via X-Lite softphone 3.0 build 56125. Is there anything I need to do? Is the Skype Client that buggy configured this way?
 
Similar, but less powered setup, and I have the same problem. This is apparently a known issue that 3CX is trying to debug. I had to opt for a different gateway product in the meantime.
 
I am going to switch from Skype to a standard SIP for outgoing and see how that goes. I think 3CX is to be commended for trying, but Skype making people use their GUI is the real problem.
 
Montclairguy said:
Similar, but less powered setup, and I have the same problem. This is apparently a known issue that 3CX is trying to debug. I had to opt for a different gateway product in the meantime.

What is the issue?

Thanks
 
Audio recordings attached to demonstrate the garbled audio issue of 3CX's Skype gateway versus a different Skype gateway.

Secondly, there is an Early Media issue with 3CX's gateway. I posted about it several days ago, but it has not been addressed.

http://www.3cx.com/forums/early-media-problems-14591.html
 

Attachments

What the heck happened to the remaining thread for April 16th? It's all deleted? I was having a conversation here with Stephan and providing logs to debug latency.
 
Luckily, I still have the missing content open in another tab. Here's the last missing post:

SY » Fri Apr 16, 2010 4:19 pm
Just introduce first 100 lines of the call quoted from 3CXMediaServer.trace.log...
Let's go :)

P.S. it will be the answer to my recent question.

SipToSis Log:
Code:
2010-04-16 14:47:32,250 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C0 - incoming sip call from "Me" <sip:[email protected]:5060> callee=<sip:[email protected]:5065>
2010-04-16 14:47:32,250 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C0 - Skype Dial:1800xxxxxxx
2010-04-16 14:47:33,250 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C0 - Actual destination:+1800xxxxxxx
2010-04-16 14:47:33,375 [AsyncSkypeMessageSender-99] INFO  local.ua.SSCallChannel.#C0 - skypeCallStatus[430861] - ROUTING
2010-04-16 14:47:37,765 [AsyncSkypeMessageSender-99] INFO  local.ua.SSCallChannel.#C0 - skypeCallStatus[430861] - RINGING
2010-04-16 14:47:38,062 [AsyncSkypeMessageSender-99] INFO  local.ua.SSCallChannel.#C0 - skypeCallStatus[430861] - EARLYMEDIA
2010-04-16 14:47:38,187 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUserAgent.#C0 - Starting codec: PCMU/8000(0) rfc2833Type(101)
2010-04-16 14:47:38,187 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C0 - CallConfirmed Active
2010-04-16 14:47:38,187 [local.ua.SkypeRtpSender.T4] INFO  local.ua.SkypeRtpSender.T4 - RTP media target: 127.0.0.1:7012
2010-04-16 14:47:38,203 [local.ua.SkypeRtpReceiver.T5] INFO  local.ua.SkypeRtpReceiver.T5 - RtpSender Address locked.
2010-04-16 14:47:39,546 [AsyncSkypeMessageSender-100] INFO  local.ua.SSCallChannel.#C0 - skypeCallStatus[430861] - INPROGRESS
2010-04-16 14:47:39,546 [AsyncSkypeMessageSender-100] INFO  local.ua.SSCallChannel.#C0 - Call Rate: Free
2010-04-16 14:47:52,375 [local.ua.SkypeAudioSenderServer.T7] INFO  local.ua.SkypeAudioSenderServer.T7 - * SkypeAudioSender stats - packets:654 underRuns:1 maxLatency:40ms avgLatency:21ms
2010-04-16 14:47:52,390 [local.ua.SkypeAudioReceiverServer.T6] INFO  local.ua.SkypeAudioReceiverServer.T6 - * SkypeAudioReceiver stats - packets:427
2010-04-16 14:47:52,390 [local.ua.SkypeRtpSender.T4] INFO  local.ua.SkypeRtpSender.T4 - * RTPSender stats - packets:11642 underRuns:262 maxLatency:0ms avgLatency:0ms
2010-04-16 14:47:52,468 [local.ua.SkypeRtpReceiver.T5] INFO  local.ua.SkypeRtpReceiver.T5 - * RTPReceiver stats - packets:704 timeOuts:1
2010-04-16 14:47:52,531 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C0 - OUTGOING_PSTN From: "Me" <sip:[email protected]:5060> To: +1800xxxxxxx CallTime: 0:12 Cost: FREE
2010-04-16 14:47:52,531 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUA - Qualified PSTN calls today: 1 Time: 12 minutes
2010-04-16 14:47:52,531 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C0 - AcctBalance: 0.00 USD
2010-04-16 14:47:52,531 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUserAgent.#C0 - WAITING FOR INCOMING CALL
2010-04-16 14:47:52,546 [AsyncSkypeMessageSender-101] INFO  local.ua.SSCallChannel.#C0 - skypeCallStatus[430861] - Complete: FINISHED

3CXMediaServer.trace.log
Code:
14:47:32.125|.\MSEndPoint.cpp(760)|Trace5||??:00000E69@: RTP bind address 192.168.1.4:7010
14:47:32.125|.\MSEndPoint.cpp(771)|Trace5||??:00000E69@: RTCP bind address 192.168.1.4:7011
14:47:32.125|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=192.168.1.2)
EndPoint: ID=00000E69@(LOCAL)
  LOGID=C:1700.1  Status: MSEP_LOCAL
  RTP:192.168.1.4:7010
  RTCP:192.168.1.4:7011
  STUN RTP:0.0.0.0:0
  STUN RTCP:0.0.0.0:0
  Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
  Party RTP:0.0.0.0:0
  Party RTCP:0.0.0.0:0
  Decoders:
    <empty>

14:47:32.125|.\MediaServer.cpp(1260)|Trace5||??:EP 00000E69@ joined to call 1700
14:47:32.125|.\MediaServer.cpp(1269)|Trace5||??:starting send on new call 1700
14:47:32.140|.\MediaServer.cpp(912)|Trace5||??:Set Party EP:C:1700.1SDP:v=0
o=- 8 2 IN IP4 192.168.1.2
s=CounterPath eyeBeam 1.5
c=IN IP4 192.168.1.2
t=0 0
m=audio 29986 RTP/AVP 107 100 106 6 0 105 18 3 5
a=alt:1 1 : r26Acfau Omlv4xaW 192.168.1.2 29986
a=fmtp:18 annexb=no
a=rtpmap:107 BV32/16000
a=rtpmap:100 SPEEX/16000
a=rtpmap:106 SPEEX-FEC/16000
a=rtpmap:105 SPEEX-FEC/8000
a=sendrecv
a=x-rtp-session-id:F4FC685CAA0949D6B106E801FAC71AC7

14:47:32.140|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000E69@ SILENCE
14:47:32.140|.\MSEndPoint.cpp(1691)|Trace5||??:partyAddrRTP_ is set to 192.168.1.2:29986
14:47:32.140|.\MSEndPoint.cpp(1692)|Trace5||??:partyAddrRTCP_ is set to 192.168.1.2:29987
14:47:32.140|.\MSEndPoint.cpp(1914)|Log2||??:[MS210000] C:1700.1:Offer received. RTP connection: 192.168.1.2:29986(29987)
14:47:32.187|.\MSEndPoint.cpp(760)|Trace5||??:00000E6A@: RTP bind address 127.0.0.1:7012
14:47:32.187|.\MSEndPoint.cpp(771)|Trace5||??:00000E6A@: RTCP bind address 127.0.0.1:7013
14:47:32.187|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=192.168.1.4)
EndPoint: ID=00000E6A@(LOCAL)
  LOGID=C:1700.2  Status: MSEP_LOCAL
  RTP:127.0.0.1:7012
  RTCP:127.0.0.1:7013
  STUN RTP:0.0.0.0:0
  STUN RTCP:0.0.0.0:0
  Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
  Party RTP:0.0.0.0:0
  Party RTCP:0.0.0.0:0
  Decoders:
    <empty>

14:47:32.187|.\MediaServer.cpp(1260)|Trace5||??:EP 00000E6A@ joined to call 1700
14:47:32.187|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000E6A@ removed from call 1700
14:47:32.187|.\MediaServer.cpp(1260)|Trace5||??:EP 00000E6A@ joined to call 1700
14:47:32.187|.\MSEndPoint.cpp(1403)|Log2||??:[MS210002] C:1700.2:Offer provided. Connection(transcoding mode): 127.0.0.1:7012(7013)
14:47:32.187|.\MediaServer.cpp(850)|Trace5||??:Get Local SDP. EP:C:1700.2SDP:v=0
o=3cxPS 516671143936 92509569025 IN IP4 127.0.0.1
s=3cxPS Audio call
c=IN IP4 127.0.0.1
t=0 0
m=audio 7012 RTP/AVP 0 8 3 99 13 18 110 101
c=IN IP4 127.0.0.1
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:99 SPEEX/8000
a=rtpmap:13 CN/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:110 iLBC/8000
a=rtpmap:101 telephone-event/8000
a=sendrecv

14:47:32.187|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000E6A@ removed from call 1700
14:47:38.093|.\MediaServer.cpp(912)|Trace5||??:Set Party EP:C:1700.2SDP:v=0
o=3cxPS 516671143936 92509569025 IN IP4 127.0.0.1
s=3cxPS Audio call
c=IN IP4 192.168.1.4
t=0 0
m=audio 63206 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=silenceSupp:off

14:47:38.093|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000E6A@ SILENCE
14:47:38.093|.\MSEndPoint.cpp(1691)|Trace5||??:partyAddrRTP_ is set to 192.168.1.4:63206
14:47:38.093|.\MSEndPoint.cpp(1692)|Trace5||??:partyAddrRTCP_ is set to 192.168.1.4:63207
14:47:38.093|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000E6A@ ACTIVE
14:47:38.093|.\MSEndPoint.cpp(1919)|Log2||??:[MS210001] C:1700.2:Answer received. RTP connection[unsecure]: 192.168.1.4:63206(63207)
14:47:38.093|.\MediaServer.cpp(1260)|Trace5||??:EP 00000E6A@ joined to call 1700
14:47:38.093|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000E69@ ACTIVE
14:47:38.093|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000E6A@ ACTIVE
14:47:38.093|.\MSEndPoint.cpp(1408)|Log2||??:[MS210003] C:1700.1:Answer provided. Connection(transcoding mode[unsecure]):192.168.1.4:7010(7011)
14:47:38.109|.\MediaServer.cpp(850)|Trace5||??:Get Local SDP. EP:C:1700.1SDP:v=0
o=3cxPS 513282146304 350912249857 IN IP4 192.168.1.4
s=3cxPS Audio call
c=IN IP4 192.168.1.4
t=0 0
m=audio 7010 RTP/AVP 0 18 3 101
c=IN IP4 192.168.1.4
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=sendrecv

14:47:38.203|.\MSEndPoint.cpp(2142)|Trace5||??:EP:00000E69@ refreshed
14:47:43.078|.\MSEndPoint.cpp(2135)|Trace5||??:resynchronization. timediff:304
14:47:43.078|.\MSEndPoint.cpp(2142)|Trace5||??:EP:00000E69@ refreshed
14:47:48.968|.\MSEndPoint.cpp(2135)|Trace5||??:resynchronization. timediff:312
14:47:48.968|.\MSEndPoint.cpp(2142)|Trace5||??:EP:00000E69@ refreshed
14:47:52.281|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000E69@ removed from call 1700
14:47:52.281|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000E6A@ removed from call 1700
14:47:52.296|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000E69@ were removed
14:47:52.390|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000E6A@ were removed
14:47:52.390|.\MediaServer.cpp(1383)|Trace5||??:references to call 1700 were removed
14:47:52.390|.\MSCallConf.cpp(36)|Trace5||??:Call: 1700 destroyed
14:47:52.437|.\MSEndPoint.cpp(836)|Error1||??:[MS105000] C:1700.2: No RTP packets were received:remoteAddr=192.168.1.4:63206,extAddr=0.0.0.0:0,localAddr=127.0.0.1:7012
14:47:52.437|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000E6A@ destroyed
14:47:52.437|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000E6A@ destroyed statistics:
Begin send:1048224734
LastSent:1048238890
TotalSent:708
MaxSendInterval:47
MinSendInterval:0
AvgSendInterval:19.9944
SendDeviation:8.65568
Begin recv:0
Last recv:0
TotalRecv:0
MaxRecvInterval:0
MinRecvInterval:0
AvgRecvInterval:0
ReceiveDeviation:0

14:47:53.734|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000E69@ destroyed
14:47:53.734|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000E69@ destroyed statistics:
Begin send:1048224734
LastSent:1048238890
TotalSent:708
MaxSendInterval:32
MinSendInterval:0
AvgSendInterval:19.9943
SendDeviation:8.3717
Begin recv:1048224859
Last recv:1048238828
TotalRecv:694
MaxRecvInterval:32
MinRecvInterval:0
AvgRecvInterval:20.1282
ReceiveDeviation:7.13433
 
Status
Not open for further replies.

Latest Posts

Forum statistics

Threads
111,880
Messages
589,533
Members
164,735
Latest member
998742