Hi, <br>I have configured OpenBTS with Freeswitch and registered 2 users using VBTS_New_User found here:<br><a href="http://wush.net/trac/rangepublic/wiki/freeswitchConfig">http://wush.net/trac/rangepublic/wiki/freeswitchConfig</a><br>
<br>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:<br><br>2013-03-27 21:18:07.495839 [NOTICE] switch_channel.c:976 New Channel sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [e9051208-96f9-11e2-8f70-<div>
5979f626837d]<br>2013-03-27 21:18:07.495839 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>
2013-03-27 21:18:07.495839 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_NEW<br>2013-03-27 21:18:07.495839 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>
2013-03-27 21:18:07.495839 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State NEW<br>2013-03-27 21:18:07.515818 [DEBUG] sofia.c:7697 IP 127.0.0.1 Approved by acl "domains[]". Access Granted.<br>
2013-03-27 21:18:07.515818 [DEBUG] sofia.c:5597 Channel sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> entering state [received][100]<br>2013-03-27 21:18:07.515818 [DEBUG] sofia.c:5608 Remote SDP:<br>
v=0<br>o=IMSI410071190004419 0 0 IN IP4 127.0.0.1<br>s=Talk Time<br>t=0 0<br>m=audio 16502 RTP/AVP 3<br>c=IN IP4 127.0.0.1<br>a=rtpmap:3 GSM/8000<br><br>2013-03-27 21:18:07.515818 [DEBUG] sofia.c:5821 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State Change CS_NEW -> CS_INIT<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_INIT<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State INIT<br>2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:86 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> SOFIA INIT<br>
2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:126 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State Change CS_INIT -> CS_ROUTING<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State INIT going to sleep<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_ROUTING<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:2012 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Callstate Change DOWN -> RINGING<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State ROUTING<br>
2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:149 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> SOFIA ROUTING<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:117 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Standard ROUTING<br>
2013-03-27 21:18:07.515818 [INFO] mod_dialplan_xml.c:557 Processing
IMSI410071190004419 <IMSI410071190004419>->2222 in context
public<br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> parsing [public->unloop] continue=false<br>
Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false<br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false<br>
Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> parsing [public->outside_call] continue=true<br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Absolute Condition [outside_call]<br>
Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Action set(outside_call=true) <br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) <br>
Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> parsing [public->call_debug] continue=true<br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never<br>
Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> parsing [public->public_extensions] continue=false<br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Regex (FAIL) [public_extensions] destination_number(2222) =~ /^(10[01][0-9])$/ break=on-false<br>
Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> parsing [public->public_did] continue=false<br>Dialplan: sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Regex (FAIL) [public_did] destination_number(2222) =~ /^(5551212)$/ break=on-false<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State Change CS_ROUTING -> CS_EXECUTE<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State ROUTING going to sleep<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_EXECUTE<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State EXECUTE<br>2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:242 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> SOFIA EXECUTE<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:209 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Standard EXECUTE<br>EXECUTE sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> set(outside_call=true)<br>
2013-03-27 21:18:07.515818 [DEBUG] mod_dptools.c:1367 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> SET [outside_call]=[true]<br>EXECUTE sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> export(RFC2822_DATE=Wed, 27 Mar 2013 21:18:07 +0500)<br>
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]<br>2013-03-27 21:18:07.515818 [NOTICE] switch_core_state_machine.c:262 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> has executed the last dialplan instruction, hanging up.<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:3011 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Callstate Change RINGING -> HANGUP<br>2013-03-27 21:18:07.515818 [NOTICE] switch_core_state_machine.c:264 Hangup sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [CS_EXECUTE] [NORMAL_CLEARING]<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [KILL]<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State EXECUTE going to sleep<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_HANGUP<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State HANGUP<br>2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:503 Channel sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> hanging up, cause: NORMAL_CLEARING<br>
2013-03-27 21:18:07.515818 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 480<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:48 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Standard HANGUP, cause: NORMAL_CLEARING<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State HANGUP going to sleep<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State Change CS_HANGUP -> CS_REPORTING<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_REPORTING<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State REPORTING<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:92 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Standard REPORTING, cause: NORMAL_CLEARING<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State REPORTING going to sleep<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State Change CS_REPORTING -> CS_DESTROY<br>
2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [BREAK]<br>2013-03-27 21:18:07.515818 [DEBUG] switch_core_session.c:1518 Session 44 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Locked, Waiting on external entities<br>
2013-03-27 21:18:07.515818 [NOTICE] switch_core_session.c:1536 Session 44 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Ended<br>2013-03-27 21:18:07.515818 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> [CS_DESTROY]<br>
2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Callstate Change HANGUP -> DOWN<br>2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) Running State Change CS_DESTROY<br>
2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State DESTROY<br>2013-03-27 21:18:07.525838 [DEBUG] mod_sofia.c:396 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> SOFIA DESTROY<br>
2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:99 sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a> Standard DESTROY<br>2013-03-27 21:18:07.525838 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/<a href="mailto:IMSI410071190004419@127.0.0.1" target="_blank">IMSI410071190004419@127.0.0.1</a>) State DESTROY going to sleep</div>
<br>Gratitude,<br>Ibrahim<br>