So the caller is dialing "030": mod_dialplan_xml.c:558 Processing 8117396389ip <8117396389ip>->030 in context public Is that by design? There's no destination_number in your dialplan that matches "030" so that's why the call doesn't go anywhere. -MC On Wed, Feb 11, 2015 at 10:03 AM, antony aguirre <djdevil8@gmail.com> wrote:
Hi,
This is the log that I've got when it's trying to make a call to the PSTN. I found that the section dialplan are not evaluating all extensions that exist in the database .
2015-02-11 11:36:27.018534 [DEBUG] switch_xml.c:1995 Cache Info Time Now: 1423676187018534 Expires: 1423676136458535 2015-02-11 11:36:27.018534 [DEBUG] switch_xml.c:1997 Cache expired for 8117396389ip@189.211.21.30, doing fresh lookup 2015-02-11 11:36:27.018534 [DEBUG] switch_xml.c:2073 caching lookup for user 8117396389ip@189.211.21.30 for 0 milliseconds 2015-02-11 11:36:38.658544 [DEBUG] switch_xml.c:1995 Cache Info Time Now: 1423676198658544 Expires: 1423676187018534 2015-02-11 11:36:38.658544 [DEBUG] switch_xml.c:1997 Cache expired for 8117396389ip@189.211.21.30, doing fresh lookup 2015-02-11 11:36:38.658544 [DEBUG] switch_xml.c:2073 caching lookup for user 8117396389ip@189.211.21.30 for 0 milliseconds 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [NOTICE] switch_channel.c:1049 New Channel sofia/internal/ 8117396389ip@189.211.21.30 [96143ce4-b214-11e4-ad21-91614133b1b9] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [DEBUG] switch_core_session.c:1016 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [DEBUG] switch_core_session.c:1016 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [DEBUG] switch_core_state_machine.c:418 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_NEW 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [DEBUG] sofia.c:7922 sofia/internal/8117396389ip@189.211.21.30 receiving invite from 189.211.235.196:48204 version: 1.2.24 git 5dfc7cf 2014-11-20 22:30:08Z 64bit 2015-02-11 11:37:01.478538 [DEBUG] sofia.c:8079 IP 189.211.235.196 Rejected by acl "domains". Falling back to Digest auth. 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [DEBUG] switch_core_state_machine.c:437 (sofia/internal/8117396389ip@189.211.21.30) State NEW 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.478538 [DEBUG] switch_core_session.c:1016 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 2015-02-11 11:37:01.478538 [DEBUG] sofia.c:1792 detaching session 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.518536 [DEBUG] sofia.c:1899 Re-attaching to session 96143ce4-b214-11e4-ad21-91614133b1b9 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.518536 [DEBUG] switch_core_session.c:1016 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.518536 [DEBUG] switch_core_session.c:1016 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.518536 [DEBUG] sofia.c:7922 sofia/internal/8117396389ip@189.211.21.30 receiving invite from 189.211.235.196:48204 version: 1.2.24 git 5dfc7cf 2014-11-20 22:30:08Z 64bit 2015-02-11 11:37:01.518536 [DEBUG] sofia.c:8079 IP 189.211.235.196 Rejected by acl "domains". Falling back to Digest auth. 2015-02-11 11:37:01.518536 [DEBUG] switch_xml.c:1995 Cache Info Time Now: 1423676221518536 Expires: 1423676198658544 2015-02-11 11:37:01.518536 [DEBUG] switch_xml.c:1997 Cache expired for 8117396389ip@189.211.21.30, doing fresh lookup 2015-02-11 11:37:01.538537 [DEBUG] switch_xml.c:2073 caching lookup for user 8117396389ip@189.211.21.30 for 0 milliseconds 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] sofia.c:5853 Channel sofia/internal/8117396389ip@189.211.21.30 entering state [received][100] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] sofia.c:5866 Remote SDP: 96143ce4-b214-11e4-ad21-91614133b1b9 v=0 96143ce4-b214-11e4-ad21-91614133b1b9 o=Z 0 0 IN IP4 192.168.15.93 96143ce4-b214-11e4-ad21-91614133b1b9 s=Z 96143ce4-b214-11e4-ad21-91614133b1b9 c=IN IP4 192.168.15.93 96143ce4-b214-11e4-ad21-91614133b1b9 t=0 0 96143ce4-b214-11e4-ad21-91614133b1b9 m=audio 47230 RTP/AVP 3 110 98 8 0 101 96143ce4-b214-11e4-ad21-91614133b1b9 a=rtpmap:110 speex/8000 96143ce4-b214-11e4-ad21-91614133b1b9 a=rtpmap:98 iLBC/8000 96143ce4-b214-11e4-ad21-91614133b1b9 a=fmtp:98 mode=20 96143ce4-b214-11e4-ad21-91614133b1b9 a=rtpmap:101 telephone-event/8000 96143ce4-b214-11e4-ad21-91614133b1b9 a=fmtp:101 0-15 96143ce4-b214-11e4-ad21-91614133b1b9 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] sofia.c:6099 (sofia/internal/8117396389ip@189.211.21.30) State Change CS_NEW -> CS_INIT 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:418 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_INIT 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:458 (sofia/internal/8117396389ip@189.211.21.30) State INIT 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:87 sofia/internal/8117396389ip@189.211.21.30 SOFIA INIT 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:127 (sofia/internal/8117396389ip@189.211.21.30) State Change CS_INIT -> CS_ROUTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:458 (sofia/internal/8117396389ip@189.211.21.30) State INIT going to sleep 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:418 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_ROUTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_channel.c:2165 (sofia/internal/8117396389ip@189.211.21.30) Callstate Change DOWN -> RINGING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:474 (sofia/internal/8117396389ip@189.211.21.30) State ROUTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:150 sofia/internal/8117396389ip@189.211.21.30 SOFIA ROUTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:117 sofia/internal/8117396389ip@189.211.21.30 Standard ROUTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [INFO] mod_dialplan_xml.c:558 Processing 8117396389ip <8117396389ip>->030 in context public 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 parsing [public->unloop] continue=false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 parsing [public->outside_call] continue=true 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Absolute Condition [outside_call] 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Action set(outside_call=true) 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 parsing [public->call_debug] continue=true 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 parsing [public->public_extensions] continue=false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Regex (FAIL) [public_extensions] destination_number(030) =~ /^(10[01][0-9])$/ break=on-false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 parsing [public->public_did] continue=false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Regex (FAIL) [public_did] destination_number(030) =~ /^(5551212)$/ break=on-false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 parsing [public->Default_Inbound] continue=false 96143ce4-b214-11e4-ad21-91614133b1b9 Dialplan: sofia/internal/ 8117396389ip@189.211.21.30 Regex (FAIL) [Default_Inbound] destination_number(030) =~ /^(\d{10})+ip$/ break=on-false 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/8117396389ip@189.211.21.30) State Change CS_ROUTING -> CS_EXECUTE 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:474 (sofia/internal/8117396389ip@189.211.21.30) State ROUTING going to sleep 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:418 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_EXECUTE 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:481 (sofia/internal/8117396389ip@189.211.21.30) State EXECUTE 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:243 sofia/internal/8117396389ip@189.211.21.30 SOFIA EXECUTE 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:209 sofia/internal/8117396389ip@189.211.21.30 Standard EXECUTE 96143ce4-b214-11e4-ad21-91614133b1b9 EXECUTE sofia/internal/ 8117396389ip@189.211.21.30 set(outside_call=true) 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_dptools.c:1402 sofia/internal/8117396389ip@189.211.21.30 SET [outside_call]=[true] 96143ce4-b214-11e4-ad21-91614133b1b9 EXECUTE sofia/internal/ 8117396389ip@189.211.21.30 export(RFC2822_DATE=Wed, 11 Feb 2015 11:37:01 -0600) 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_channel.c:1241 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 11 Feb 2015 11:37:01 -0600] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [NOTICE] switch_core_state_machine.c:262 sofia/internal/8117396389ip@189.211.21.30 has executed the last dialplan instruction, hanging up. 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [NOTICE] switch_core_state_machine.c:264 Hangup sofia/internal/ 8117396389ip@189.211.21.30 [CS_EXECUTE] [NORMAL_CLEARING] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_channel.c:3189 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [KILL] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:481 (sofia/internal/8117396389ip@189.211.21.30) State EXECUTE going to sleep 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:418 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_HANGUP 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:681 (sofia/internal/8117396389ip@189.211.21.30) Callstate Change RINGING -> HANGUP 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:683 (sofia/internal/8117396389ip@189.211.21.30) State HANGUP 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:506 Channel sofia/internal/8117396389ip@189.211.21.30 hanging up, cause: NORMAL_CLEARING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:640 Responding to INVITE with: 480 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:48 sofia/internal/8117396389ip@189.211.21.30 Standard HANGUP, cause: NORMAL_CLEARING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:683 (sofia/internal/8117396389ip@189.211.21.30) State HANGUP going to sleep 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:450 (sofia/internal/8117396389ip@189.211.21.30) State Change CS_HANGUP -> CS_REPORTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:418 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_REPORTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:767 (sofia/internal/8117396389ip@189.211.21.30) State REPORTING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:92 sofia/internal/8117396389ip@189.211.21.30 Standard REPORTING, cause: NORMAL_CLEARING 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:767 (sofia/internal/8117396389ip@189.211.21.30) State REPORTING going to sleep 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:444 (sofia/internal/8117396389ip@189.211.21.30) State Change CS_REPORTING -> CS_DESTROY 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1351 Send signal sofia/internal/ 8117396389ip@189.211.21.30 [BREAK] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_session.c:1559 Session 8 (sofia/internal/ 8117396389ip@189.211.21.30) Locked, Waiting on external entities 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [NOTICE] switch_core_session.c:1577 Session 8 (sofia/internal/ 8117396389ip@189.211.21.30) Ended 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [NOTICE] switch_core_session.c:1581 Close Channel sofia/internal/ 8117396389ip@189.211.21.30 [CS_DESTROY] 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:572 (sofia/internal/8117396389ip@189.211.21.30) Running State Change CS_DESTROY 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:582 (sofia/internal/8117396389ip@189.211.21.30) State DESTROY 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] mod_sofia.c:399 sofia/internal/8117396389ip@189.211.21.30 SOFIA DESTROY 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:99 sofia/internal/8117396389ip@189.211.21.30 Standard DESTROY 96143ce4-b214-11e4-ad21-91614133b1b9 2015-02-11 11:37:01.538537 [DEBUG] switch_core_state_machine.c:582 (sofia/internal/8117396389ip@189.211.21.30) State DESTROY going to sleep
2015-02-10 15:22 GMT-06:00 Brian West <brian@freeswitch.org>:
Sounds like you might need to do some escaping in there... what does the freeswitch debug log say?
On Tue, Feb 10, 2015 at 12:09 PM, Ing. Antonyam <ing.antonyam@gmail.com> wrote:
Hi,
I have an issue in xml_curl module. If the user tries calling to PSTN, the call is not routed and the code generates an error similar when the calling plan is not set for PSTN extensions. I've set the plan in the database with "/d" but it doesn't work. If I use a static way inside the xml files works fine.
My calling plan is working when it calls among extensions.
I've validated that sofia status is setting with calling plan for PSTN.
actions = sofia/gateway/${effective_caller_id_numer}/$1
Do you have any idea why it's not working when I configure it in the database?
Regards.
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
Official FreeSWITCH Sites http://www.freeswitch.org http://confluence.freeswitch.org http://www.cluecon.com
FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
--
*Brian West* brian@freeswitch.org
*Twitter: @FreeSWITCH , @briankwest* http://www.freeswitchbook.com http://www.freeswitchcookbook.com
*T:*+19184209001 | *F:*+19184209002 | *M:*+1918424WEST (9378) *iNUM:*+883 5100 1420 9001 | *ISN:*410*543 | *Skype:*briankwest
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
Official FreeSWITCH Sites http://www.freeswitch.org http://confluence.freeswitch.org http://www.cluecon.com
FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
Official FreeSWITCH Sites http://www.freeswitch.org http://confluence.freeswitch.org http://www.cluecon.com
FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org