[Spce-user] Inbound call fail

[Carlos M. Perez]

Hi,

 

We have recently setup a SPCE server, and we can make outbound calls
correctly, but inbound calls fail.  We followed the instructions as best
we could.  The purpose of this test box is to get ATA's successfully
dialing out and receiving calls. These calls will be used for both voice
and fax.

 

We have a domain setup with Public IP address.  The Inbound rewrite for
caller/callee are blank, as our provider gives us E164 compliant CLID
without the + sign.  We will always receive <cc><ac><sn> as described in
the instructions.  Our outbound rewriting is handled by the ATA to
ensure that we always  dial as 1<ac><sn> for North America based calls.
We will not be supporting international calls at this time with our
first provider.  We are blocking these types of calls at the ata level.


 

Here's the context of a call inbound.  I've sanitized it as follows:
(hopefully I haven't pasted too much)

 

-          atadid = 11 digit matching the DID 1786xxxxxxx

-          ata.ip = Public IP of NAT router.  Private IP as seen is
192.168.1.194

-          E164caller = the CID of the inbound call it is 1305xxxxxxx

-          sipwise.ip = public IP of the Sipwise server (no-nat)

-          provider.ip = IP of provider we register against

-          provider.ip2 = IP of provider media?

 

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: New request - M=INVITE R=sip:atadid at sipwise.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Call from PSTN - M=INVITE R=sip:atadid at sipwise.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Load dialplan IDs for peer host '1' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Fetched dialplan IDs caller_in='9', callee_in='10' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Clear caller preferences - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Load caller preferences for uuid '0' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: IP authorization for caller not provisioned, allow call -
M=INVITE R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: User-provided CLI 'E164caller' in From found - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Applying caller-in peer rewrite rules on user-provided CLI
using dpid '9' - M=INVITE R=sip:atadid at sipwise.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: No matching rewrite rules for 'E164caller' found - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Setting 'E164caller at provider.ip' as initiating CLI - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Searching for callee - M=INVITE R=sip:atadid at sipwise.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Applying callee-in peer rewrite rules using dpid '10' -
M=INVITE R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: No matching rewrite rules for 'atadid' found - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Callee was aliased with base 'atadid' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Clear callee preferences - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Callee is local, uuid='81a82ee6-ec49-4e17-8030-8912317852a8' -
M=INVITE R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Check Administrative NCOS level - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Check User NCOS level - M=INVITE R=sip:atadid at sipwise.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Admin caller block mode is 'open' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Caller block mode is 'open' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Load callee preferences for uuid
'81a82ee6-ec49-4e17-8030-8912317852a8' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Admin callee block mode is 'open' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Callee block mode is 'open' - M=INVITE
R=sip:atadid at sipwise.ip:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Local user online, using base as user - M=INVITE
R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Setting acc source-leg for uuid '0':
'0|E164caller|provider.ip|E164caller|0|call' - M=INVITE
R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Setting acc destination-leg for uuid
'81a82ee6-ec49-4e17-8030-8912317852a8':
'atadid|81a82ee6-ec49-4e17-8030-8912317852a8|atadid|sipwise.ip|atadid|si
pwise.ip' - M=INVITE R=sip:atadid at 192.168.1.194:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Relaying request - M=INVITE R=sip:atadid at 192.168.1.194:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Use mediaproxy for forward direction - M=INVITE
R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: First caller CLI 'E164caller' found - M=INVITE
R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Applying caller-out domain rewrite rules to first caller CLI
using dpid '7' - M=INVITE R=sip:atadid at 192.168.1.194:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: No matching rewrite rules for 'E164caller' found - M=INVITE
R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Set caller CLI 'E164caller <sip:E164caller at provider.ip>' -
M=INVITE R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21633]: INFO:
<script>: Request leaving server, D-URI='sip:ata.ip:5060' - M=INVITE
R=sip:atadid at 192.168.1.194:5060 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21634]: INFO:
<script>: NAT-Reply - S=100 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:18 rundc1-switch01 /usr/sbin/kamailio[21638]: INFO:
<script>: NAT-Reply - S=180 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:27 rundc1-switch01 /usr/sbin/kamailio[21628]: INFO:
<script>: NAT-Reply - S=200 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:27 rundc1-switch01 /usr/sbin/kamailio[21628]: INFO:
<script>: Use mediaproxy for backward direction - S=200
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:28 rundc1-switch01 /usr/sbin/kamailio[21637]: INFO:
<script>: New request - M=ACK R=sip:atadid at ata.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:28 rundc1-switch01 /usr/sbin/kamailio[21637]: INFO:
<script>: Relaying request - M=ACK R=sip:atadid at ata.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:31 rundc1-switch01 /usr/sbin/kamailio[21627]: INFO:
<script>: New request - M=INVITE R=sip:E164caller at provider.ip:5060
F=sip:atadid at sipwise.ip T=sip:E164caller at provider.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:31 rundc1-switch01 /usr/sbin/kamailio[21627]: INFO:
<script>: Relaying request - M=INVITE R=sip:E164caller at provider.ip:5060
F=sip:atadid at sipwise.ip T=sip:E164caller at provider.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:31 rundc1-switch01 /usr/sbin/kamailio[21629]: INFO:
<script>: NAT-Reply - S=100 F=sip:atadid at sipwise.ip
T=sip:E164caller at provider.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:43 rundc1-switch01 /usr/sbin/kamailio[21630]: INFO:
<script>: New request - M=BYE R=sip:atadid at ata.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:43 rundc1-switch01 /usr/sbin/kamailio[21630]: INFO:
<script>: Stop mediaproxy - M=BYE R=sip:atadid at ata.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:43 rundc1-switch01 /usr/sbin/kamailio[21630]: INFO:
<script>: Relaying request - M=BYE R=sip:atadid at ata.ip:5060
F=sip:E164caller at provider.ip T=sip:atadid at sipwise.ip IP=provider.ip:5060
ID=21957837-0-443276480 at provider.ip2

Apr 11 03:13:43 rundc1-switch01 /usr/sbin/kamailio[21636]: INFO:
<script>: NAT-Reply - S=200 F=sip:E164caller at provider.ip
T=sip:atadid at sipwise.ip IP=ata.ip:5060
ID=21957837-0-443276480 at provider.ip2

 

Thanks in advance,

 

Carlos M. Perez

CMP Consulting Services

 

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sipwise.com/mailman/private/spce-user_lists.sipwise.com/attachments/20110411/5f8091d9/attachment.html>