[Freeswitch-users] gtalk dingaling G723

11 Dec 2009

      hi!

Pls shed some light to the below dingaling/gtalk issue.

___________________________Call path________________________
Gtalk ---> Account setup in client.xml ---routed to public.xml ---> route to
a external SIP gateway -----> sipUserA

___________________________Problem statement________________

The above call scenario is successfull using the *PMCU, PCMA* codecs in
"dingaling.conf.xml". Both parties can hear each other.
When I choose G723 the call disconnects after few seconds(2~). Both parties
can hear some noise & thasts all.

I see the call is bridged and then immediately unbridged.

I assume G.723 is suppose to work here in passtru mode. Do I have to do any
other configuration ohter than the ones listed below in order to get
passthru working.

___________________________LOG important parts________________
(Full log found at the end)
2009-12-11 16:05:12.948700 [ERR] mod_g723_1.c:148 This codec is only usable
in passthrough mode!
2009-12-11 16:05:12.948700 [DEBUG] switch_ivr_bridge.c:464 DingaLing/new
ending bridge by request from write function
2009-12-11 16:05:12.948700 [DEBUG] switch_ivr_bridge.c:520
sofia/external/0094777915380 receive message [UNBRIDGE]

________________________Configuration XMLS______________________

________________________dingaling.conf.xml_____________________
<configuration name="dingaling.conf" description="XMPP Jingle Endpoint">
  <settings>
    <param name="debug" value="20"/>
    <param name="codec-prefs" value="G723"/>
    <!-- <param name="codec-prefs" value="PCMU"/> -->
  </settings>

  <X-PRE-PROCESS cmd="include" data="../jingle_profiles/*.xml"/>

</configuration>

______________________________public.xml__________________________
<extension name="public_did">
  <condition field="caller_id_number" expression="^([^@]+)" break="never">
    <action application="set" data="effective_caller_id_number=$1"/>
  </condition>
  <condition field="destination_number" expression="^(5555)$">
    <action application="set" data="call_timeout=18"/>
    <action application="set" data="continue_on_fail=true"/>
    <action application="set" data="hangup_after_bridge=true"/>
    <!-- <action application="bridge" data="sofia/internal/1001@safaricom"/>
-->
    <!-- X
    <action application="set" data="proxy_media=true"/>
    <action application="set" data="bypass_media=false"/>
   <anti-action application="set" data="proxy_media=false"/>
   <anti-action application="set" data="bypass_media=true"/>
    <action application="set" data="absolute_codec_string=G723"/> -->
    <!-- X-->
    <!-- <action application="bridge" data="user/1001@172.16.11.211"/> -->
    <!-- <action application="bridge" data="sofia/gateway/sbc/$1"/> -->
    <action application="bridge" data="sofia/gateway/sbc/sipUserA"/>
  </condition>
</extension>
______________________________client.xml___________________________
<include>
  <!-- Client Profile (Original mode) -->
  <!-- to use this profile take the x- away from the open and close tags so
its <profile> and </profile> -->
  <profile type="client">
   <param name="name" value="gmail.com"/>
   <param name="login" value="xxxxx@gmail.com/gtalk"/>
   <param name="password" value="xxxx"/>
   <param name="server" value="talk.google.com"/>
   <param name="dialplan" value="XML"/>
   <param name="context" value="public"/>
   <param name="message" value="xxxxxxxxxx"/>
   <param name="rtp-ip" value="auto"/>
   <param name="candidate-acl" value="wan"/>
   <!-- if you are behind NAT, you should probably use stun -->
   <param name="ext-rtp-ip" value="$${external_rtp_ip}"/>
   <param name="auto-login" value="true"/>
   <param name="auto-reply" value="Press *Call* to join my conference"/>
   <param name="sasl" value="plain"/>
   <param name="tls" value="true"/>
   <param name="use-rtp-timer" value="true"/>
   <param name="exten" value="5555"/>
   <param name="vad" value="both"/>
 </profile>
</include>
__________________________________Full Log__________________________
____________________________________________________________________
____________________________________________________________________
____________________________________________________________________

freeswitch@internal> 2009-12-11 16:18:05.848176 [INFO] libdingaling.c:1305
SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="83"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="initiate" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <description xmlns="http://www.google.com/session/phone">
      <payload-type id="103" name="ISAC"></payload-type>
      <payload-type id="97" name="IPCMWB"></payload-type>
      <payload-type id="4" name="G723"></payload-type>
      <payload-type id="100" name="EG711U"></payload-type>
      <payload-type id="101" name="EG711A"></payload-type>
      <payload-type id="0" name="PCMU"></payload-type>
      <payload-type id="8" name="PCMA"></payload-type>
      <payload-type id="13" name="CN"></payload-type>
      <payload-type id="102" name="iLBC"></payload-type>
      <payload-type id="117" name="red"></payload-type>
      <payload-type id="106" name="audio/telephone-event"></payload-type>
    </description>
  </session>
</iq>

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:353 Created Session
596627090

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [ISAC]
id='103'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [IPCMWB]
id='97'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [G723]
id='4'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [EG711U]
id='100'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [EG711A]
id='101'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [PCMU]
id='0'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [PCMA]
id='8'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [CN]
id='13'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [iLBC]
id='102'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload [red]
id='117'

2009-12-11 16:18:05.848176 [DEBUG] libdingaling.c:421 Add Payload
[audio/telephone-event] id='106'

2009-12-11 16:18:05.848176 [DEBUG] mod_dingaling.c:3028 Creating an identity
for 596627090 GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB <
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB> 5555
2009-12-11 16:18:05.848176 [NOTICE] switch_channel.c:613 New Channel
dingaling/5555 [d689728e-fcbd-433d-8b87-7c54c03d2825]
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3056 Creating a session
for 596627090
2009-12-11 16:18:05.849387 [NOTICE] switch_channel.c:611 Rename Channel
dingaling/5555->DingaLing/new [d689728e-fcbd-433d-8b87-7c54c03d2825]
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3060 (DingaLing/new)
State Change CS_NEW -> CS_INIT
2009-12-11 16:18:05.849387 [DEBUG] switch_core_session.c:999 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3157 11 payloads
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3159 Available Payload
ISAC 103
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3166 compare ISAC
103/8000 to G723 4/8000
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3159 Available Payload
IPCMWB 97
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3166 compare IPCMWB
97/8000 to G723 4/8000
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3159 Available Payload
G723 4
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3166 compare G723 4/8000
to G723 4/8000
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:3177 Choosing Payload
index 0 G723 4
2009-12-11 16:18:05.849387 [DEBUG] mod_dingaling.c:1066 Send Describe
[G723@8000]
2009-12-11 16:18:05.849387 [DEBUG] switch_core_state_machine.c:314
(DingaLing/new) Running State Change CS_INIT
2009-12-11 16:18:05.849387 [DEBUG] switch_core_state_machine.c:338
(DingaLing/new) State INIT
2009-12-11 16:18:05.849387 [NOTICE] mod_dingaling.c:1093 Ring-Ready
DingaLing/new!
2009-12-11 16:18:05.884166 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="83">
  <query></query>
</iq>

2009-12-11 16:18:05.884166 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:05.884166 [DEBUG] libdingaling.c:1406 Sending packet 300 (2
left)

2009-12-11 16:18:05.884166 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq xmlns="jabber:client" from="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE"
to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" type="set" id="300">
  <ses:session xmlns:ses="http://www.google.com/session" type="accept"
id="596627090" initiator="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
    <pho:description xmlns:pho="http://www.google.com/session/phone"
xml:lang="en">
      <pho:payload-type xmlns:pho="http://www.google.com/session/phone"
id="4" name="G723" clockrate="8000" bitrate="6300"></pho:payload-type>
    </pho:description>
  </ses:session>
</iq>

2009-12-11 16:18:05.983333 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.084116 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.184092 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.284068 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.384042 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.483334 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.583993 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.683965 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.783940 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.867919 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="85"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="candidates" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <candidate name="rtp" address="172.16.11.110" port="1563"
username="Unokk7lKh84I8mEM" password="At5OQzApw/ZrIrCo" preference="1"
protocol="udp" type="local" network="0" generation="0"></candidate>
  </session>
</iq>

2009-12-11 16:18:06.867919 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:06.867919 [DEBUG] libdingaling.c:503 New Candidate 1
name=rtp
type=local
protocol=udp
username=Unokk7lKh84I8mEM
password=At5OQzApw/ZrIrCo
address=172.16.11.110
port=1563
pref=1.00

2009-12-11 16:18:06.867919 [DEBUG] mod_dingaling.c:2916 using Existing
session for 596627090
2009-12-11 16:18:06.867919 [DEBUG] mod_dingaling.c:3227 1 candidates
2009-12-11 16:18:06.867919 [DEBUG] mod_dingaling.c:3243 candidate
172.16.11.110:1563 FAIL ACL wan
2009-12-11 16:18:06.883915 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="85">
  <query></query>
</iq>

2009-12-11 16:18:06.883915 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:06.983330 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:07.013899 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="86"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="candidates" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <candidate name="rtp" address="172.16.7.28" port="1566"
username="W3xgvc25vCXb5M/U" password="7EcqsVB3S6J3I2+g" preference="1"
protocol="udp" type="local" network="1" generation="0"></candidate>
  </session>
</iq>

2009-12-11 16:18:07.013899 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:07.013899 [DEBUG] libdingaling.c:463 Duplicate Pref!

2009-12-11 16:18:07.013899 [DEBUG] libdingaling.c:503 New Candidate 1
name=rtp
type=local
protocol=udp
username=W3xgvc25vCXb5M/U
password=7EcqsVB3S6J3I2+g
address=172.16.7.28
port=1566
pref=1.00

2009-12-11 16:18:07.013899 [DEBUG] mod_dingaling.c:2916 using Existing
session for 596627090
2009-12-11 16:18:07.013899 [DEBUG] mod_dingaling.c:3227 1 candidates
2009-12-11 16:18:07.013899 [DEBUG] mod_dingaling.c:3243 candidate
172.16.7.28:1566 FAIL ACL wan
2009-12-11 16:18:07.083870 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="86">
  <query></query>
</iq>

2009-12-11 16:18:07.083870 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:07.119862 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="300"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB"></iq>

2009-12-11 16:18:07.119862 [DEBUG] libdingaling.c:943 Cancel packet 300

2009-12-11 16:18:07.183848 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:07.183848 [DEBUG] libdingaling.c:1414 Discarding packet 300

2009-12-11 16:18:08.365552 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="87"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="candidates" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <candidate name="rtp" address="209.85.229.126" port="19295"
username="erYq6ggXdBRbEVDe" password="GQcop4clv7IEVldS" preference="0.5"
protocol="udp" type="relay" network="0" generation="0"></candidate>
  </session>
</iq>

2009-12-11 16:18:08.365552 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:08.365552 [DEBUG] libdingaling.c:503 New Candidate 2
name=rtp
type=relay
protocol=udp
username=erYq6ggXdBRbEVDe
password=GQcop4clv7IEVldS
address=209.85.229.126
port=19295
pref=0.50

2009-12-11 16:18:08.365552 [DEBUG] mod_dingaling.c:2916 using Existing
session for 596627090
2009-12-11 16:18:08.365552 [DEBUG] mod_dingaling.c:3227 2 candidates
2009-12-11 16:18:08.365552 [DEBUG] mod_dingaling.c:3243 candidate
172.16.7.28:1566 FAIL ACL wan
2009-12-11 16:18:08.365552 [DEBUG] mod_dingaling.c:3239 candidate
209.85.229.126:19295 PASS ACL wan
2009-12-11 16:18:08.365552 [DEBUG] mod_dingaling.c:3288 Acceptable Candidate
209.85.229.126:19295
2009-12-11 16:18:08.365552 [DEBUG] mod_dingaling.c:976 Stun Lookup Local
172.16.11.211:22878
2009-12-11 16:18:15.496911 [INFO] mod_dingaling.c:984 Stun Success
XX.XX.XX.XX:22878
2009-12-11 16:18:15.496911 [DEBUG] mod_dingaling.c:998 Send Candidate
XX.XX.XX.XX:22878 [goTRR95uTkRRMe3t]
2009-12-11 16:18:15.496911 [DEBUG] mod_dingaling.c:856 Set Read Codec to
G723@8000
2009-12-11 16:18:15.496911 [DEBUG] mod_dingaling.c:871 Set Write Codec to
G723@8000
2009-12-11 16:18:15.496911 [DEBUG] mod_dingaling.c:884 SETUP RTP
172.16.11.211:22878 -> 209.85.229.126:19295
2009-12-11 16:18:15.496911 [DEBUG] switch_rtp.c:1167 Starting timer [soft]
960 bytes per 120ms
2009-12-11 16:18:15.498911 [DEBUG] switch_rtp.c:2905 Activate VAD codec G723
120ms
2009-12-11 16:18:15.498911 [DEBUG] mod_dingaling.c:1184 (DingaLing/new)
State Change CS_INIT -> CS_ROUTING
2009-12-11 16:18:15.498911 [DEBUG] switch_core_session.c:999 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:15.498911 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:15.498911 [DEBUG] switch_core_state_machine.c:338
(DingaLing/new) State INIT going to sleep
2009-12-11 16:18:15.498911 [DEBUG] switch_core_state_machine.c:314
(DingaLing/new) Running State Change CS_ROUTING
2009-12-11 16:18:15.498911 [DEBUG] switch_core_state_machine.c:341
(DingaLing/new) State ROUTING
2009-12-11 16:18:15.498911 [DEBUG] mod_dingaling.c:1198 DingaLing/new
CHANNEL ROUTING
2009-12-11 16:18:15.498911 [DEBUG] switch_core_state_machine.c:78
DingaLing/new Standard ROUTING
2009-12-11 16:18:15.498911 [INFO] mod_dialplan_xml.c:408 Processing
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB->5555 in context public
Dialplan: DingaLing/new parsing [public->public_did] continue=false
Dialplan: DingaLing/new Regex (PASS) [public_did] caller_id_number(
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB) =~ /^([^@]+)/ break=never
Dialplan: DingaLing/new Action
set(effective_caller_id_number=GTALK_ANY_CLIENT)
Dialplan: DingaLing/new Regex (PASS) [public_did] destination_number(5555)
=~ /^(5555)$/ break=on-false
Dialplan: DingaLing/new Action set(call_timeout=18)
Dialplan: DingaLing/new Action set(continue_on_fail=true)
Dialplan: DingaLing/new Action set(hangup_after_bridge=true)
Dialplan: DingaLing/new Action bridge(sofia/gateway/sbc/sipUserA)
Dialplan: DingaLing/new Action answer()
Dialplan: DingaLing/new Action voicemail(default 172.16.11.211 1001)
2009-12-11 16:18:15.499911 [DEBUG] switch_core_state_machine.c:122
(DingaLing/new) State Change CS_ROUTING -> CS_EXECUTE
2009-12-11 16:18:15.499911 [DEBUG] switch_core_session.c:999 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:15.499911 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:15.499911 [DEBUG] switch_core_state_machine.c:341
(DingaLing/new) State ROUTING going to sleep
2009-12-11 16:18:15.499911 [DEBUG] switch_core_state_machine.c:314
(DingaLing/new) Running State Change CS_EXECUTE
2009-12-11 16:18:15.499911 [DEBUG] switch_core_state_machine.c:348
(DingaLing/new) State EXECUTE
2009-12-11 16:18:15.499911 [DEBUG] mod_dingaling.c:1215 DingaLing/new
CHANNEL EXECUTE
2009-12-11 16:18:15.499911 [DEBUG] switch_core_state_machine.c:159
DingaLing/new Standard EXECUTE
EXECUTE DingaLing/new set(effective_caller_id_number=GTALK_ANY_CLIENT)
2009-12-11 16:18:15.499911 [DEBUG] mod_dptools.c:768 DingaLing/new SET
[effective_caller_id_number]=[GTALK_ANY_CLIENT]
EXECUTE DingaLing/new set(call_timeout=18)
2009-12-11 16:18:15.499911 [DEBUG] mod_dptools.c:768 DingaLing/new SET
[call_timeout]=[18]
EXECUTE DingaLing/new set(continue_on_fail=true)
2009-12-11 16:18:15.499911 [DEBUG] mod_dptools.c:768 DingaLing/new SET
[continue_on_fail]=[true]
EXECUTE DingaLing/new set(hangup_after_bridge=true)
2009-12-11 16:18:15.499911 [DEBUG] mod_dptools.c:768 DingaLing/new SET
[hangup_after_bridge]=[true]
EXECUTE DingaLing/new bridge(sofia/gateway/sbc/sipUserA)
2009-12-11 16:18:15.500912 [NOTICE] switch_channel.c:613 New Channel
sofia/external/sipUserA [cf250379-b2c9-439e-8295-766feef6cf74]
2009-12-11 16:18:15.500912 [DEBUG] mod_sofia.c:3142
(sofia/external/sipUserA) State Change CS_NEW -> CS_INIT
2009-12-11 16:18:15.500912 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:15.500912 [DEBUG] switch_core_state_machine.c:314
(sofia/external/sipUserA) Running State Change CS_INIT
2009-12-11 16:18:15.500912 [DEBUG] switch_core_state_machine.c:338
(sofia/external/sipUserA) State INIT
2009-12-11 16:18:15.500912 [DEBUG] mod_sofia.c:83 sofia/external/sipUserA
SOFIA INIT
2009-12-11 16:18:15.500912 [DEBUG] mod_sofia.c:111 (sofia/external/sipUserA)
State Change CS_INIT -> CS_ROUTING
2009-12-11 16:18:15.500912 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:15.500912 [DEBUG] switch_core_state_machine.c:338
(sofia/external/sipUserA) State INIT going to sleep
2009-12-11 16:18:15.500912 [DEBUG] switch_core_state_machine.c:314
(sofia/external/sipUserA) Running State Change CS_ROUTING
2009-12-11 16:18:15.500912 [DEBUG] switch_core_state_machine.c:341
(sofia/external/sipUserA) State ROUTING
2009-12-11 16:18:15.500912 [DEBUG] mod_sofia.c:132 sofia/external/sipUserA
SOFIA ROUTING
2009-12-11 16:18:15.500912 [DEBUG] switch_ivr_originate.c:66
(sofia/external/sipUserA) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2009-12-11 16:18:15.500912 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:15.501911 [DEBUG] switch_core_state_machine.c:341
(sofia/external/sipUserA) State ROUTING going to sleep
2009-12-11 16:18:15.501911 [DEBUG] switch_core_state_machine.c:314
(sofia/external/sipUserA) Running State Change CS_CONSUME_MEDIA
2009-12-11 16:18:15.501911 [DEBUG] switch_core_state_machine.c:360
(sofia/external/sipUserA) State CONSUME_MEDIA
2009-12-11 16:18:15.501911 [DEBUG] switch_core_state_machine.c:360
(sofia/external/sipUserA) State CONSUME_MEDIA going to sleep
2009-12-11 16:18:15.501911 [DEBUG] sofia.c:3727 Channel
sofia/external/sipUserA entering state [calling][0]
2009-12-11 16:18:15.583888 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="87">
  <query></query>
</iq>

2009-12-11 16:18:15.583888 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:15.583888 [DEBUG] libdingaling.c:1406 Sending packet 301 (2
left)

2009-12-11 16:18:15.583888 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq xmlns="jabber:client" from="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE"
to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" type="set" id="301">
  <ses:session xmlns:ses="http://www.google.com/session" type="candidates"
id="596627090" initiator="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
    <ses:candidate name="rtp" address="XX.XX.XX.XX" port="22878"
username="goTRR95uTkRRMe3t" password="goTRR95uTkRRMe3t" preference="1.0"
protocol="udp" type="stun" network="0" generation="0"></ses:candidate>
  </ses:session>
</iq>

2009-12-11 16:18:15.684864 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:15.784839 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:15.884815 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:15.984789 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.084764 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.184740 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.284715 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.384691 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.484666 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.584640 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.684617 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.784591 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.810584 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="301"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB"></iq>

2009-12-11 16:18:16.810584 [DEBUG] libdingaling.c:943 Cancel packet 301

2009-12-11 16:18:16.884567 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:16.884567 [DEBUG] libdingaling.c:1414 Discarding packet 301

2009-12-11 16:18:17.795342 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="88"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="candidates" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <candidate name="rtp" address="172.16.7.28" port="1569"
username="pBOc+m0nq7uQngnq" password="HzZY2+zb/u9oRH++" preference="0.8"
protocol="tcp" type="local" network="1" generation="0"></candidate>
  </session>
</iq>

2009-12-11 16:18:17.795342 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:17.795342 [DEBUG] libdingaling.c:503 New Candidate 3
name=rtp
type=local
protocol=tcp
username=pBOc+m0nq7uQngnq
password=HzZY2+zb/u9oRH++
address=172.16.7.28
port=1569
pref=0.80

2009-12-11 16:18:17.795342 [DEBUG] mod_dingaling.c:2916 using Existing
session for 596627090
2009-12-11 16:18:17.795342 [DEBUG] mod_dingaling.c:3223 Already picked an IP
[209.85.229.126]
2009-12-11 16:18:17.798342 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="89"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="candidates" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <candidate name="rtp" address="209.85.229.126" port="19294"
username="erYq6ggXdBRbEVDe" password="GQcop4clv7IEVldS" preference="0.5"
protocol="tcp" type="relay" network="0" generation="0"></candidate>
    <candidate name="rtp" address="172.16.11.110" port="1570"
username="EXe2XpIc76S9WxgB" password="BKF7SUs/hc30Fplp" preference="0.8"
protocol="tcp" type="local" network="0" generation="0"></candidate>
  </session>
</iq>

2009-12-11 16:18:17.798342 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:17.798342 [DEBUG] libdingaling.c:463 Duplicate Pref!

2009-12-11 16:18:17.798342 [DEBUG] libdingaling.c:503 New Candidate 3
name=rtp
type=relay
protocol=tcp
username=erYq6ggXdBRbEVDe
password=GQcop4clv7IEVldS
address=209.85.229.126
port=19294
pref=0.50

2009-12-11 16:18:17.798342 [DEBUG] libdingaling.c:463 Duplicate Pref!

2009-12-11 16:18:17.798342 [DEBUG] libdingaling.c:503 New Candidate 3
name=rtp
type=local
protocol=tcp
username=EXe2XpIc76S9WxgB
password=BKF7SUs/hc30Fplp
address=172.16.11.110
port=1570
pref=0.80

2009-12-11 16:18:17.798342 [DEBUG] mod_dingaling.c:2916 using Existing
session for 596627090
2009-12-11 16:18:17.798342 [DEBUG] mod_dingaling.c:3223 Already picked an IP
[209.85.229.126]
2009-12-11 16:18:17.884322 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="88">
  <query></query>
</iq>

2009-12-11 16:18:17.884322 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="89">
  <query></query>
</iq>

2009-12-11 16:18:18.797094 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="90"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="candidates" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session">
    <candidate name="rtp" address="209.85.229.126" port="443"
username="erYq6ggXdBRbEVDe" password="GQcop4clv7IEVldS" preference="0.5"
protocol="ssltcp" type="relay" network="0" generation="0"></candidate>
  </session>
</iq>

2009-12-11 16:18:18.797094 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:18.797094 [DEBUG] libdingaling.c:463 Duplicate Pref!

2009-12-11 16:18:18.797094 [DEBUG] libdingaling.c:503 New Candidate 3
name=rtp
type=relay
protocol=ssltcp
username=erYq6ggXdBRbEVDe
password=GQcop4clv7IEVldS
address=209.85.229.126
port=443
pref=0.50

2009-12-11 16:18:18.797094 [DEBUG] mod_dingaling.c:2916 using Existing
session for 596627090
2009-12-11 16:18:18.797094 [DEBUG] mod_dingaling.c:3223 Already picked an IP
[209.85.229.126]
2009-12-11 16:18:18.885072 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="90">
  <query></query>
</iq>

2009-12-11 16:18:21.529273 [INFO] sofia.c:506 Update Callee ID to "sipUserA"
<sipUserA>
2009-12-11 16:18:21.529273 [DEBUG] sofia.c:3727 Channel
sofia/external/sipUserA entering state [proceeding][180]
2009-12-11 16:18:21.529273 [DEBUG] sofia.c:3738 Remote SDP:
v=0
o=- 298002432 1260522569 IN IP4 YY.YY.YY.YY
s=-
c=IN IP4 YY.YY.YY.YY
t=0 0
m=audio 15002 RTP/AVP 4 8
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=ptime:30

2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:3305 Audio Codec Compare
[G723:4:8000:30]/[G723:4:8000:120]
2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:3305 Audio Codec Compare
[G723:4:8000:30]/[PCMU:0:8000:120]
2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:3305 Audio Codec Compare
[G723:4:8000:30]/[PCMA:8:8000:120]
2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:3305 Audio Codec Compare
[G723:4:8000:30]/[GSM:3:8000:120]
2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:3353 Substituting codec
G723@30i@8000h
2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:2143 Set Codec
sofia/external/sipUserA G723/8000 30 ms 240 samples
2009-12-11 16:18:21.529273 [DEBUG] sofia_glue.c:2381 AUDIO RTP
[sofia/external/sipUserA] 172.16.11.211 port 32408 -> YY.YY.YY.YY port 15002
codec: 4 ms: 30
2009-12-11 16:18:21.530280 [DEBUG] switch_rtp.c:1167 Starting timer [soft]
240 bytes per 30ms
2009-12-11 16:18:21.531273 [NOTICE] sofia_glue.c:2909 Pre-Answer
sofia/external/sipUserA!
2009-12-11 16:18:21.531273 [DEBUG] switch_channel.c:2020 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:21.531273 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:21.531273 [DEBUG] switch_ivr_originate.c:2886 DingaLing/new
receive message [PROGRESS]
2009-12-11 16:18:21.531273 [DEBUG] switch_core_session.c:645 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:21.531273 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:21.531273 [NOTICE] switch_ivr_originate.c:2886 Pre-Answer
DingaLing/new!
2009-12-11 16:18:21.531273 [DEBUG] switch_ivr_originate.c:2929 Originate
Resulted in Success: [sofia/external/sipUserA]
2009-12-11 16:18:21.531273 [DEBUG] switch_channel.c:182
sofia/external/sipUserA receive message [AUDIO_SYNC]
2009-12-11 16:18:21.531273 [DEBUG] switch_channel.c:182 DingaLing/new
receive message [AUDIO_SYNC]
2009-12-11 16:18:21.531273 [DEBUG] switch_ivr_bridge.c:1032
sofia/external/sipUserA receive message [BRIDGE]
2009-12-11 16:18:21.531273 [DEBUG] switch_core_session.c:645 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:21.531273 [DEBUG] switch_ivr_bridge.c:1039 DingaLing/new
receive message [BRIDGE]
2009-12-11 16:18:21.531273 [DEBUG] switch_core_session.c:645 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:21.531273 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:21.531273 [DEBUG] switch_ivr_bridge.c:1083
(sofia/external/sipUserA) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2009-12-11 16:18:21.531273 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:21.531273 [DEBUG] switch_core_state_machine.c:314
(sofia/external/sipUserA) Running State Change CS_EXCHANGE_MEDIA
2009-12-11 16:18:21.531273 [DEBUG] switch_core_state_machine.c:351
(sofia/external/sipUserA) State EXCHANGE_MEDIA
2009-12-11 16:18:21.531273 [DEBUG] mod_sofia.c:455 SOFIA LOOPBACK
2009-12-11 16:18:21.548268 [DEBUG] switch_rtp.c:2004 Correct ip/port
confirmed.
2009-12-11 16:18:23.513922 [INFO] sofia.c:506 Update Callee ID to "sipUserA"
<sipUserA>
2009-12-11 16:18:23.513922 [DEBUG] sofia.c:3727 Channel
sofia/external/sipUserA entering state [completing][200]
2009-12-11 16:18:23.513922 [DEBUG] sofia.c:3735 Duplicate SDP
v=0
o=- 298002432 1260522569 IN IP4 YY.YY.YY.YY
s=-
c=IN IP4 YY.YY.YY.YY
t=0 0
m=audio 15002 RTP/AVP 4 8
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=ptime:30

2009-12-11 16:18:23.513922 [DEBUG] sofia.c:3727 Channel
sofia/external/sipUserA entering state [ready][200]
2009-12-11 16:18:23.513922 [DEBUG] switch_channel.c:2133 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:23.513922 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:23.513922 [NOTICE] sofia.c:4219 Channel
[sofia/external/sipUserA] has been answered
2009-12-11 16:18:23.513922 [DEBUG] switch_channel.c:182
sofia/external/sipUserA receive message [AUDIO_SYNC]
2009-12-11 16:18:23.587904 [DEBUG] switch_ivr_bridge.c:394 DingaLing/new
receive message [ANSWER]
2009-12-11 16:18:23.587904 [DEBUG] switch_core_session.c:645 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:23.587904 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:23.587904 [NOTICE] switch_ivr_bridge.c:394 Channel
[DingaLing/new] has been answered
2009-12-11 16:18:23.587904 [DEBUG] switch_channel.c:182 DingaLing/new
receive message [AUDIO_SYNC]
2009-12-11 16:18:23.587904 [DEBUG] switch_core_session.c:706 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:23.587904 [DEBUG] switch_core_session.c:706 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:23.587904 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:23.617898 [DEBUG] switch_ivr_bridge.c:131
sofia/external/sipUserA receive message [DISPLAY]
2009-12-11 16:18:23.708875 [DEBUG] switch_ivr_bridge.c:131 DingaLing/new
receive message [DISPLAY]
2009-12-11 16:18:25.568413 [DEBUG] switch_rtp.c:2004 Correct ip/port
confirmed.
2009-12-11 16:18:25.568413 [ERR] mod_g723_1.c:148 This codec is only usable
in passthrough mode!
2009-12-11 16:18:25.568413 [DEBUG] switch_ivr_bridge.c:464 DingaLing/new
ending bridge by request from write function
2009-12-11 16:18:25.568413 [DEBUG] switch_ivr_bridge.c:520
sofia/external/sipUserA receive message [UNBRIDGE]
2009-12-11 16:18:25.568413 [DEBUG] switch_core_session.c:645 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:25.568413 [DEBUG] switch_ivr_bridge.c:563 BRIDGE THREAD
DONE [sofia/external/sipUserA]
2009-12-11 16:18:25.568413 [DEBUG] switch_ivr_bridge.c:565 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:25.568413 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:25.568413 [NOTICE] switch_ivr_bridge.c:617 Hangup
sofia/external/sipUserA [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2009-12-11 16:18:25.568413 [DEBUG] switch_channel.c:1912 Send signal
sofia/external/sipUserA [KILL]
2009-12-11 16:18:25.568413 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:25.568413 [DEBUG] switch_core_state_machine.c:488
(sofia/external/sipUserA) State HANGUP
2009-12-11 16:18:25.568413 [DEBUG] mod_sofia.c:358 Channel
sofia/external/sipUserA hanging up, cause: NORMAL_CLEARING
2009-12-11 16:18:25.568413 [DEBUG] mod_sofia.c:400 Sending BYE to
sofia/external/sipUserA
2009-12-11 16:18:25.568413 [DEBUG] switch_core_state_machine.c:46
sofia/external/sipUserA Standard HANGUP, cause: NORMAL_CLEARING
2009-12-11 16:18:25.568413 [DEBUG] switch_core_state_machine.c:488
(sofia/external/sipUserA) State HANGUP going to sleep
2009-12-11 16:18:25.568413 [DEBUG] switch_core_state_machine.c:351
(sofia/external/sipUserA) State EXCHANGE_MEDIA going to sleep
2009-12-11 16:18:25.568413 [DEBUG] switch_core_state_machine.c:314
(sofia/external/sipUserA) Running State Change CS_HANGUP
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:465
sofia/external/sipUserA handler already called, skipping state handler.
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:333
(sofia/external/sipUserA) State Change CS_HANGUP -> CS_REPORTING
2009-12-11 16:18:25.569414 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:314
(sofia/external/sipUserA) Running State Change CS_REPORTING
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:579
(sofia/external/sipUserA) State REPORTING
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:53
sofia/external/sipUserA Standard REPORTING, cause: NORMAL_CLEARING
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:579
(sofia/external/sipUserA) State REPORTING going to sleep
2009-12-11 16:18:25.569414 [DEBUG] switch_core_state_machine.c:327
(sofia/external/sipUserA) State Change CS_REPORTING -> CS_DESTROY
2009-12-11 16:18:25.569414 [DEBUG] switch_core_session.c:999 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:25.569414 [DEBUG] switch_core_session.c:1136 Session 2
(sofia/external/sipUserA) Locked, Waiting on external entities
2009-12-11 16:18:25.628397 [DEBUG] switch_ivr_bridge.c:520 DingaLing/new
receive message [UNBRIDGE]
2009-12-11 16:18:25.628397 [DEBUG] switch_core_session.c:645 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:25.628397 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:25.628397 [DEBUG] switch_ivr_bridge.c:563 BRIDGE THREAD
DONE [DingaLing/new]
2009-12-11 16:18:25.628397 [DEBUG] switch_ivr_bridge.c:565 Send signal
sofia/external/sipUserA [BREAK]
2009-12-11 16:18:25.628397 [NOTICE] switch_ivr_bridge.c:1179 Hangup
DingaLing/new [CS_EXECUTE] [NORMAL_CLEARING]
2009-12-11 16:18:25.628397 [DEBUG] switch_channel.c:1912 Send signal
DingaLing/new [KILL]
2009-12-11 16:18:25.628397 [DEBUG] libdingaling.c:298 Destroyed Session
596627090

2009-12-11 16:18:25.628397 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:25.628397 [DEBUG] switch_core_session.c:999 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:25.628397 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:25.628397 [DEBUG] switch_core_state_machine.c:488
(DingaLing/new) State HANGUP
2009-12-11 16:18:25.628397 [DEBUG] mod_dingaling.c:1293 DingaLing/new
CHANNEL HANGUP
2009-12-11 16:18:25.628397 [DEBUG] switch_core_state_machine.c:46
DingaLing/new Standard HANGUP, cause: NORMAL_CLEARING
2009-12-11 16:18:25.628397 [DEBUG] switch_core_state_machine.c:488
(DingaLing/new) State HANGUP going to sleep
2009-12-11 16:18:25.628397 [NOTICE] switch_core_session.c:1154 Session 2
(sofia/external/sipUserA) Ended
2009-12-11 16:18:25.628397 [NOTICE] switch_core_session.c:1156 Close Channel
sofia/external/sipUserA [CS_DESTROY]
2009-12-11 16:18:25.628397 [DEBUG] switch_core_state_machine.c:348
(DingaLing/new) State EXECUTE going to sleep
2009-12-11 16:18:25.628397 [DEBUG] switch_core_state_machine.c:423
(sofia/external/sipUserA) Running State Change CS_DESTROY
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:314
(DingaLing/new) Running State Change CS_HANGUP
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:434
(sofia/external/sipUserA) State DESTROY
2009-12-11 16:18:25.629398 [DEBUG] mod_sofia.c:293 sofia/external/sipUserA
SOFIA DESTROY
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:465
DingaLing/new handler already called, skipping state handler.
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:333
(DingaLing/new) State Change CS_HANGUP -> CS_REPORTING
2009-12-11 16:18:25.629398 [DEBUG] switch_core_session.c:999 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:25.629398 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:314
(DingaLing/new) Running State Change CS_REPORTING
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:60
sofia/external/sipUserA Standard DESTROY
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:579
(DingaLing/new) State REPORTING
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:434
(sofia/external/sipUserA) State DESTROY going to sleep
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:53
DingaLing/new Standard REPORTING, cause: NORMAL_CLEARING
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:579
(DingaLing/new) State REPORTING going to sleep
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:327
(DingaLing/new) State Change CS_REPORTING -> CS_DESTROY
2009-12-11 16:18:25.629398 [DEBUG] switch_core_session.c:999 Send signal
DingaLing/new [BREAK]
2009-12-11 16:18:25.629398 [DEBUG] mod_dingaling.c:1333 DingaLing/new
CHANNEL KILL
2009-12-11 16:18:25.629398 [DEBUG] switch_core_session.c:1136 Session 1
(DingaLing/new) Locked, Waiting on external entities
2009-12-11 16:18:25.629398 [NOTICE] switch_core_session.c:1154 Session 1
(DingaLing/new) Ended
2009-12-11 16:18:25.629398 [NOTICE] switch_core_session.c:1156 Close Channel
DingaLing/new [CS_DESTROY]
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:423
(DingaLing/new) Running State Change CS_DESTROY
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:434
(DingaLing/new) State DESTROY
2009-12-11 16:18:25.629398 [DEBUG] mod_dingaling.c:1231 NUKE RTP
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:60
DingaLing/new Standard DESTROY
2009-12-11 16:18:25.629398 [DEBUG] switch_core_state_machine.c:434
(DingaLing/new) State DESTROY going to sleep
2009-12-11 16:18:25.683383 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:25.683383 [DEBUG] libdingaling.c:1406 Sending packet 302 (2
left)

2009-12-11 16:18:25.683383 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq xmlns="jabber:client" from="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE"
to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" type="set" id="302">
  <ses:session xmlns:ses="http://www.google.com/session" type="terminate"
id="596627090" initiator="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB
"></ses:session>
</iq>

2009-12-11 16:18:25.783359 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:25.883332 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:25.983307 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.083280 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.183267 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.283231 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.383206 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.483181 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.583156 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.651139 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="302"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB"></iq>

2009-12-11 16:18:26.651139 [DEBUG] libdingaling.c:943 Cancel packet 302

2009-12-11 16:18:26.660136 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<iq to="GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" type="set" id="91"
from="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB">
  <session type="terminate" id="596627090" initiator="
GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" xmlns="
http://www.google.com/session"></session>
</iq>

2009-12-11 16:18:26.660136 [DEBUG] libdingaling.c:353 Created Session
596627090

2009-12-11 16:18:26.660136 [DEBUG] libdingaling.c:381 Message for Session
596627090

2009-12-11 16:18:26.660136 [DEBUG] mod_dingaling.c:2926 Session is already
dead
2009-12-11 16:18:26.683132 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<iq type="result" to="GTALK_ANY_CLIENT@gmail.com/Talk.v1054D5EA6CB" from="
GTALK_JINGLE_CLIENT@gmail.com/gtalk8FB831CE" id="91">
  <query></query>
</iq>

2009-12-11 16:18:26.683132 [DEBUG] libdingaling.c:1389 Processing 1 packets
in retry queue

2009-12-11 16:18:26.683132 [DEBUG] libdingaling.c:1414 Discarding packet 302

Regds.

[Freeswitch-users] gtalk dingaling G723

zendel fernandez