[Spce-user] Rewrite Rules outbound calls

Jay Autar jay.k.autar at gmail.com
Sun Jun 14 20:22:47 EDT 2015


Hi Daniel,

Thanks for your fast reply! I checked my rewrite rules and it is added to
my sip domain profile and the peer rules are added to their peers. I also
added the rewrite rules to the subscriber but that did not help.

I did the test with the commando: ngcp-kamctl proxy fifo debug 2. This is
the output. I tested with two numbers 31612345678 and
<sip%3A31612345678 at sip1.ntelecom.com>0612345678
<sip%3A31612345678 at sip1.ntelecom.com> which I called from my Bria softphone

The logs are attached to this mail.

The logs are saying there is no matching rewrite rule, which is strange, I
added the rewrite rules at the same way it is described in the handbook.

Do you have an other idea what the problem could be?

2015-06-14 15:19 GMT+02:00 Daniel Grotti <dgrotti at sipwise.com>:

> Hi Jay,
> Your ruri is not rewritten at all.
> So please check again your rewrite rule set and rules.
> Also you can increase the proxy debug with: ngcp-kamctl proxy fifo debug 2
>
> You can see what's happening.
> Did you assign the reqwrite rule set to your peer?
>
> Daniel
>
>
> On Jun 14, 2015 2:03 PM, Jay Autar <jay.k.autar at gmail.com> wrote:
> >
> > Goodday everyone,
> >
> > I am struggling white this issue for a few days, searching the lists but
> I cannot figure this issue out.
> >
> > Could you help me with this one:
> >
> > Situation:
> >
> > Subscriber---->Peer (Outbound)----->Outside world
> >
> > 1) I Create Rewrite rules for my domain sip1.ntelecom.com
> >
> > Inbound Rewrite Rules for Caller
> > ˆ(00|\+)([1-9][0-9]+)$     \2         International to E.164     yes
> > ˆ0([1-9][0-9]+)$     ${caller_cc}\1     National to E.164     yes
> > ˆ([1-9][0-9]+)$     ${caller_cc}${caller_ac}\1     Local to E.164     yes
> >
> > Inbound Rewrite Rules for Callee
> > ˆ(00|\+)([1-9][0-9]+)$     \2         International to E.164     yes
> > ˆ0([1-9][0-9]+)$     ${caller_cc}\1     National to E.164     yes
> > ˆ([1-9][0-9]+)$     ${caller_cc}${caller_ac}\1     Local to E.164
> yes
> > ˆ(911|112)$         emergency_\1     Tag Emergency Numbers     yes
> >
> > Outbound Rewrite Rules for Caller
> > ˆemergency_(.+)$     ${caller_emergency_prefix}${caller_ac}\1
> Normalize Emergency Numbers     yes
> >
> > 2) For the peer sip.voxbone.com I create the following:
> > 2.1) Peering rules:
> > One empty rule to match everything
> >
> > 2.2) Rewrite rule(VoxBone requires me to use a prefix of 0011 for all
> numbers that will be
> > So I created the following rewrite rule and added to this peer:
> >
> > Outbound Rewrite Rules for Callee
> > ˆ([1-9]+)$     0011\1     Prefix for number yes
> >
> > Now when I call a number for example 31612345678
> > The following happens in the log:
> >
> > *************
> > Jun 14 12:51:15 sip1 proxy[3829]: NOTICE: <script>: New request on proxy
> - M=REGISTER R=sip:sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=
> sip:erik at sip1.ntelecom.com IP=92.69.229.52:36671 (127.0.0.1:5060)
> ID=Zt1EaYvnb-QInZ6J1PwU-NcpUpEgBgN1
> > Jun 14 12:51:15 sip1 proxy[3829]: NOTICE: <script>: Contacts
> successfully updated, expires in 900s - R=sip:sip1.ntelecom.com
> ID=Zt1EaYvnb-QInZ6J1PwU-NcpUpEgBgN1
> > Jun 14 12:51:21 sip1 proxy[3828]: NOTICE: <script>: New request on proxy
> - M=INVITE R=sip:31612345678 at sip1.ntelecom.com F=
> sip:erik at sip1.ntelecom.com T=sip:31612345678 at sip1.ntelecom.com IP=
> 92.69.229.52:36671 (127.0.0.1:5060) ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3828]: NOTICE: <script>: Authentication
> failed, no credentials - R=sip:31612345678 at sip1.ntelecom.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: New request on proxy
> - M=INVITE R=sip:31612345678 at sip1.ntelecom.com F=
> sip:erik at sip1.ntelecom.com T=sip:31612345678 at sip1.ntelecom.com IP=
> 92.69.229.52:36671 (127.0.0.1:5060) ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: User-Provided CLI
> 'erik' taken from From-User - R=sip:31612345678 at sip1.ntelecom.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: User-provided CLI
> 'erik' rejected, using network-provided CLI '31207132454' - R=
> sip:31612345678 at sip1.ntelecom.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting '
> 31207132454 at sip1.ntelecom.com' as initiating user-provided CLI - R=
> sip:31612345678 at sip1.ntelecom.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting '
> 31207132454 at sip1.ntelecom.com' as initiating network-provided CLI - R=
> sip:31612345678 at sip1.ntelecom.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Callee is not local
> - R=sip:31612345678 at sip1.ntelecom.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Call to SIP Peering
> - R=sip:31612345678 at sip1.ntelecom.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Load gws matching
> calling part 'sip:31207132454 at sip1.ntelecom.com' and called user
> '31612345678' and called part 'sip:31612345678 at sip1.ntelecom.com' - R=
> sip:31612345678 at sip1.ntelecom.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting acc
> source-leg for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a':
> '67ad8967-9d19-4c4a-ba4b-19b3a564906a|erik|sip1.ntelecom.com|31207132454|||3|||0|call|92.69.229.52|1434279081.116248|||||||||||'
> - R=sip:31612345678 at sip.voxbone.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting acc
> destination-leg for uuid '0': '0|||0|31612345678|0|31612345678|
> sip.voxbone.com|31612345678|sip1.ntelecom.com|1|||||||||||' - R=
> sip:31612345678 at sip.voxbone.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting
> caller_cli_userprov/caller_domain_userprov '31207132454 at sip1.ntelecom.com'
> for upn - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting From to '<
> sip:31207132454 at sip1.ntelecom.com>' - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting
> caller_cli_netprov/caller_domain_netprov '31207132454 at sip1.ntelecom.com'
> for npn - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting PAI to '<
> sip:31207132454 at sip1.ntelecom.com>' - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting
> P-Called-Party-ID '<sip:31612345678 at sip.voxbone.com>' - R=
> sip:31612345678 at sip.voxbone.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Setting 'sip:
> 98.222.112.123:5060' taken from D-URI as next hop after lb for PSTN call
> - R=sip:31612345678 at sip.voxbone.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Appending P-D-URI
> 'sip:127.0.0.1:5060;received='sip:98.222.112.123:5060;lr;transport=udp''
> - R=sip:31612345678 at sip.voxbone.com ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Forcing request via
> B2BUA 'sip:127.0.0.1:5080' - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3831]: NOTICE: <script>: Request leaving
> server, D-URI='sip:127.0.0.1:5080' - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3830]: NOTICE: <script>: NAT-Reply - S=100 -
> Connecting M=INVITE IP=92.69.229.52:36671 (127.0.0.1:5080)
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3827]: NOTICE: <script>: NAT-Reply - S=503 -
> Internal Server Error - tnk M=INVITE IP=92.69.229.52:36671 (127.0.0.1:5080)
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > Jun 14 12:51:21 sip1 proxy[3827]: NOTICE: <script>: Failure route for
> PSTN call - R=sip:31612345678 at sip.voxbone.com
> ID=4OuHzx0F-f7N5o27zPs7VCmg1a371A5r
> > *****************************
> >
> > As seen in the log, the number which is dialed by the subscriber erik
> (31612345678) is not rewrited in the form of 001131612345678 which is
> defined in the PEER Outbound Rewrite Rules for Callee. I am getting a S=503
> - Internal Server Error back from voxbone because there is no prefix set.
> >
> > Could you help me to solve this issue. I thing it is a setting but now i
> do not know where to look.
> >
> > Thanks for your help!
> >
> > Warm regards,
> > Jay
> >
> >
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sipwise.com/pipermail/spce-user_lists.sipwise.com/attachments/20150615/aa771aa0/attachment-0001.html>
-------------- next part --------------
Jun 15 01:39:17 sip1 proxy[3831]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:erik at sip1.ntelecom.com IP=92.69.229.52:36707 (127.0.0.1:5060) ID=LdLq5XIkv3RBCCILNuweIL4.dDku7VrL
Jun 15 01:39:17 sip1 proxy[3831]: INFO: <script>: [LUA] Load caller preferences for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a' and domain part of uri 'sip1.ntelecom.com' - R=sip:sip1.ntelecom.com ID=LdLq5XIkv3RBCCILNuweIL4.dDku7VrL
Jun 15 01:39:17 sip1 proxy[3831]: INFO: <script>: IP authorization not provisioned, allow registration - R=sip:sip1.ntelecom.com ID=LdLq5XIkv3RBCCILNuweIL4.dDku7VrL
Jun 15 01:39:17 sip1 proxy[3831]: NOTICE: <script>: Contacts successfully updated, expires in 900s - R=sip:sip1.ntelecom.com ID=LdLq5XIkv3RBCCILNuweIL4.dDku7VrL
Jun 15 01:39:24 sip1 proxy[3827]: NOTICE: <script>: New request on proxy - M=INVITE R=sip:0612345678 at sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:0612345678 at sip1.ntelecom.com IP=92.69.229.52:36707 (127.0.0.1:5060) ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3827]: INFO: <script>: Load domain preferences for callee - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3827]: INFO: <script>: Clean domain preferences for callee - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3827]: NOTICE: <script>: Authentication failed, no credentials - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: New request on proxy - M=INVITE R=sip:0612345678 at sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:0612345678 at sip1.ntelecom.com IP=92.69.229.52:36707 (127.0.0.1:5060) ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Load domain preferences for callee - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Clean domain preferences for callee - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Adding reply P-NGCP-Caller-Info '<sip:erik at sip1.ntelecom.com>;ip=92.69.229.52;port=36707' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Clear caller preferences - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Load caller preferences for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a' and domain 'sip1.ntelecom.com' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Load caller contract preferences for contract id '3' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Use lb/rtp set id '50' for local caller - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Fetched dialplan IDs caller_in='1', callee_in='2' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Use 'P-NGCP-Src-Ip' for CDR IP - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: IP authorization for caller not provisioned, allow call - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: User-Provided CLI 'erik' taken from From-User - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Applying caller-in usr/domain rewrite rules on user-provided CLI using dpid '1' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No matching rewrite rules for 'erik' found - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Checking User-provided CLI against allowed CLIs - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: User-provided CLI 'erik' rejected, using network-provided CLI '31207132454' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting '31207132454 at sip1.ntelecom.com' as initiating user-provided CLI - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting '31207132454 at sip1.ntelecom.com' as initiating network-provided CLI - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Searching for callee - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Applying callee-in usr/domain rewrite rules on called party using dpid '2' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No matching rewrite rules for '0612345678' found - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Clear callee preferences - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Callee is not local - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Check Administrative Contract NCOS level - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Check Administrative NCOS level - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Check Contract NCOS level - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Check User NCOS level - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Checking URI '0612345678 at sip1.ntelecom.com' and CLI '0612345678' against admin contract block out lists - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Admin Contract caller block mode is 'open' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Checking URI '0612345678 at sip1.ntelecom.com' and CLI '0612345678' against block out lists - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Admin caller block mode is 'open' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Checking URI '0612345678 at sip1.ntelecom.com' and CLI '0612345678' against contract block out lists - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Contract caller block mode is 'open' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Caller block mode is 'open' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Call to SIP Peering - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Load gws matching calling part 'sip:31207132454 at sip1.ntelecom.com' and called user '0612345678' and called part 'sip:0612345678 at sip1.ntelecom.com' - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Dialog set mark type to outgoing - R=sip:0612345678 at sip1.ntelecom.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Clean peer preferences for callee - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Load peer preferences for peer host '1' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Use lb/rtp set id '50' for call to peer - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Load dialplan IDs for peer host '1' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Fetched dialplan IDs caller_out='7', callee_out='8' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Load route set for peer host '1' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No outbound route set for this peer found - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Dialog set mark peer and peerout to '1' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Remove INFO from Allow - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Remove REFER from Allow - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Dialog set total - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Set caller dialogs: totaluser, totaluserout, totalaccount, totalaccountout to '67ad8967-9d19-4c4a-ba4b-19b3a564906a/3' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Set caller dialogs: user, userout, account, accountout to '67ad8967-9d19-4c4a-ba4b-19b3a564906a/3' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting acc source-leg for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a': '67ad8967-9d19-4c4a-ba4b-19b3a564906a|erik|sip1.ntelecom.com|31207132454|||3|||0|call|92.69.229.52|1434325164.353613|||||||||||' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting acc destination-leg for uuid '0': '0|||0|0612345678|0|0612345678|sip.voxbone.com|0612345678|sip1.ntelecom.com|1|||||||||||' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Loading dispatcher entries for lb using did '50' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Successfully loaded lb 'sip:127.0.0.1:5060' from dispatcher using did '50' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Relaying request, du='sip:98.222.112.123:5060;transport=udp' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Use mediaproxy for forward direction for IPv4/IPv4 - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Remove existing ICE candidates (if any) for callee - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Try protocol 'transparent' for callee - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Engaging rtpengine in request for caller did '50' and callee did '50' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Setting P-Caller-UUID to '67ad8967-9d19-4c4a-ba4b-19b3a564906a' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Setting P-Callee-UUID to '0' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: User Agent header removed - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Sessions Timers disabled for caller - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Sessions Timers disabled for callee - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Applying caller-out peer rewrite rules on first user-provided CLI using dpid '7' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No matching rewrite rules for '31207132454' found - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Applying caller-out peer rewrite rules on first network-provided CLI using dpid '7' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No matching rewrite rules for '31207132454' found - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Prepare From display-name setting - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No selector set, not setting CLI - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Prepare From username setting - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting caller_cli_userprov/caller_domain_userprov '31207132454 at sip1.ntelecom.com' for upn - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting From to '<sip:31207132454 at sip1.ntelecom.com>' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Prepare PAI username setting - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting caller_cli_netprov/caller_domain_netprov '31207132454 at sip1.ntelecom.com' for npn - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting PAI to '<sip:31207132454 at sip1.ntelecom.com>' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Prepare PPI username setting - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No selector set, not setting CLI - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Prepare Diversion setting - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No selector set, not setting CLI - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Applying callee-out peer rewrite rules on called party using dpid '8' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: No matching rewrite rules for '0612345678' found - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Prepare P-Called-Party-ID setting using selector 'callee' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting P-Called-Party-ID '<sip:0612345678 at sip.voxbone.com>' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Writing sbc parameters  ;aleg_sst_enable=no;sst_enable=no - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Setting 'sip:98.222.112.123:5060' taken from D-URI as next hop after lb for PSTN call - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Adding P-NGCP-Caller-Info '<sip:erik at sip1.ntelecom.com>;ip=92.69.229.52;port=36707' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: INFO: <script>: Adding P-NGCP-Callee-Info '<sip:0612345678 at sip.voxbone.com>;ip=98.222.112.123;port=5060' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Appending P-D-URI 'sip:127.0.0.1:5060;received='sip:98.222.112.123:5060;lr;transport=udp'' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Forcing request via B2BUA 'sip:127.0.0.1:5080' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3835]: NOTICE: <script>: Request leaving server, D-URI='sip:127.0.0.1:5080' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3829]: NOTICE: <script>: NAT-Reply - S=100 - Connecting M=INVITE IP=92.69.229.52:36707 (127.0.0.1:5080) ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3828]: NOTICE: <script>: NAT-Reply - S=503 - Internal Server Error - tnk M=INVITE IP=92.69.229.52:36707 (127.0.0.1:5080) ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3828]: NOTICE: <script>: Failure route for PSTN call - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3828]: INFO: <script>: Unset dialog mark peer and peerout '1' - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS
Jun 15 01:39:24 sip1 proxy[3828]: INFO: <script>: Filter reply code - R=sip:0612345678 at sip.voxbone.com ID=AHFcY9jCUE6Gw5gB4Rf1QVxOqQII1QzS

-------------- next part --------------
Jun 15 02:12:35 sip1 proxy[3831]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:erik at sip1.ntelecom.com IP=92.69.229.52:62833 (127.0.0.1:5060) ID=IY7.opqTFy.WQpuwrhtWxQvURRYUWJGo
Jun 15 02:12:35 sip1 proxy[3831]: NOTICE: <script>: Authentication failed, no credentials - R=sip:sip1.ntelecom.com ID=IY7.opqTFy.WQpuwrhtWxQvURRYUWJGo
Jun 15 02:12:35 sip1 proxy[3827]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:erik at sip1.ntelecom.com IP=92.69.229.52:62833 (127.0.0.1:5060) ID=IY7.opqTFy.WQpuwrhtWxQvURRYUWJGo
Jun 15 02:12:35 sip1 proxy[3827]: INFO: <script>: [LUA] Load caller preferences for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a' and domain part of uri 'sip1.ntelecom.com' - R=sip:sip1.ntelecom.com ID=IY7.opqTFy.WQpuwrhtWxQvURRYUWJGo
Jun 15 02:12:35 sip1 proxy[3827]: INFO: <script>: IP authorization not provisioned, allow registration - R=sip:sip1.ntelecom.com ID=IY7.opqTFy.WQpuwrhtWxQvURRYUWJGo
Jun 15 02:12:35 sip1 proxy[3827]: NOTICE: <script>: Contacts successfully saved, expires in 900s - R=sip:sip1.ntelecom.com ID=IY7.opqTFy.WQpuwrhtWxQvURRYUWJGo
Jun 15 02:12:43 sip1 proxy[3826]: NOTICE: <script>: New request on proxy - M=INVITE R=sip:31612345678 at sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:31612345678 at sip1.ntelecom.com IP=92.69.229.52:62833 (127.0.0.1:5060) ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3826]: INFO: <script>: Load domain preferences for callee - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3826]: INFO: <script>: Clean domain preferences for callee - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3826]: NOTICE: <script>: Authentication failed, no credentials - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: New request on proxy - M=INVITE R=sip:31612345678 at sip1.ntelecom.com F=sip:erik at sip1.ntelecom.com T=sip:31612345678 at sip1.ntelecom.com IP=92.69.229.52:62833 (127.0.0.1:5060) ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Load domain preferences for callee - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Clean domain preferences for callee - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Adding reply P-NGCP-Caller-Info '<sip:erik at sip1.ntelecom.com>;ip=92.69.229.52;port=62833' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Clear caller preferences - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Load caller preferences for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a' and domain 'sip1.ntelecom.com' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Load caller contract preferences for contract id '3' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Use lb/rtp set id '50' for local caller - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Fetched dialplan IDs caller_in='1', callee_in='2' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Use 'P-NGCP-Src-Ip' for CDR IP - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: IP authorization for caller not provisioned, allow call - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: User-Provided CLI 'erik' taken from From-User - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Applying caller-in usr/domain rewrite rules on user-provided CLI using dpid '1' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No matching rewrite rules for 'erik' found - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Checking User-provided CLI against allowed CLIs - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: User-provided CLI 'erik' rejected, using network-provided CLI '31207132454' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting '31207132454 at sip1.ntelecom.com' as initiating user-provided CLI - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting '31207132454 at sip1.ntelecom.com' as initiating network-provided CLI - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Searching for callee - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Applying callee-in usr/domain rewrite rules on called party using dpid '2' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No matching rewrite rules for '31612345678' found - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Clear callee preferences - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Callee is not local - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Check Administrative Contract NCOS level - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Check Administrative NCOS level - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Check Contract NCOS level - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Check User NCOS level - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Checking URI '31612345678 at sip1.ntelecom.com' and CLI '31612345678' against admin contract block out lists - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Admin Contract caller block mode is 'open' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Checking URI '31612345678 at sip1.ntelecom.com' and CLI '31612345678' against block out lists - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Admin caller block mode is 'open' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Checking URI '31612345678 at sip1.ntelecom.com' and CLI '31612345678' against contract block out lists - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Contract caller block mode is 'open' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Caller block mode is 'open' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Call to SIP Peering - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Load gws matching calling part 'sip:31207132454 at sip1.ntelecom.com' and called user '31612345678' and called part 'sip:31612345678 at sip1.ntelecom.com' - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Dialog set mark type to outgoing - R=sip:31612345678 at sip1.ntelecom.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Clean peer preferences for callee - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Load peer preferences for peer host '1' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Use lb/rtp set id '50' for call to peer - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Load dialplan IDs for peer host '1' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Fetched dialplan IDs caller_out='7', callee_out='8' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Load route set for peer host '1' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No outbound route set for this peer found - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Dialog set mark peer and peerout to '1' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Remove INFO from Allow - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Remove REFER from Allow - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Dialog set total - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Set caller dialogs: totaluser, totaluserout, totalaccount, totalaccountout to '67ad8967-9d19-4c4a-ba4b-19b3a564906a/3' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Set caller dialogs: user, userout, account, accountout to '67ad8967-9d19-4c4a-ba4b-19b3a564906a/3' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting acc source-leg for uuid '67ad8967-9d19-4c4a-ba4b-19b3a564906a': '67ad8967-9d19-4c4a-ba4b-19b3a564906a|erik|sip1.ntelecom.com|31207132454|||3|||0|call|92.69.229.52|1434327163.208273|||||||||||' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting acc destination-leg for uuid '0': '0|||0|31612345678|0|31612345678|sip.voxbone.com|31612345678|sip1.ntelecom.com|1|||||||||||' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Loading dispatcher entries for lb using did '50' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Successfully loaded lb 'sip:127.0.0.1:5060' from dispatcher using did '50' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Relaying request, du='sip:98.222.112.123:5060;transport=udp' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Use mediaproxy for forward direction for IPv4/IPv4 - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Remove existing ICE candidates (if any) for callee - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Try protocol 'transparent' for callee - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Engaging rtpengine in request for caller did '50' and callee did '50' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Setting P-Caller-UUID to '67ad8967-9d19-4c4a-ba4b-19b3a564906a' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Setting P-Callee-UUID to '0' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: User Agent header removed - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Sessions Timers disabled for caller - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Sessions Timers disabled for callee - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Applying caller-out peer rewrite rules on first user-provided CLI using dpid '7' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No matching rewrite rules for '31207132454' found - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Applying caller-out peer rewrite rules on first network-provided CLI using dpid '7' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No matching rewrite rules for '31207132454' found - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Prepare From display-name setting - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No selector set, not setting CLI - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Prepare From username setting - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting caller_cli_userprov/caller_domain_userprov '31207132454 at sip1.ntelecom.com' for upn - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting From to '<sip:31207132454 at sip1.ntelecom.com>' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Prepare PAI username setting - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX

Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting caller_cli_netprov/caller_domain_netprov '31207132454 at sip1.ntelecom.com' for npn - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting PAI to '<sip:31207132454 at sip1.ntelecom.com>' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Prepare PPI username setting - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No selector set, not setting CLI - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Prepare Diversion setting - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No selector set, not setting CLI - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Applying callee-out peer rewrite rules on called party using dpid '8' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: No matching rewrite rules for '31612345678' found - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Prepare P-Called-Party-ID setting using selector 'callee' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting P-Called-Party-ID '<sip:31612345678 at sip.voxbone.com>' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Writing sbc parameters  ;aleg_sst_enable=no;sst_enable=no - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Setting 'sip:98.222.112.123:5060' taken from D-URI as next hop after lb for PSTN call - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Adding P-NGCP-Caller-Info '<sip:erik at sip1.ntelecom.com>;ip=92.69.229.52;port=62833' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: INFO: <script>: Adding P-NGCP-Callee-Info '<sip:31612345678 at sip.voxbone.com>;ip=98.222.112.123;port=5060' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Appending P-D-URI 'sip:127.0.0.1:5060;received='sip:98.222.112.123:5060;lr;transport=udp'' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Forcing request via B2BUA 'sip:127.0.0.1:5080' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3829]: NOTICE: <script>: Request leaving server, D-URI='sip:127.0.0.1:5080' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3828]: NOTICE: <script>: NAT-Reply - S=100 - Connecting M=INVITE IP=92.69.229.52:62833 (127.0.0.1:5080) ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3842]: NOTICE: <script>: NAT-Reply - S=503 - Internal Server Error - tnk M=INVITE IP=92.69.229.52:62833 (127.0.0.1:5080) ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3842]: NOTICE: <script>: Failure route for PSTN call - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3842]: INFO: <script>: Unset dialog mark peer and peerout '1' - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX
Jun 15 02:12:43 sip1 proxy[3842]: INFO: <script>: Filter reply code - R=sip:31612345678 at sip.voxbone.com ID=nTfjwV7T25wBVa7lvxExnSSUd9Bd.bIX



More information about the Spce-user mailing list