1 Topic by scolja

  • scolja
  • Member
  • Offline

Topic: No Audio Being Sent

I'm able to successfully make and receive phones calls to my Grandstream BT200 phone using SipToSis and Skype, but my audio from the phone is not being heard.  I've played around with the settings recommended in your first Troubleshooting step, but nothing seems to be helping.  Windows Firewall is completely disabled.

I figure the issue is probably related to PublicIP or STUN server (whatever that is), but I'm unsure.  Here's the regular log when the issue occurs -- let me know if the debug log would be more helpful.  I removed some of the identifiable info, sorry if that makes it harder to read/use.

2011-01-26 15:37:02,767 PublicIP=<removed: x.x.x.72>
2011-01-26 15:37:02,777 Starting SipToSis v20110104
2011-01-26 15:37:02,781 Skype4Java Version 1.2.0.1
2011-01-26 15:37:02,781 os=Windows 7 ver=6.1 arch=x86 (4 core)
2011-01-26 15:37:02,782 javaVer=1.6.0_21 - Sun Microsystems Inc. (32 bit)
2011-01-26 15:37:02,813 Available Codecs: PCMU(0),PCMA(8),iLBC(98)
2011-01-26 15:37:02,813 DTMF rfc2833(101)
2011-01-26 15:37:02,814 initSkype - If stuck, check Skype online & API auth
2011-01-26 15:37:03,589 SkypeVer:5.0.0.152
2011-01-26 15:37:03,592 Attached SkypeUserId:someSkypeUser
2011-01-26 15:37:03,600 Config - skypeClientSupportsMultiCalls:false  concurrent CallLimit:2
2011-01-26 15:37:03,601 SipToSis contact_url=sip:myuserid@<removed: x.x.x.72>:5070
2011-01-26 15:37:03,601 via_addr=<removed: x.x.x.72>  realm=
2011-01-26 15:37:03,601 RTP Ports: 63200-63202  Local Skype Ports: 64432-64435
2011-01-26 15:37:03,601 jitterLevel=-1
2011-01-26 15:37:03,651 Registrar Server Domains=
2011-01-26 15:37:03,657 WAITING FOR INCOMING CALL
2011-01-26 15:37:03,657 WAITING FOR INCOMING CALL
2011-01-26 15:37:03,689 MaxCallTime: not limited MaxPSTNCallTime: not limited
2011-01-26 15:37:03,690 MaxDailyPSTNUniqueNumberCount: 48 MaxDailyPSTNMinutes: 350
2011-01-26 15:37:03,691 Loading Skype PSTN Call History
2011-01-26 15:37:03,713 39 possible calls to import.
2011-01-26 15:37:03,736 0 PSTN calls imported
2011-01-26 15:37:03,738 PSTN counters reset at: 19:00:00 EST
2011-01-26 15:37:03,739 Qualified PSTN calls today: 2 Time: 8 minutes
2011-01-26 15:37:03,741 AcctBalance: 0.00 USD
2011-01-26 15:43:03,425 incoming sip call from "Jason" <sip:userid@<removed: x.x.x.72>:5070> callee=<sip:813xxx8459@<removed: x.x.x.72>:5070> ReqLineUser=813xxx8459
2011-01-26 15:43:03,426 Skype Dial:813xxx8459
2011-01-26 15:43:04,426 Actual destination:+1813xxx8459
2011-01-26 15:43:04,462 skypeCallStatus[16109] - ROUTING
2011-01-26 15:43:09,263 skypeCallStatus[16109] - RINGING
2011-01-26 15:43:09,593 skypeCallStatus[16109] - EARLYMEDIA
2011-01-26 15:43:09,625 Starting codec: PCMU/8000(0) rfc2833Type(101)
2011-01-26 15:43:09,630 CallConfirmed Active
2011-01-26 15:43:09,630 RTP media target: <removed: x.x.x.57>:5018
2011-01-26 15:43:09,640 RtpSender Address locked.
2011-01-26 15:43:10,643 skypeCallStatus[16109] - INPROGRESS
2011-01-26 15:43:10,645 Call Rate: Free
2011-01-26 15:43:10,646 This call is limited to: 342 minutes
2011-01-26 15:43:13,176 BYE
2011-01-26 15:43:13,182 * RTPSender stats - packets:117 maxLatency:60ms avgLatency:41ms
2011-01-26 15:43:13,186 * SkypeAudioReceiver stats - packets:112
2011-01-26 15:43:13,260 * RTPReceiver stats - packets:137 timeOuts:8
2011-01-26 15:43:13,328 OUTGOING_PSTN From: "Jason" <sip:userid@<removed: x.x.x.72>:5070> To: +1813xxx8459 CallTime: 0:02 Cost: FREE
2011-01-26 15:43:13,330 Qualified PSTN calls today: 2 Time: 9 minutes
2011-01-26 15:43:13,331 AcctBalance: 0.00 USD
2011-01-26 15:43:13,339 WAITING FOR INCOMING CALL
2011-01-26 15:43:13,339 * SkypeAudioSender stats - packets:35 IOErrors:1 maxLatency:1040ms avgLatency:49ms
2011-01-26 15:43:13,362 skypeCallStatus[16109] - Complete: FINISHED

Any help is most appreciated!

Thanks,
Jason

Last edited by scolja (2011-01-26 20:50:11)

2 Reply by MH

  • MH
  • Administrator
  • Offline

Re: No Audio Being Sent

I don't see anything wrong - with the IP's hidden I can't tell if you are direct on net or local network - Follow the procedure under Diagnostic procedure if none of the above resolved the problem: on the troubleshooting page and post the INVITE message. You should not have to change the PublicIP or Stun settings under normal conditions.

3 Reply by scolja

  • scolja
  • Member
  • Offline

Re: No Audio Being Sent

OK - no obscurement this time.  I'll just give you the output of both logs for completeness. 

Thank you, again.

=================================================================
message.log
=================================================================

2011-01-27 09:36:07,064 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (975 bytes): received
INVITE sip:8139748459@131.xxx.xxx.72:5070 SIP/2.0
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
To: <sip:8139748459@131.xxx.xxx.72:5070>
Contact: <sip:userid@131.xxx.xxx.57:5060;transport=udp>
Supported: replaces, timer, path
P-Early-Media: Supported
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
User-Agent: Grandstream BT200 1.xxx.xxx.19
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
Content-Type: application/sdp
Content-Length: 358

v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.57
t=0 0
m=audio 5036 RTP/AVP 0 8 4 18 2 97 9 3
a=sendrecv
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:18 G729/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=20
a=rtpmap:9 G722/8000
a=rtpmap:3 GSM/8000
a=ptime:20
-----End-of-message-----

2011-01-27 09:36:07,081 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (347 bytes): sent
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
Server: mjsip stack 1.6 sts.2
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:12,581 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (395 bytes): sent
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
Contact: <sip:userid@131.xxx.xxx.72:5070>
Server: mjsip stack 1.6 sts.2
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:12,899 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (596 bytes): sent
SIP/2.0 200 OK
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
Contact: <sip:userid@131.xxx.xxx.72:5070>
Server: mjsip stack 1.6 sts.2
Content-Length: 173
Content-Type: application/sdp

v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.72
t=0 0
m=audio 63202 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=sendrecv
a=silenceSupp:off
-----End-of-message-----

2011-01-27 09:36:12,931 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (556 bytes): received
ACK sip:userid@131.xxx.xxx.72:5070 SIP/2.0
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bK89ca89fd80b36af0
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
Contact: <sip:userid@131.xxx.xxx.57:5060;transport=udp>
Supported: path
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 ACK
User-Agent: Grandstream BT200 1.xxx.xxx.19
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:25,370 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (529 bytes): received
BYE sip:userid@131.xxx.xxx.72:5070 SIP/2.0
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKb5908b969b3eab4e
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
Supported: path
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44129 BYE
User-Agent: Grandstream BT200 1.xxx.xxx.19
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
Reason: SIP ;text="Onhook event"
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:25,377 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (340 bytes): sent
SIP/2.0 200 OK
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKb5908b969b3eab4e
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44129 BYE
Server: mjsip stack 1.6 sts.2
Content-Length: 0

-----End-of-message-----


=================================================================
SipToSis.log
=================================================================

2011-01-27 09:35:50,481 [org.zoolu.sip.provider.StunClient.T2] DEBUG org.zoolu.sip.provider.StunClient.T2 - STUN: Server: stun.xten.net:3478
2011-01-27 09:35:50,491 [main] INFO  local.ua.SkypeUA - Starting SipToSis v20110104
2011-01-27 09:35:50,495 [main] INFO  local.ua.SkypeUA - Skype4Java Version 1.2.0.1
2011-01-27 09:35:50,495 [main] INFO  local.ua.SkypeUA - os=Windows 7 ver=6.1 arch=x86 (4 core)
2011-01-27 09:35:50,495 [main] INFO  local.ua.SkypeUA - javaVer=1.6.0_21 - Sun Microsystems Inc. (32 bit)
2011-01-27 09:35:50,496 [main] DEBUG local.ua.SkypeUA - javaLibPath=.
2011-01-27 09:35:50,496 [main] DEBUG local.ua.SkypeUA - javaClassPath=sip.jar;ua.jar;mailapi.jar;smtp.jar;activation.jar;skype.jar;log4j-1.2.15.jar;siptosis.jar;.
2011-01-27 09:35:50,526 [main] INFO  local.ua.SkypeUA - Available Codecs: PCMU(0),PCMA(8),iLBC(98)
2011-01-27 09:35:50,527 [main] INFO  local.ua.SkypeUA - DTMF rfc2833(101)
2011-01-27 09:35:50,527 [main] DEBUG local.ua.SkypeUA - Codec Config:
CodecClassSuffix:PCMU internalName:PCMU frameSize:240 inGain:1.2 outGain:1.0
CodecClassSuffix:ILBC internalName:iLBC frameSize:240 inGain:1.2 outGain:1.0
CodecClassSuffix:PCMA internalName:PCMA frameSize:240 inGain:1.2 outGain:1.0

2011-01-27 09:35:50,528 [main] INFO  local.ua.SkypeUA - initSkype - If stuck, check Skype online & API auth
2011-01-27 09:35:50,595 [org.zoolu.sip.provider.StunClient.T2] DEBUG org.zoolu.sip.provider.StunClient.T2 - STUN: Bind request sent
2011-01-27 09:35:50,643 [org.zoolu.sip.provider.StunClient.T2] DEBUG org.zoolu.sip.provider.StunClient.T2 - STUN: Bind response received
2011-01-27 09:35:50,644 [org.zoolu.sip.provider.StunClient.T2] DEBUG org.zoolu.sip.provider.StunClient.T2 - addr=131.xxx.xxx.72:58020
2011-01-27 09:35:50,645 [org.zoolu.sip.provider.StunClient.T2] INFO  org.zoolu.sip.provider.SipProvider - PublicIP=131.xxx.xxx.72
2011-01-27 09:35:53,305 [main] INFO  local.ua.SkypeUA - SkypeVer:5.0.0.152
2011-01-27 09:35:53,308 [main] INFO  local.ua.SkypeUA - Attached SkypeUserId:someSkypeUser
2011-01-27 09:35:53,317 [main] INFO  local.ua.SkypeUA - Config - skypeClientSupportsMultiCalls:false  concurrentCallLimit:2
2011-01-27 09:35:53,318 [main] INFO  local.ua.SkypeUA - SipToSis contact_url=sip:userid@131.xxx.xxx.72:5070
2011-01-27 09:35:53,319 [main] INFO  local.ua.SkypeUA - via_addr=131.xxx.xxx.72  realm=
2011-01-27 09:35:53,319 [main] INFO  local.ua.SkypeUA - RTP Ports: 63200-63202  Local Skype Ports: 64432-64435
2011-01-27 09:35:53,320 [main] INFO  local.ua.SkypeUA - jitterLevel=-1
2011-01-27 09:35:53,375 [main] INFO  local.server.SSRegistrar - Registrar Server Domains=
2011-01-27 09:35:53,379 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_INIT
2011-01-27 09:35:53,380 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=0
2011-01-27 09:35:53,379 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_INIT
2011-01-27 09:35:53,381 [main] DEBUG local.server.SSRegistrar - LocationService (local): size=1
To: userid@131.xxx.xxx.72

2011-01-27 09:35:53,381 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_WAITING
2011-01-27 09:35:53,382 [main] INFO  local.ua.SkypeUA - MaxCallTime: not limited MaxPSTNCallTime: not limited
2011-01-27 09:35:53,381 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=0
2011-01-27 09:35:53,383 [main] INFO  local.ua.SkypeUA - MaxDailyPSTNUniqueNumberCount: 48 MaxDailyPSTNMinutes: 350
2011-01-27 09:35:53,383 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=1
2011-01-27 09:35:53,384 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_WAITING
2011-01-27 09:35:53,386 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=1
2011-01-27 09:35:53,388 [main] INFO  local.ua.SkypeUA - Loading Skype PSTN Call History
2011-01-27 09:35:53,389 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - id: INVITE
2011-01-27 09:35:53,389 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - id: INVITE
2011-01-27 09:35:53,390 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - created
2011-01-27 09:35:53,389 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - created
2011-01-27 09:35:53,390 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - start
2011-01-27 09:35:53,391 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - start
2011-01-27 09:35:53,391 [local.ua.SSCallChannel.#C0] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - changed transaction state: T_Waiting
2011-01-27 09:35:53,392 [local.ua.SSCallChannel.#C1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - changed transaction state: T_Waiting
2011-01-27 09:35:53,393 [local.ua.SSCallChannel.#C0] INFO  local.ua.SkypeUserAgent.#C0 - WAITING FOR INCOMING CALL
2011-01-27 09:35:53,393 [local.ua.SSCallChannel.#C1] INFO  local.ua.SkypeUserAgent.#C1 - WAITING FOR INCOMING CALL
2011-01-27 09:35:53,394 [local.ua.SSCallChannel.#C0] DEBUG local.ua.SSCallChannel.#C0 - TotMem=5952KB  Free=3846KB
2011-01-27 09:35:53,395 [local.ua.SSCallChannel.#C1] DEBUG local.ua.SSCallChannel.#C1 - TotMem=5952KB  Free=3846KB
2011-01-27 09:35:53,414 [local.ua.SSCallChannel.#C0] DEBUG local.ua.SSCallChannel.#C0 - TotMem=5952KB  Free=5102KB
2011-01-27 09:35:53,429 [main] DEBUG local.ua.SkypeUA - CallsList:16525, 16365, 16205, 16109, 15949, 15789, 15629, 15469, 15309, 15085, 14989, 14733, 14573, 14349, 14189, 13933, 13805, 12973, 12845, 12461, 12141, 11405, 11309, 11149, 10989, 10701, 10477, 10317, 10221, 9901, 9805, 9133, 9037, 7725, 7213, 7053, 6413, 6253, 5229, 5005, 4205, 3917, 3821
2011-01-27 09:35:53,429 [local.ua.SSCallChannel.#C1] DEBUG local.ua.SSCallChannel.#C1 - TotMem=5952KB  Free=5104KB
2011-01-27 09:35:53,430 [main] INFO  local.ua.SkypeUA - 43 possible calls to import.
2011-01-27 09:35:53,438 [main] DEBUG local.ua.CallHistoryHandler - Call Log Switch: log/callLog_userid_20110126.log
2011-01-27 09:35:53,458 [main] INFO  local.ua.SkypeUA - 9 PSTN calls imported
2011-01-27 09:35:53,460 [main] INFO  local.ua.SkypeUA - PSTN counters reset at: 19:00:00 EST
2011-01-27 09:35:53,461 [main] DEBUG local.ua.CallHistoryHandler - Call Log Switch: log/callLog_userid_20110127.log
2011-01-27 09:35:53,464 [main] INFO  local.ua.SkypeUA - Qualified PSTN calls today: 0 Time: 0 minutes
2011-01-27 09:35:53,466 [main] INFO  local.ua.SkypeUA - AcctBalance: 0.00 USD
2011-01-27 09:36:07,064 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (975 bytes): received
INVITE sip:8139748459@131.xxx.xxx.72:5070 SIP/2.0
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
To: <sip:8139748459@131.xxx.xxx.72:5070>
Contact: <sip:userid@131.xxx.xxx.57:5060;transport=udp>
Supported: replaces, timer, path
P-Early-Media: Supported
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
User-Agent: Grandstream BT200 1.xxx.xxx.19
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
Content-Type: application/sdp
Content-Length: 358

v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.57
t=0 0
m=audio 5036 RTP/AVP 0 8 4 18 2 97 9 3
a=sendrecv
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:18 G729/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=20
a=rtpmap:9 G722/8000
a=rtpmap:3 GSM/8000
a=ptime:20
-----End-of-message-----

2011-01-27 09:36:07,074 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - changed transaction state: T_Trying
2011-01-27 09:36:07,081 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (347 bytes): sent
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
Server: mjsip stack 1.6 sts.2
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:07,082 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - changed transaction state: T_Proceeding
2011-01-27 09:36:07,082 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside onTransRequest(ts,msg)
2011-01-27 09:36:07,083 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_INVITED
2011-01-27 09:36:07,083 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=3
2011-01-27 09:36:07,084 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=3
2011-01-27 09:36:07,085 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - new dialog id: c1c14e2c3fed25d8@131.xxx.xxx.57-null-72d405a4d1351b9b
2011-01-27 09:36:07,087 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - onCallIncoming()
2011-01-27 09:36:07,087 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - onCallIncoming INCOMING SIP CALL
From: "Jason" <sip:userid@131.xxx.xxx.72:5070> To: <sip:8139748459@131.xxx.xxx.72:5070>
2011-01-27 09:36:07,093 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - ### selectCodec mjsipAfterSelect=v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.72
t=0 0
m=audio 63202 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=sendrecv
a=silenceSupp:off

2011-01-27 09:36:07,094 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C1 - incoming sip call from "Jason" <sip:userid@131.xxx.xxx.72:5070> callee=<sip:8139748459@131.xxx.xxx.72:5070> ReqLineUser=8139748459
2011-01-27 09:36:07,095 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.AuthMap - map SipCallerID=userid realm:131.xxx.xxx.72 IP:131.xxx.xxx.57 Dest:<sip:8139748459@131.xxx.xxx.72:5070> ReqLineUser:8139748459
2011-01-27 09:36:07,096 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.AuthMap - match=::
2011-01-27 09:36:07,096 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SSCallChannel.#C1 - handleSipCall - authMap:8139748459
2011-01-27 09:36:07,099 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C1 - Skype Dial:8139748459
2011-01-27 09:36:08,099 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C1 - Actual destination:+18139748459
2011-01-27 09:36:08,136 [AsyncSkypeMessageSender-0] DEBUG local.ua.SkypeUA - callMaked: Skype ROUTING id=16749
2011-01-27 09:36:08,137 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - skypeCallStatus[16749] - ROUTING
2011-01-27 09:36:12,575 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside ring()
2011-01-27 09:36:12,575 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(180,Ringing)
2011-01-27 09:36:12,578 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(resp)
2011-01-27 09:36:12,579 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(resp)
2011-01-27 09:36:12,581 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (395 bytes): sent
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
Contact: <sip:userid@131.xxx.xxx.72:5070>
Server: mjsip stack 1.6 sts.2
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:12,583 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - skypeCallStatus[16749] - RINGING
2011-01-27 09:36:12,884 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - skypeCallStatus[16749] - EARLYMEDIA
2011-01-27 09:36:12,885 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside accept(sdp)
2011-01-27 09:36:12,886 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(200,OK)
2011-01-27 09:36:12,888 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(resp)
2011-01-27 09:36:12,888 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(resp)
2011-01-27 09:36:12,889 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=3
2011-01-27 09:36:12,890 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - new dialog id: c1c14e2c3fed25d8@131.xxx.xxx.57-7602105a672d5aa6-72d405a4d1351b9b
2011-01-27 09:36:12,890 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_ACCEPTED
2011-01-27 09:36:12,891 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=5
2011-01-27 09:36:12,892 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - changed transaction state: T_Terminated
2011-01-27 09:36:12,893 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.transaction.AckTransactionServer - id: ACK
2011-01-27 09:36:12,896 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.transaction.AckTransactionServer - created
2011-01-27 09:36:12,896 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.transaction.AckTransactionServer - start
2011-01-27 09:36:12,897 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.transaction.AckTransactionServer - changed transaction state: T_Proceeding
2011-01-27 09:36:12,899 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (596 bytes): sent
SIP/2.0 200 OK
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKcf74d4afd2df79d2
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 INVITE
Contact: <sip:userid@131.xxx.xxx.72:5070>
Server: mjsip stack 1.6 sts.2
Content-Length: 173
Content-Type: application/sdp

v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.72
t=0 0
m=audio 63202 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=sendrecv
a=silenceSupp:off
-----End-of-message-----

2011-01-27 09:36:12,902 [AsyncSkypeMessageSender-0] DEBUG local.ua.SSCallChannel.#C1 - ###  redirSkypeAudio success
2011-01-27 09:36:12,903 [local.ua.SkypeAudioSenderServer.T13] DEBUG local.ua.SkypeAudioSenderServer.T13 - +++ skypeAudioSender connected to port:64434
2011-01-27 09:36:12,904 [local.ua.SkypeAudioReceiverServer.T11] DEBUG local.ua.SSInBandDtmfDetector.T16 - InbandDtmfDecoderGainAdjust: 1.0
2011-01-27 09:36:12,906 [local.ua.SkypeAudioReceiverServer.T11] DEBUG local.ua.SkypeAudioReceiverServer.T11 - +++ skypeAudioReceiver Connected on port:64435
2011-01-27 09:36:12,931 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (556 bytes): received
ACK sip:userid@131.xxx.xxx.72:5070 SIP/2.0
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bK89ca89fd80b36af0
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
Contact: <sip:userid@131.xxx.xxx.57:5060;transport=udp>
Supported: path
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44128 ACK
User-Agent: Grandstream BT200 1.xxx.xxx.19
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:12,933 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - Message received: ACK sip:userid@131.xxx.xxx.72:5070 SIP/2.0
2011-01-27 09:36:12,934 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside onReceivedMessage(sip_provider,message)
2011-01-27 09:36:12,934 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_CALL
2011-01-27 09:36:12,934 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=6
2011-01-27 09:36:12,934 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.AckTransactionServer - changed transaction state: T_Terminated
2011-01-27 09:36:12,935 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - onCallConfirmed()
2011-01-27 09:36:12,935 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - CONFIRMED/CALL
2011-01-27 09:36:12,936 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - launchMediaApplication
remote media IP:131.xxx.xxx.57
localSdp:v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.72
t=0 0
m=audio 63202 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=sendrecv
a=silenceSupp:off


remoteSdp:v=0
o=userid 8000 8000 IN IP4 131.xxx.xxx.57
s=SIP Call
c=IN IP4 131.xxx.xxx.57
t=0 0
m=audio 5036 RTP/AVP 0 8 4 18 2 97 9 3
a=sendrecv
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:18 G729/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=20
a=rtpmap:9 G722/8000
a=rtpmap:3 GSM/8000
a=ptime:20

2011-01-27 09:36:12,937 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - RTP audio ports: local_audio_port=63202 remote_audio_port=5036
2011-01-27 09:36:12,938 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUserAgent.#C1 - Starting codec: PCMU/8000(0) rfc2833Type(101)
2011-01-27 09:36:12,942 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.JSkypeAudioLauncher - starting skype/sip audio bridge..
2011-01-27 09:36:12,943 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C1 - CallConfirmed Active
2011-01-27 09:36:12,943 [local.ua.SkypeRtpSender.T8] DEBUG local.ua.SkypeRtpSender.T8 - +++ sipAudioSender Connected - skypeframesize:960 framesize:240 frame_time:30
2011-01-27 09:36:12,943 [local.ua.SkypeRtpReceiver.T9] DEBUG local.ua.SkypeRtpReceiver.T9 - +++ sipAudioReceiver - sip Port:63202
2011-01-27 09:36:12,944 [local.ua.SkypeRtpSender.T8] INFO  local.ua.SkypeRtpSender.T8 - RTP media target: 131.xxx.xxx.57:5036
2011-01-27 09:36:12,966 [local.ua.SkypeRtpReceiver.T9] INFO  local.ua.SkypeRtpReceiver.T9 - RtpSender Address locked.
2011-01-27 09:36:13,813 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - skypeCallStatus[16749] - INPROGRESS
2011-01-27 09:36:13,814 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - Call Rate: Free
2011-01-27 09:36:13,816 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - This call is limited to: 350 minutes
2011-01-27 09:36:25,370 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (529 bytes): received
BYE sip:userid@131.xxx.xxx.72:5070 SIP/2.0
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKb5908b969b3eab4e
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
Supported: path
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44129 BYE
User-Agent: Grandstream BT200 1.xxx.xxx.19
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE,UPDATE,PRACK
Reason: SIP ;text="Onhook event"
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:25,372 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - Message received: BYE sip:userid@131.xxx.xxx.72:5070 SIP/2.0
2011-01-27 09:36:25,372 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside onReceivedMessage(sip_provider,message)
2011-01-27 09:36:25,373 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_BYED
2011-01-27 09:36:25,373 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=8
2011-01-27 09:36:25,374 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.TransactionServer - id: c1c14e2c3fed25d8@131.xxx.xxx.57-44129-BYE-z9hG4bKb5908b969b3eab4e
2011-01-27 09:36:25,374 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.TransactionServer - created
2011-01-27 09:36:25,374 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.TransactionServer - start
2011-01-27 09:36:25,374 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.TransactionServer - changed transaction state: T_Trying
2011-01-27 09:36:25,375 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(resp)
2011-01-27 09:36:25,376 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - inside respond(resp)
2011-01-27 09:36:25,377 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.provider.SipProvider_msg -
131.xxx.xxx.57:5060/udp (340 bytes): sent
SIP/2.0 200 OK
Via: SIP/2.0/UDP 131.xxx.xxx.57:5060;branch=z9hG4bKb5908b969b3eab4e
To: <sip:8139748459@131.xxx.xxx.72:5070>;tag=7602105a672d5aa6
From: "Jason" <sip:userid@131.xxx.xxx.72:5070>;tag=72d405a4d1351b9b
Call-ID: c1c14e2c3fed25d8@131.xxx.xxx.57
CSeq: 44129 BYE
Server: mjsip stack 1.6 sts.2
Content-Length: 0

-----End-of-message-----

2011-01-27 09:36:25,378 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.TransactionServer - changed transaction state: T_Completed
2011-01-27 09:36:25,378 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - onCallClosing()
2011-01-27 09:36:25,378 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUserAgent.#C1 - BYE
2011-01-27 09:36:25,379 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.JSkypeAudioLauncher - halting skype/sip audio bridge..
2011-01-27 09:36:25,383 [local.ua.SkypeAudioReceiverServer.T11] INFO  local.ua.SkypeAudioReceiverServer.T11 - * SkypeAudioReceiver stats - packets:391
2011-01-27 09:36:25,386 [local.ua.SkypeRtpSender.T8] INFO  local.ua.SkypeRtpSender.T8 - * RTPSender stats - packets:413 maxLatency:70ms avgLatency:41ms
2011-01-27 09:36:25,529 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_CLOSE
2011-01-27 09:36:25,529 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=9
2011-01-27 09:36:25,529 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - onCallClosed()
2011-01-27 09:36:25,530 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - CLOSE/OK
2011-01-27 09:36:25,530 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SSCallChannel.#C1 - onUaCallClosed
2011-01-27 09:36:25,531 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C1 - OUTGOING_PSTN From: "Jason" <sip:userid@131.xxx.xxx.72:5070> To: +18139748459 CallTime: 0:12 Cost: FREE
2011-01-27 09:36:25,533 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUA - Qualified PSTN calls today: 1 Time: 1 minutes
2011-01-27 09:36:25,533 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SSCallChannel.#C1 - AcctBalance: 0.00 USD
2011-01-27 09:36:25,533 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SkypeUserAgent.#C1 - HANGUP
2011-01-27 09:36:25,534 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isWaiting - callState=9
2011-01-27 09:36:25,534 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=9
2011-01-27 09:36:25,535 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_INIT
2011-01-27 09:36:25,535 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=0
2011-01-27 09:36:25,535 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - changed dialog state: D_WAITING
2011-01-27 09:36:25,536 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isTerminated - callState=1
2011-01-27 09:36:25,536 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - id: INVITE
2011-01-27 09:36:25,536 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - created
2011-01-27 09:36:25,536 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - start
2011-01-27 09:36:25,537 [org.zoolu.net.UdpProvider.T1] DEBUG org.zoolu.sip.transaction.InviteTransactionServer - changed transaction state: T_Waiting
2011-01-27 09:36:25,538 [org.zoolu.net.UdpProvider.T1] INFO  local.ua.SkypeUserAgent.#C1 - WAITING FOR INCOMING CALL
2011-01-27 09:36:25,538 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SSCallChannel.#C1 - TotMem=5952KB  Free=4119KB
2011-01-27 09:36:25,559 [org.zoolu.net.UdpProvider.T1] DEBUG local.ua.SSCallChannel.#C1 - TotMem=5952KB  Free=4902KB
2011-01-27 09:36:25,559 [local.ua.SkypeAudioSenderServer.T13] INFO  local.ua.SkypeAudioSenderServer.T13 - * SkypeAudioSender stats - packets:35 IOErrors:1 maxLatency:820ms avgLatency:42ms
2011-01-27 09:36:25,559 [AsyncSkypeMessageSender-0] INFO  local.ua.SSCallChannel.#C1 - skypeCallStatus[16749] - Complete: FINISHED
2011-01-27 09:36:25,560 [AsyncSkypeMessageSender-0] DEBUG local.ua.SkypeUserAgent.#C1 - HANGUP
2011-01-27 09:36:25,560 [AsyncSkypeMessageSender-0] DEBUG org.zoolu.sip.dialog.ExtendedInviteDialog - isWaiting - callState=1
2011-01-27 09:36:26,507 [local.ua.SkypeRtpReceiver.T9] INFO  local.ua.SkypeRtpReceiver.T9 - * RTPReceiver stats - packets:178

4 Reply by scolja

  • scolja
  • Member
  • Offline

Re: No Audio Being Sent

OK - think I'm onto something.  I don't have a microphone on my Skype machine, so Skype has been set to Microphone = None.  As soon as I connect a microphone to it, it seems SipToSis can successfully "hijack" it and transmit the audio successfully.  I'd prefer not to essentially have a "dummy" microphone connected if at all possible, but this seems positive.

I started the debug of this with the recordSkypeIn, recordSkypeOut config settings - nice job!  You've done a hell of a job with this tool and it's really appreciated.

5 Reply by MH

  • MH
  • Administrator
  • Offline

Re: No Audio Being Sent

You can try virtual audio cables: http://software.muzychenko.net/eng/vac.htm
Someone else had the same issue and it worked for him.

6 Reply by scolja

  • scolja
  • Member
  • Offline

Re: No Audio Being Sent

Works like a champ.  Thank you.