[Freeswitch-users] Question about mod_dingaling.

Fri Feb 11 08:29:11 MSK 2011

Good everyone,I use Freeswitch 1.0.6 with mod_dingaling.Now i call out from
mod_dingaling use google voice,this cann't call succeed.

This is cli log:

freeswitch at internal> 2011-02-11 13:27:39.558796 [DEBUG] sofia.c:5847 IP
121.28.15.8 Rejected by acl "domains". Falling back to Digest auth.
2011-02-11 13:27:39.834785 [DEBUG] sofia.c:5847 IP 121.28.15.8 Rejected by
acl "domains". Falling back to Digest auth.
2011-02-11 13:27:39.838761 [NOTICE] switch_channel.c:669 New Channel
sofia/internal/1000 at 184.105.153.247 [1df65ab4-0d7e-48e5-8c75-547ab51d73d7]
2011-02-11 13:27:39.838761 [DEBUG] switch_core_state_machine.c:314 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_NEW
2011-02-11 13:27:39.838761 [DEBUG] switch_core_state_machine.c:320 (
sofia/internal/1000 at 184.105.153.247) State NEW
2011-02-11 13:27:39.850754 [DEBUG] sofia.c:4153 Channel
sofia/internal/1000 at 184.105.153.247 entering state [received][100]
2011-02-11 13:27:39.850754 [DEBUG] sofia.c:4164 Remote SDP:
v=0
o=- 7 2 IN IP4 61.235.150.11
s=CounterPath eyeBeam 1.5
c=IN IP4 61.235.150.11
t=0 0
m=audio 13410 RTP/AVP 0 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=alt:1 3 : xpehuJM9 ZEXWjImz 192.168.52.1 13410
a=alt:2 2 : 9AzLyh+Z Xgci2e96 192.168.153.1 13410
a=alt:3 1 : U0bonQcp 1CQ61b/S 61.235.150.11 13410
a=x-rtp-session-id:2BC4463425494741B4A9DA4DFD436DDF
2011-02-11 13:27:39.850754 [DEBUG] sofia_glue.c:3585 Audio Codec Compare
[PCMU:0:8000:20]/[G7221:115:32000:20]
2011-02-11 13:27:39.850754 [DEBUG] sofia_glue.c:3585 Audio Codec Compare
[PCMU:0:8000:20]/[G7221:107:16000:20]
2011-02-11 13:27:39.850754 [DEBUG] sofia_glue.c:3585 Audio Codec Compare
[PCMU:0:8000:20]/[G722:9:8000:20]
2011-02-11 13:27:39.850754 [DEBUG] sofia_glue.c:3585 Audio Codec Compare
[PCMU:0:8000:20]/[PCMU:0:8000:20]
2011-02-11 13:27:39.850754 [DEBUG] sofia_glue.c:2354 Set Codec
sofia/internal/1000 at 184.105.153.247 PCMU/8000 20 ms 160 samples
2011-02-11 13:27:39.850754 [DEBUG] sofia_glue.c:3524 Set 2833 dtmf send/recv
payload to 101
2011-02-11 13:27:39.850754 [DEBUG] sofia.c:4310 (
sofia/internal/1000 at 184.105.153.247) State Change CS_NEW -> CS_INIT
2011-02-11 13:27:39.850754 [DEBUG] switch_core_session.c:1021 Send signal
sofia/internal/1000 at 184.105.153.247 [BREAK]
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:314 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_INIT
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:338 (
sofia/internal/1000 at 184.105.153.247) State INIT
2011-02-11 13:27:39.854744 [DEBUG] mod_sofia.c:83
sofia/internal/1000 at 184.105.153.247 SOFIA INIT
2011-02-11 13:27:39.854744 [DEBUG] mod_sofia.c:117 (
sofia/internal/1000 at 184.105.153.247) State Change CS_INIT -> CS_ROUTING
2011-02-11 13:27:39.854744 [DEBUG] switch_core_session.c:1021 Send signal
sofia/internal/1000 at 184.105.153.247 [BREAK]
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:338 (
sofia/internal/1000 at 184.105.153.247) State INIT going to sleep
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:314 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_ROUTING
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:341 (
sofia/internal/1000 at 184.105.153.247) State ROUTING
2011-02-11 13:27:39.854744 [DEBUG] mod_sofia.c:140
sofia/internal/1000 at 184.105.153.247 SOFIA ROUTING
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:77
sofia/internal/1000 at 184.105.153.247 Standard ROUTING
2011-02-11 13:27:39.854744 [INFO] mod_dialplan_xml.c:418 Processing
1000->5018009993355 in context default
Dialplan: sofia/internal/1000 at 184.105.153.247 parsing [default->gvoice_out]
continue=false
Dialplan: sofia/internal/1000 at 184.105.153.247 Regex (PASS) [gvoice_out]
destination_number(5018009993355) =~ /^50(1\d{10})$/ break=on-false
Dialplan: sofia/internal/1000 at 184.105.153.247 Action
set(hangup_after_bridge=true)
Dialplan: sofia/internal/1000 at 184.105.153.247 Action bridge(
dingaling/gv1/+18009993355 at voice.google.com)
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:119 (
sofia/internal/1000 at 184.105.153.247) State Change CS_ROUTING -> CS_EXECUTE
2011-02-11 13:27:39.854744 [DEBUG] switch_core_session.c:1021 Send signal
sofia/internal/1000 at 184.105.153.247 [BREAK]
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:341 (
sofia/internal/1000 at 184.105.153.247) State ROUTING going to sleep
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:314 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_EXECUTE
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:348 (
sofia/internal/1000 at 184.105.153.247) State EXECUTE
2011-02-11 13:27:39.854744 [DEBUG] mod_sofia.c:226
sofia/internal/1000 at 184.105.153.247 SOFIA EXECUTE
2011-02-11 13:27:39.854744 [DEBUG] switch_core_state_machine.c:157
sofia/internal/1000 at 184.105.153.247 Standard EXECUTE
EXECUTE sofia/internal/1000 at 184.105.153.247 set(hangup_after_bridge=true)
2011-02-11 13:27:39.854744 [DEBUG] mod_dptools.c:816
sofia/internal/1000 at 184.105.153.247 SET [hangup_after_bridge]=[true]
EXECUTE sofia/internal/1000 at 184.105.153.247 bridge(
dingaling/gv1/+18009993355 at voice.google.com)
2011-02-11 13:27:39.894782 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence type="subscribe" to="+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE">
  <status>Call Me!</status>
</presence>
2011-02-11 13:27:39.894782 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence xmlns="jabber:client" type="probe" to="
+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE"></presence>
2011-02-11 13:27:40.050810 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<presence type="error" to="husodesar at gmail.com/gtalkAC94A6BE" from="
+18009993355 at voice.google.com">
  <error code="501" type="cancel">
    <feature-not-implemented
xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></feature-not-implemented>
  </error>
</presence>
2011-02-11 13:27:44.595029 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence type="subscribe" to="+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE">
  <status>Call Me!</status>
</presence>
2011-02-11 13:27:44.595029 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence xmlns="jabber:client" type="probe" to="
+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE"></presence>
2011-02-11 13:27:44.751042 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<presence type="error" to="husodesar at gmail.com/gtalkAC94A6BE" from="
+18009993355 at voice.google.com">
  <error code="501" type="cancel">
    <feature-not-implemented
xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></feature-not-implemented>
  </error>
</presence>
2011-02-11 13:27:49.595349 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence type="subscribe" to="+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE">
  <status>Call Me!</status>
</presence>
2011-02-11 13:27:49.595349 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence xmlns="jabber:client" type="probe" to="
+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE"></presence>
2011-02-11 13:27:49.751408 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<presence type="error" to="husodesar at gmail.com/gtalkAC94A6BE" from="
+18009993355 at voice.google.com">
  <error code="501" type="cancel">
    <feature-not-implemented
xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></feature-not-implemented>
  </error>
</presence>
2011-02-11 13:27:54.595667 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence type="subscribe" to="+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE">
  <status>Call Me!</status>
</presence>
2011-02-11 13:27:54.595667 [NOTICE] libdingaling.c:1307 SecSEND:
-------------------------------------------------------------------------------
<presence xmlns="jabber:client" type="probe" to="
+18009993355 at voice.google.com" from="
husodesar at gmail.com/gtalkAC94A6BE"></presence>
2011-02-11 13:27:54.751666 [INFO] libdingaling.c:1305 SecRECV:
-------------------------------------------------------------------------------
<presence type="error" to="husodesar at gmail.com/gtalkAC94A6BE" from="
+18009993355 at voice.google.com">
  <error code="501" type="cancel">
    <feature-not-implemented
xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"></feature-not-implemented>
  </error>
</presence>
2011-02-11 13:27:56.495776 [DEBUG] mod_dingaling.c:1715 Unknown Recipient!
2011-02-11 13:27:56.495776 [DEBUG] mod_dingaling.c:704 Terminate called from
line 1716 state=CS_NEW
2011-02-11 13:27:56.495776 [NOTICE] mod_dingaling.c:715 Close Channel N/A
[CS_NEW]
2011-02-11 13:27:56.495776 [DEBUG] switch_core_state_machine.c:428 ()
Running State Change CS_DESTROY
2011-02-11 13:27:56.495776 [DEBUG] switch_core_state_machine.c:439 (N/A)
State DESTROY
2011-02-11 13:27:56.495776 [DEBUG] switch_core_state_machine.c:439 (N/A)
State DESTROY going to sleep
2011-02-11 13:27:56.495776 [ERR] switch_ivr_originate.c:2430 Cannot create
outgoing channel of type [dingaling] cause: [NO_USER_RESPONSE]
2011-02-11 13:27:56.495776 [DEBUG] switch_ivr_originate.c:3228 Originate
Resulted in Error Cause: 18 [NO_USER_RESPONSE]
2011-02-11 13:27:56.495776 [INFO] mod_dptools.c:2355 Originate Failed.
Cause: NO_USER_RESPONSE
2011-02-11 13:27:56.495776 [NOTICE] switch_core_state_machine.c:185
sofia/internal/1000 at 184.105.153.247 has executed the last dialplan
instruction, hanging up.
2011-02-11 13:27:56.495776 [NOTICE] switch_core_state_machine.c:187 Hangup
sofia/internal/1000 at 184.105.153.247 [CS_EXECUTE] [NORMAL_CLEARING]
2011-02-11 13:27:56.495776 [DEBUG] switch_channel.c:2102 Send signal
sofia/internal/1000 at 184.105.153.247 [KILL]
2011-02-11 13:27:56.495776 [DEBUG] switch_core_session.c:1021 Send signal
sofia/internal/1000 at 184.105.153.247 [BREAK]
2011-02-11 13:27:56.495776 [DEBUG] switch_core_state_machine.c:348 (
sofia/internal/1000 at 184.105.153.247) State EXECUTE going to sleep
2011-02-11 13:27:56.495776 [DEBUG] switch_core_state_machine.c:314 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_HANGUP
2011-02-11 13:27:56.495776 [DEBUG] switch_core_state_machine.c:499 (
sofia/internal/1000 at 184.105.153.247) State HANGUP
2011-02-11 13:27:56.495776 [DEBUG] mod_sofia.c:414 Channel
sofia/internal/1000 at 184.105.153.247 hanging up, cause: NORMAL_CLEARING
2011-02-11 13:27:56.511787 [DEBUG] mod_sofia.c:476 Responding to INVITE
with: 480
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:46
sofia/internal/1000 at 184.105.153.247 Standard HANGUP, cause: NORMAL_CLEARING
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:499 (
sofia/internal/1000 at 184.105.153.247) State HANGUP going to sleep
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:333 (
sofia/internal/1000 at 184.105.153.247) State Change CS_HANGUP -> CS_REPORTING
2011-02-11 13:27:56.511787 [DEBUG] switch_core_session.c:1021 Send signal
sofia/internal/1000 at 184.105.153.247 [BREAK]
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:314 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_REPORTING
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:590 (
sofia/internal/1000 at 184.105.153.247) State REPORTING
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:53
sofia/internal/1000 at 184.105.153.247 Standard REPORTING, cause:
NORMAL_CLEARING
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:590 (
sofia/internal/1000 at 184.105.153.247) State REPORTING going to sleep
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:327 (
sofia/internal/1000 at 184.105.153.247) State Change CS_REPORTING -> CS_DESTROY
2011-02-11 13:27:56.511787 [DEBUG] switch_core_session.c:1021 Send signal
sofia/internal/1000 at 184.105.153.247 [BREAK]
2011-02-11 13:27:56.511787 [DEBUG] switch_core_session.c:1164 Session 12 (
sofia/internal/1000 at 184.105.153.247) Locked, Waiting on external entities
2011-02-11 13:27:56.511787 [NOTICE] switch_core_session.c:1182 Session 12 (
sofia/internal/1000 at 184.105.153.247) Ended
2011-02-11 13:27:56.511787 [NOTICE] switch_core_session.c:1184 Close Channel
sofia/internal/1000 at 184.105.153.247 [CS_DESTROY]
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:428 (
sofia/internal/1000 at 184.105.153.247) Running State Change CS_DESTROY
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:439 (
sofia/internal/1000 at 184.105.153.247) State DESTROY
2011-02-11 13:27:56.511787 [DEBUG] mod_sofia.c:341
sofia/internal/1000 at 184.105.153.247 SOFIA DESTROY
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:60
sofia/internal/1000 at 184.105.153.247 Standard DESTROY
2011-02-11 13:27:56.511787 [DEBUG] switch_core_state_machine.c:439 (
sofia/internal/1000 at 184.105.153.247) State DESTROY going to sleep

What's wrong with this?

Please help me, Thanks.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20110211/3ef47ed3/attachment-0001.html 