(bluebox) multitenant_routing_context not found

295 views
Skip to first unread message

Michael Mol

unread,
May 15, 2013, 2:17:08 PM5/15/13
to 2600hz...@googlegroups.com
I must be doing something insanely stupid.

I'm trying to use Bluebox git HEAD with Freeswitch GIT head. However,
whenever I try dialing any number from any device, I get this sequence
in my logs. (Pardon the example.com obfuscation)

2013-05-15 12:49:20.053269 [INFO] mod_dialplan_xml.c:558 Processing
Michael Mol <HRpy7SdJ8W>->3001 in context multitenant_routing_context
2013-05-15 12:49:20.053269 [WARNING] mod_dialplan_xml.c:588 Context
multitenant_routing_context not found
2013-05-15 12:49:20.053269 [INFO] switch_core_state_machine.c:192 No
Route, Aborting
2013-05-15 12:49:20.053269 [NOTICE] switch_core_state_machine.c:193
Hangup sofia/sipinterface_1/HRpy7...@sip.example.com [CS_ROUTING]
[NO_ROUTE_DESTINATION]

I did not install the sample data during the Bluebox installation.

I've defined an "In-house only" context that all of the devices are
assigned to. I have no idea where the 'multitenant_routing_context' is
coming from, or why it isn't appearing anywhere in my bluebox
configuration UI.

I see its presence in /var/www/html/buebox/modules/freeswitch-1.1.1:

# find . -type f -print0|xargs -0 grep multitenant_routing
./config/freeswitch.php: 'query' =>
'//document/section[@name="routes"]/context[@name="multitenant_routing_context"]'
./config/freeswitch.php.dist: 'query' =>
'//document/section[@name="routes"]/context[@name="multitenant_routing_context"]'
./libraries/FreeSwitch.php: const AUTO_ROUTE_CONTEXT =
'multitenant_routing_context';
./libraries/FreeSwitch.php: 'number_route' =>
'//document/section[@name="routes"]/context[@name="multitenant_routing_context"]/extension[@name="route_number_%s"][@continue="true"]',

But I don't know the significance of these configuration lines and
whether or not I should modify them.

What am I doing wrong? (And if I'm not providing enough
information...what's needed?)



signature.asc

Michael Mol

unread,
May 15, 2013, 3:11:21 PM5/15/13
to 2600hz...@googlegroups.com
After further googling, I found that it relates to whether or not I have
the numbers in question set as type "Internal" or "External". Setting
them both to "External" allowed me to dial one from the other.

Where is there good documentation on what "Internal" vs "External" means?

From Number Manager, I find "Type - here you can select if this is a
Internal (local extension) number or External (public) number."

In the same area, I find "If you want the same functionality in multiple
contexts your number must be of type 'Internal' and you'll be able to
select more than one context."

But that's about it. What are the specifics of 'Internal' vs 'External',
and why would I have to set the numbers to 'External' in order to dial
one from the other? This doesn't make any sense to me.


signature.asc

Darren Schreiber

unread,
May 15, 2013, 4:16:55 PM5/15/13
to 2600hz...@googlegroups.com
So the original concept was that it was supposed to be a helper for
people, but that has backfired. We are actively debating removing the
designation of internal & external.

The basic problem is as followsÅ 

If you are running a multi-tenant PBX we have to know, for inbound calls,
which account/context the call is destined for. For that, we create a
"global" inbound routes list of all incoming phone numbers, then transfer
those numbers to the right context for the particular account in question.

If you select "External" we know the number you are adding needs to be
added to that global list (say 203-555-1234). If you select "Internal" we
know the number you are adding is just an extension number and only to be
called by other phones on the same context/account (say "2222").

That's what it's for.

Once you've selected Internal or External you also have to pick at least
one context (at the bottom) to add the number to.

Michael Mol

unread,
May 16, 2013, 12:40:55 PM5/16/13
to 2600hz...@googlegroups.com
OK, so I have three contexts:

1) Inbound Routes
2) Outbound Routes
3) In-house Only

I have two numbers, 200 and 201, of type Internal, and both are in
"Outbound Routes" and "In-house Only". Neither device at these numbers
can successfully dial the other; they get 404 (Not Found).

When the inbound trunk is dialed, the user reaches an auto attendant
whose context is "In-house Only". The user can then successfully reach
either 200 or 201.

What am I doing wrong here? The two numbers share two contexts; I
thought that would be more than sufficient to dial one number from the
other.
signature.asc

Darren Schreiber

unread,
May 16, 2013, 12:41:57 PM5/16/13
to 2600hz...@googlegroups.com
What context are the devices themselves assigned to? They would need to
match the context the numbers are also in.

--
Darren Schreiber
CEO / Co-Founder


visit: www.2600hz.com <http://www.2600hz.com/>
sip:dar...@2600hz.com


tel: 415-886-7901




Note: Please do not send support requests to Darren directly. Please use
sup...@2600hz.com

Michael Mol

unread,
May 16, 2013, 12:50:23 PM5/16/13
to 2600hz...@googlegroups.com
So, the only place I see to set context wrt devices is in their
"Outbound Context" setting, where I only see a dropdown, meaning I can
only set one context.

Initially, upon checking, both devices' outbound context was "Outbound
Only". Obviously, if the numbers I was trying to dial are in every
context _but_ that, that won't work.

However, I've tried setting the devices' (first one, then both) outbound
contexts to "In-house Only" and to "Inbound Only", and they're still not
able to dial each other. Same result.
signature.asc

Darren Schreiber

unread,
May 16, 2013, 12:52:15 PM5/16/13
to 2600hz...@googlegroups.com
I would need a FreeSWITCH log at this point when you make the call.

Michael Mol

unread,
May 16, 2013, 12:56:05 PM5/16/13
to 2600hz...@googlegroups.com
I'll see what I can do. Obviously, I'll have to sed out some identifying
details; I'll be sure to leave things uniquely identifiable.

Silly question: Do devices need to unregister and re-register in order
for all settings changes to take effect?
signature.asc

Darren Schreiber

unread,
May 16, 2013, 12:57:44 PM5/16/13
to 2600hz...@googlegroups.com
no, no need to unreg/re-reg

Michael Mol

unread,
May 16, 2013, 1:14:00 PM5/16/13
to 2600hz...@googlegroups.com
Redactions made:
* s/domain-name/sip.example.com/
* s/client IP first three octets/a.b.c/
* s/trunk SIP address/trunktest/

I didn't see anything else identifiable (without fingerprinting, anyway).

Redacted log:

2013-05-16 12:05:26.132651 [NOTICE] switch_core_session.c:1566 Session
52 (sofia/sipinterface_1/2...@sip.example.com) Ended
2013-05-16 12:05:26.132651 [NOTICE] switch_core_session.c:1570 Close
Channel sofia/sipinterface_1/2...@sip.example.com [CS_DESTROY]
2013-05-16 12:05:26.132651 [DEBUG] switch_core_state_machine.c:565
(sofia/sipinterface_1/2...@sip.example.com) Callstate Change HANGUP -> DOWN
2013-05-16 12:05:26.132651 [DEBUG] switch_core_state_machine.c:568
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_DESTROY
2013-05-16 12:05:26.132651 [DEBUG] switch_core_state_machine.c:578
(sofia/sipinterface_1/2...@sip.example.com) State DESTROY
2013-05-16 12:05:26.132651 [DEBUG] mod_sofia.c:373
sofia/sipinterface_1/2...@sip.example.com SOFIA DESTROY
2013-05-16 12:05:26.132651 [DEBUG] switch_core_state_machine.c:99
sofia/sipinterface_1/2...@sip.example.com Standard DESTROY
2013-05-16 12:05:26.132651 [DEBUG] switch_core_state_machine.c:578
(sofia/sipinterface_1/2...@sip.example.com) State DESTROY going to sleep
2013-05-16 12:06:18.473703 [INFO] mod_enum.c:872 ENUM Reloaded
2013-05-16 12:06:18.473703 [INFO] switch_time.c:1173 Timezone reloaded
530 definitions
2013-05-16 12:06:28.772604 [NOTICE] switch_channel.c:978 New Channel
sofia/sipinterface_1/2...@sip.example.com
[f2fa7852-be4a-11e2-bb52-3de901aa3cfd]
2013-05-16 12:06:28.772604 [DEBUG] switch_core_session.c:1005 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.772604 [DEBUG] switch_core_session.c:1005 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.772604 [DEBUG] switch_core_state_machine.c:415
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_NEW
2013-05-16 12:06:28.772604 [DEBUG] switch_core_state_machine.c:433
(sofia/sipinterface_1/2...@sip.example.com) State NEW
2013-05-16 12:06:28.792558 [DEBUG] sofia.c:7855 IP a.b.c.77 Approved by
acl "net_list_6[]". Access Granted.
2013-05-16 12:06:28.792558 [DEBUG] sofia.c:5742 Channel
sofia/sipinterface_1/2...@sip.example.com entering state [received][100]
2013-05-16 12:06:28.792558 [DEBUG] sofia.c:5751 Remote SDP:
v=0^M
o=- 1368724070 1 IN IP4 a.b.c.77^M
s=Ekiga/4.0.1^M
c=IN IP4 a.b.c.77^M
t=0 0^M
m=audio 33000 RTP/AVP 93 0 8 101^M
a=rtpmap:93 Speex/16000/1^M
a=rtpmap:0 PCMU/8000/1^M
a=rtpmap:8 PCMA/8000/1^M
a=rtpmap:101 telephone-event/8000^M
a=fmtp:101 0-16,32,36^M
a=maxptime:20^M
m=video 33106 RTP/AVP 91 31 34 110 113 112 118^M
b=AS:4096^M
b=AS:4096000^M
a=rtpmap:91 theora/90000^M
a=fmtp:91 height=576;width=704^M
a=rtpmap:31 h261/90000^M
a=fmtp:31 CIF=1;QCIF=1^M
a=rtpmap:34 H263/90000^M
a=fmtp:34 F=1;CIF=1;CIF4=1;QCIF=1^M
a=rtpmap:110 H263-1998/90000^M
a=fmtp:110 D=1;F=1;I=1;J=1;CIF=1;CIF4=1;QCIF=1^M
a=rtpmap:113 H264/90000^M
a=fmtp:113 max-fs=6336;max-mbps=190080;profile-level-id=42801e^M
a=rtpmap:112 H264/90000^M
a=fmtp:112
packetization-mode=1;max-fs=6336;max-mbps=190080;profile-level-id=42801e^M
a=rtpmap:118 MP4V-ES/90000^M
a=fmtp:118 profile-level-id=5^M

2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2673 Audio Codec
Compare [Speex:93:16000:20:0]/[G722:9:8000:20:64000]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2673 Audio Codec
Compare [Speex:93:16000:20:0]/[PCMU:0:8000:20:64000]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2673 Audio Codec
Compare [Speex:93:16000:20:0]/[PCMA:8:8000:20:64000]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2673 Audio Codec
Compare [Speex:93:16000:20:0]/[GSM:3:8000:20:13200]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2673 Audio Codec
Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2673 Audio Codec
Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:1772 Set Codec
sofia/sipinterface_1/2...@sip.example.com PCMU/8000 20 ms 160 samples
64000 bits
2013-05-16 12:06:28.792558 [DEBUG] switch_core_codec.c:111
sofia/sipinterface_1/2...@sip.example.com Original read codec set to PCMU:0
2013-05-16 12:06:28.792558 [DEBUG] switch_core_media.c:2842 Set 2833
dtmf send/recv payload to 101
2013-05-16 12:06:28.792558 [DEBUG] sofia.c:5984
(sofia/sipinterface_1/2...@sip.example.com) State Change CS_NEW -> CS_INIT
2013-05-16 12:06:28.792558 [DEBUG] switch_core_session.c:1340 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:415
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_INIT
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:454
(sofia/sipinterface_1/2...@sip.example.com) State INIT
2013-05-16 12:06:28.792558 [DEBUG] mod_sofia.c:87
sofia/sipinterface_1/2...@sip.example.com SOFIA INIT
2013-05-16 12:06:28.792558 [DEBUG] mod_sofia.c:114
(sofia/sipinterface_1/2...@sip.example.com) State Change CS_INIT ->
CS_ROUTING
2013-05-16 12:06:28.792558 [DEBUG] switch_core_session.c:1340 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:454
(sofia/sipinterface_1/2...@sip.example.com) State INIT going to sleep
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:415
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_ROUTING
2013-05-16 12:06:28.792558 [DEBUG] switch_channel.c:2034
(sofia/sipinterface_1/2...@sip.example.com) Callstate Change DOWN -> RINGING
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:470
(sofia/sipinterface_1/2...@sip.example.com) State ROUTING
2013-05-16 12:06:28.792558 [DEBUG] mod_sofia.c:137
sofia/sipinterface_1/2...@sip.example.com SOFIA ROUTING
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:117
sofia/sipinterface_1/2...@sip.example.com Standard ROUTING
2013-05-16 12:06:28.792558 [INFO] mod_dialplan_xml.c:558 Processing Mike
Mol <201>->200 in context multitenant_routing_context
Dialplan: sofia/sipinterface_1/2...@sip.example.com parsing
[multitenant_routing_context->route_number_19] continue=true
Dialplan: sofia/sipinterface_1/2...@sip.example.com Regex (FAIL)
[route_number_19] destination_number(200) =~ /^trunktest$/ break=on-false
2013-05-16 12:06:28.792558 [INFO] switch_core_state_machine.c:192 No
Route, Aborting
2013-05-16 12:06:28.792558 [NOTICE] switch_core_state_machine.c:193
Hangup sofia/sipinterface_1/2...@sip.example.com [CS_ROUTING]
[NO_ROUTE_DESTINATION]
2013-05-16 12:06:28.792558 [DEBUG] switch_channel.c:3096 Send signal
sofia/sipinterface_1/2...@sip.example.com [KILL]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_session.c:1340 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:470
(sofia/sipinterface_1/2...@sip.example.com) State ROUTING going to sleep
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:415
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_HANGUP
2013-05-16 12:06:28.792558 [DEBUG] switch_core_state_machine.c:676
(sofia/sipinterface_1/2...@sip.example.com) State HANGUP
2013-05-16 12:06:28.792558 [DEBUG] mod_sofia.c:463 Channel
sofia/sipinterface_1/2...@sip.example.com hanging up, cause:
NO_ROUTE_DESTINATION
2013-05-16 12:06:28.814972 [DEBUG] mod_sofia.c:597 Responding to INVITE
with: 404
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:48
sofia/sipinterface_1/2...@sip.example.com Standard HANGUP, cause:
NO_ROUTE_DESTINATION
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:676
(sofia/sipinterface_1/2...@sip.example.com) State HANGUP going to sleep
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:689
(sofia/sipinterface_1/2...@sip.example.com) Callstate Change RINGING ->
HANGUP
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:446
(sofia/sipinterface_1/2...@sip.example.com) State Change CS_HANGUP ->
CS_REPORTING
2013-05-16 12:06:28.814972 [DEBUG] switch_core_session.c:1340 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:415
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_REPORTING
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:761
(sofia/sipinterface_1/2...@sip.example.com) State REPORTING
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:92
sofia/sipinterface_1/2...@sip.example.com Standard REPORTING, cause:
NO_ROUTE_DESTINATION
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:761
(sofia/sipinterface_1/2...@sip.example.com) State REPORTING going to sleep
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:440
(sofia/sipinterface_1/2...@sip.example.com) State Change CS_REPORTING ->
CS_DESTROY
2013-05-16 12:06:28.814972 [DEBUG] switch_core_session.c:1340 Send
signal sofia/sipinterface_1/2...@sip.example.com [BREAK]
2013-05-16 12:06:28.814972 [DEBUG] switch_core_session.c:1548 Session 53
(sofia/sipinterface_1/2...@sip.example.com) Locked, Waiting on external
entities
2013-05-16 12:06:28.814972 [NOTICE] switch_core_session.c:1566 Session
53 (sofia/sipinterface_1/2...@sip.example.com) Ended
2013-05-16 12:06:28.814972 [NOTICE] switch_core_session.c:1570 Close
Channel sofia/sipinterface_1/2...@sip.example.com [CS_DESTROY]
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:565
(sofia/sipinterface_1/2...@sip.example.com) Callstate Change HANGUP -> DOWN
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:568
(sofia/sipinterface_1/2...@sip.example.com) Running State Change CS_DESTROY
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:578
(sofia/sipinterface_1/2...@sip.example.com) State DESTROY
2013-05-16 12:06:28.814972 [DEBUG] mod_sofia.c:373
sofia/sipinterface_1/2...@sip.example.com SOFIA DESTROY
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:99
sofia/sipinterface_1/2...@sip.example.com Standard DESTROY
2013-05-16 12:06:28.814972 [DEBUG] switch_core_state_machine.c:578
(sofia/sipinterface_1/2...@sip.example.com) State DESTROY going to sleep
signature.asc
Reply all
Reply to author
Forward
0 new messages