[Freeswitch-users] Problem configuring OpenBTS2.8 with Freeswitch 1.0.6

Thu Mar 28 18:11:53 MSK 2013

Your log shows that you're entering the dialplan with destination number
2222. However there are no extensions that match this number. You need to
create a dialplan extension match this number and bridge the call to the
registered user.

Your log shows that you're using the default configuration. This is only
intended as an example. I recommend you replace or modify it to only do
what you need.

FreeSWITCH 1.0.6 is also a very old unsupported release that contains known
problems. I suggest you upgrade to either 1.2.7 or Git master.

-Steve

On 28 March 2013 14:19, Syed Ibrahim Ghaznavi <ibrahimghaznavi at gmail.com>wrote:

> Hi,
> I have configured OpenBTS with Freeswitch and registered 2 users using
> VBTS_New_User found here:
> http://wush.net/trac/rangepublic/wiki/freeswitchConfig
>
> I can see the 2 tuples in the sqlite3.db, however when i attempt to make a
> call between the 2 registered users, the log on Freeswitch is as follows:
>
> 2013-03-27 21:18:07.495839 [NOTICE] switch_channel.c:976 New Channel
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [e9051208-96f9-11e2-8f70-
> 5979f626837d]
> 2013-03-27 21:18:07.495839 [DEBUG] switch_core_session.c:975 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.495839 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change CS_NEW
> 2013-03-27 21:18:07.495839 [DEBUG] switch_core_session.c:975 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.495839 [DEBUG] switch_core_state_machine.c:433
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State NEW
> 2013-03-27 21:18:07.515818 [DEBUG] sofia.c:7697 IP 127.0.0.1 Approved by
> acl "domains[]". Access Granted.
> 2013-03-27 21:18:07.515818 [DEBUG] sofia.c:5597 Channel sofia/internal/
> IMSI410071190004419 at 127.0.0.1 entering state [received][100]
> 2013-03-27 21:18:07.515818 [DEBUG] sofia.c:5608 Remote SDP:
> v=0
> o=IMSI410071190004419 0 0 IN IP4 127.0.0.1
> s=Talk Time
> t=0 0
> m=audio 16502 RTP/AVP 3
> c=IN IP4 127.0.0.1
> a=rtpmap:3 GSM/8000
>
> 2013-03-27 21:18:07.515818 [DEBUG] sofia.c:5821 (sofia/internal/
> IMSI410071190004419 at 127.0.0.1) State Change CS_NEW -> CS_INIT
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change
> CS_INIT
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:454
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State INIT
> 2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:86 sofia/internal/
> IMSI410071190004419 at 127.0.0.1 SOFIA INIT
> 2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:126 (sofia/internal/
> IMSI410071190004419 at 127.0.0.1) State Change CS_INIT -> CS_ROUTING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:454
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State INIT going to sleep
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change
> CS_ROUTING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:2012 (sofia/internal/
> IMSI410071190004419 at 127.0.0.1) Callstate Change DOWN -> RINGING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:470
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State ROUTING
> 2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:149 sofia/internal/
> IMSI410071190004419 at 127.0.0.1 SOFIA ROUTING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:117
> sofia/internal/IMSI410071190004419 at 127.0.0.1 Standard ROUTING
> 2013-03-27 21:18:07.515818 [INFO] mod_dialplan_xml.c:557 Processing
> IMSI410071190004419 <IMSI410071190004419>->2222 in context public
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 parsing
> [public->unloop] continue=false
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Regex (PASS)
> [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Regex (FAIL)
> [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 parsing
> [public->outside_call] continue=true
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Absolute Condition
> [outside_call]
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Action
> set(outside_call=true)
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Action
> export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 parsing
> [public->call_debug] continue=true
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Regex (FAIL)
> [call_debug] ${call_debug}(false) =~ /^true$/ break=never
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 parsing
> [public->public_extensions] continue=false
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Regex (FAIL)
> [public_extensions] destination_number(2222) =~ /^(10[01][0-9])$/
> break=on-false
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 parsing
> [public->public_did] continue=false
> Dialplan: sofia/internal/IMSI410071190004419 at 127.0.0.1 Regex (FAIL)
> [public_did] destination_number(2222) =~ /^(5551212)$/ break=on-false
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:167
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State Change CS_ROUTING ->
> CS_EXECUTE
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:470
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State ROUTING going to
> sleep
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change
> CS_EXECUTE
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:477
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State EXECUTE
> 2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:242 sofia/internal/
> IMSI410071190004419 at 127.0.0.1 SOFIA EXECUTE
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:209
> sofia/internal/IMSI410071190004419 at 127.0.0.1 Standard EXECUTE
> EXECUTE sofia/internal/IMSI410071190004419 at 127.0.0.1set(outside_call=true)
> 2013-03-27 21:18:07.515818 [DEBUG] mod_dptools.c:1367 sofia/internal/
> IMSI410071190004419 at 127.0.0.1 SET [outside_call]=[true]
> EXECUTE sofia/internal/IMSI410071190004419 at 127.0.0.1export(RFC2822_DATE=Wed, 27 Mar 2013 21:18:07 +0500)
> 2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:1143 EXPORT
> (export_vars) [RFC2822_DATE]=[Wed, 27 Mar 2013 21:18:07 +0500]
> 2013-03-27 21:18:07.515818 [NOTICE] switch_core_state_machine.c:262
> sofia/internal/IMSI410071190004419 at 127.0.0.1 has executed the last
> dialplan instruction, hanging up.
> 2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:3011 (sofia/internal/
> IMSI410071190004419 at 127.0.0.1) Callstate Change RINGING -> HANGUP
> 2013-03-27 21:18:07.515818 [NOTICE] switch_core_state_machine.c:264 Hangup
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [CS_EXECUTE]
> [NORMAL_CLEARING]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:3034 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [KILL]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:477
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State EXECUTE going to
> sleep
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change
> CS_HANGUP
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:676
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State HANGUP
> 2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:503 Channel sofia/internal/
> IMSI410071190004419 at 127.0.0.1 hanging up, cause: NORMAL_CLEARING
> 2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:633 Responding to INVITE
> with: 480
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:48
> sofia/internal/IMSI410071190004419 at 127.0.0.1 Standard HANGUP, cause:
> NORMAL_CLEARING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:676
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State HANGUP going to sleep
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:446
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State Change CS_HANGUP ->
> CS_REPORTING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change
> CS_REPORTING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:758
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State REPORTING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:92
> sofia/internal/IMSI410071190004419 at 127.0.0.1 Standard REPORTING, cause:
> NORMAL_CLEARING
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:758
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State REPORTING going to
> sleep
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:440
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State Change CS_REPORTING
> -> CS_DESTROY
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal
> sofia/internal/IMSI410071190004419 at 127.0.0.1 [BREAK]
> 2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1518 Session 44
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Locked, Waiting on
> external entities
> 2013-03-27 21:18:07.515818 [NOTICE] switch_core_session.c:1536 Session 44
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Ended
> 2013-03-27 21:18:07.515818 [NOTICE] switch_core_session.c:1540 Close
> Channel sofia/internal/IMSI410071190004419 at 127.0.0.1 [CS_DESTROY]
> 2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:565
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Callstate Change HANGUP ->
> DOWN
> 2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:568
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) Running State Change
> CS_DESTROY
> 2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:578
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State DESTROY
> 2013-03-27 21:18:07.525838 [DEBUG] mod_sofia.c:396 sofia/internal/
> IMSI410071190004419 at 127.0.0.1 SOFIA DESTROY
> 2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:99
> sofia/internal/IMSI410071190004419 at 127.0.0.1 Standard DESTROY
> 2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:578
> (sofia/internal/IMSI410071190004419 at 127.0.0.1) State DESTROY going to
> sleep
>
> Gratitude,
> Ibrahim
>
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services:
> consulting at freeswitch.org
> http://www.freeswitchsolutions.com
>
> 
> 
>
> Official FreeSWITCH Sites
> http://www.freeswitch.org
> http://wiki.freeswitch.org
> http://www.cluecon.com
>
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20130328/1908ea6d/attachment-0001.html 