Cisco Support Community
cancel
Showing results for 
Search instead for 
Did you mean: 
Announcements

Welcome to Cisco Support Community. We would love to have your feedback.

For an introduction to the new site, click here. And see here for current known issues.

New Member

Unable to match incoming calls to a dialpeer

Hi,

I  have a Cisco 2912 (CUBE) registered to voip.ms. All  the outbound calls  work just fine. I am not able to make the incoming  calls work. When an  incoming call is places the CUBE doesn't match any  incoming dial peer  instead the outboud dial-peer is matched (please see  the debug below).  The cube is sitting behind an ASA 5510, however, the  public IP assigned  to CUBE's loopback is not being natted as it gives to  many problems  when cube traffc is natted. I have also attached a  network diagram to  this post. The following config is on the 2921  router. Also I have  pasted the dialpeer and CCSIP debugs.

SHOW RUN

Current configuration : 8069 bytes

!

! Last configuration change at 13:32:55 UTC Mon Dec 16 2013 by ajlal

version 15.2

service timestamps debug datetime msec

service timestamps log datetime msec

service password-encryption

!

hostname SEC-HO-VGATEWAY01

!

boot-start-marker

boot-end-marker

!

!

! card type command needed for slot/vwic-slot 0/0

logging buffered 51200 warnings

!

no aaa new-model

!

ip cef

!

!

!

!

!

!

ip domain name yrns.local

ip name-server 10.13.11.2

ip name-server 192.168.60.4

no ipv6 cef

multilink bundle-name authenticated

!

!

!

!

!

!

voice-card 0

dsp services dspfarm

!

!

!

voice service voip

ip address trusted list

  ipv4 184.75.215.114

ip address trusted call-block cause not-in-cug

gcid

clid substitute name

address-hiding

allow-connections sip to h323

allow-connections sip to sip

no supplementary-service sip moved-temporarily

no supplementary-service sip refer

fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none

sip

  bind control source-interface Loopback0

  bind media source-interface Loopback0

  session transport tcp

  e911

  transport switch udp tcp

  asserted-id ppi

  localhost dns:sec-ho-vgateway01.yrns.local

  midcall-signaling passthru

  no call service stop

!

!

!

voice class uri 1001 sip

host ipv4:184.75.215.114

voice class codec 1

codec preference 1 g711ulaw

codec preference 2 g729r8

codec preference 3 ilbc

!

!

!

!

voice translation-rule 1

rule 1 /^123456\(....\)$/ /\1/

!

!

voice translation-profile INBOUND_TRANS

translate called 1

!

!

!

!

!

!

!

redundancy

!

!

!

!

!

!

interface Loopback0

ip address 64.187.178.132 255.255.255.224

!

interface Embedded-Service-Engine0/0

no ip address

shutdown

!

interface GigabitEthernet0/0

description TO_ASA

ip address 10.13.255.13 255.255.255.252

duplex full

speed 1000

!

interface GigabitEthernet0/1

description TO_LOCAL_LAN

ip address 10.13.14.1 255.255.255.0

ip helper-address 192.168.60.4

duplex full

speed 1000

!

!

!

router eigrp 13

network 10.10.10.10 0.0.0.0

network 10.13.10.2 0.0.0.0

network 10.13.14.0 0.0.0.255

network 10.13.255.12 0.0.0.3

network 64.187.178.132 0.0.0.0

!

ip forward-protocol nd

!

ip http server

ip http authentication local

ip http secure-server

ip http timeout-policy idle 60 life 86400 requests 10000

!

!

!

!

!

control-plane

!

!

voice-port 0/1/0

!

voice-port 0/1/1

!

voice-port 0/1/2

!

voice-port 0/1/3

!

voice-port 0/2/0

!

voice-port 0/2/1

!

voice-port 0/2/2

!

voice-port 0/2/3

!

!

!

!

!

!

mgcp profile default

!

sccp local Loopback0

sccp ccm 10.13.14.22 identifier 2 version 7.0

sccp ccm 10.13.14.21 identifier 1 version 7.0

sccp

!

sccp ccm group 1

bind interface Loopback0

associate ccm 2 priority 1

associate ccm 1 priority 2

associate profile 4 register SECHO-G729-MTP

associate profile 3 register SECHO-G711-MTP

associate profile 2 register SECHO-HW-CFB

associate profile 1 register SECHO-HW-XCode

!

dspfarm profile 1 transcode

codec g729r8

codec g711ulaw

codec g711alaw

codec g729ar8

maximum sessions 2

associate application SCCP

!

dspfarm profile 2 conference

codec g711ulaw

codec g711alaw

codec g729ar8

codec g729r8

maximum sessions 2

associate application SCCP

!

dspfarm profile 3 mtp

codec g711ulaw

maximum sessions software 100

associate application SCCP

!

dspfarm profile 4 mtp

codec g729r8

maximum sessions software 100

associate application SCCP

!

dial-peer voice 1001 voip

description SIP TRUNK TO CUCM-SUB01

preference 1

destination-pattern 5...

session protocol sipv2

session target ipv4:10.13.14.21

session transport tcp

voice-class codec 1

!

dial-peer voice 1002 voip

description SIP TRUNK TO CUCM-SUB01

preference 1

destination-pattern 1...$

session protocol sipv2

session target ipv4:10.13.14.21

session transport tcp

voice-class codec 1

!

dial-peer voice 101 voip

preference 1

destination-pattern [2-9]..[2-9]......$

session protocol sipv2

session target dns:toronto2.voip.ms

session transport udp

no voice-class sip block 180

no voice-class sip block 183

no voice-class sip block 181

voice-class sip bind control source-interface Loopback0

voice-class sip bind media source-interface Loopback0

dtmf-relay rtp-nte

codec g711ulaw

no vad

!

dial-peer voice 103 voip

preference 1

destination-pattern 911$

session protocol sipv2

session target dns:toronto2.voip.ms

session transport udp

no voice-class sip block 180

no voice-class sip block 183

no voice-class sip block 181

voice-class sip bind control source-interface Loopback0

voice-class sip bind media source-interface Loopback0

dtmf-relay rtp-nte

codec g711ulaw

no vad

!

dial-peer voice 102 voip

preference 1

destination-pattern 1[2-9]..[2-9]......$

session protocol sipv2

session target dns:toronto2.voip.ms

session transport udp

no voice-class sip block 180

no voice-class sip block 183

no voice-class sip block 181

voice-class sip bind control source-interface Loopback0

voice-class sip bind media source-interface Loopback0

dtmf-relay rtp-nte

codec g711ulaw

no vad

!

dial-peer voice 1 voip

session protocol sipv2

incoming uri via 1001

dtmf-relay rtp-nte

codec transparent

no vad

!

dial-peer voice 501 voip

session protocol sipv2

incoming called-number .

voice-class sip bind control source-interface Loopback0

voice-class sip bind media source-interface Loopback0

dtmf-relay rtp-nte

codec g711ulaw

no vad

!

!

!

dial-peer hunt 1

sip-ua

credentials username USERNAME password 7 PASSWORD realm toronto2.voip.ms

authentication username USERNAME password 7 PASSWORD realm toronto2.voip.ms

registrar 1 dns:toronto2.voip.ms expires 300 auth-realm toronto2.voip.ms

!

!

!

gatekeeper

shutdown

!

!

!

line con 0

exec-timeout 60 0

logging synchronous

login local

line aux 0

line 2

no activation-character

no exec

transport preferred none

transport output pad telnet rlogin lapb-ta mop udptn v120 ssh

stopbits 1

line vty 0 4

exec-timeout 60 0

privilege level 15

logging synchronous

login local

transport input telnet ssh

line vty 5 15

access-class 23 in

privilege level 15

login local

transport input telnet ssh

!

scheduler allocate 20000 1000

!

end

DEBUG VOICE DIALPEER ALL

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=2893211281, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44

SEC-HO-VGATEWAY01#:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=1, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=6473215943

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=6473215943

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling

SEC-HO-VGATEWAY01#Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.165: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=6473215943

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=6473215943

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.169: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=2893211281, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=P

SEC-HO-VGATEWAY01#EER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_VIA_URI; URI=sip:184.75.215.114:5060

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=1 Is Matched

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_VIA_URI; Incoming Dial-peer=1

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpAssociateIncomingPeerSPI:exit@6655

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.169: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=2893211281, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=2893211281, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=2893211281

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=2893211281

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Re

SEC-HO-VGATEWAY01#sult=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=2893211281, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=2893211281

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=2893211281

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.173: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=1, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.173: //-1/5F20307A81F3/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=2893211281, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=1, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=6473215943

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=6473215943

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=6473215943

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=6473215943

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.437: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=2893211281, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_VIA_URI; URI=sip:184.75.215.114:5060

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=1 Is Matched

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_VIA_URI; Incoming Dial-peer=1

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.437: //-1/5F49B07481FA/DPM/dpAssociateIncomingPeerSPI:exit@6655

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/MatchNextPeer:

SEC-HO-VGATEWAY01# Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.441: //-1/5F49B07481FA/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=2893211281, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=2893211281, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=2893211281

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=2893211281

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=2893211281, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=2893211281

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=2893211281

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.441: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=0, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.445: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Calling Number=, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=1, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.445: //-1/5F49B07481FA/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.693: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Calling Number=2893211281, Called Number=2893211281, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.693: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=2893211281

*Dec 16 14:44:16.693: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=2893211281, Expanded String=2893211281, Calling Number=2893211281T

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.693: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.693: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.693: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=1, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=6473215943

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=6473215943

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16

SEC-HO-VGATEWAY01#14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Calling Number=6473215943, Called Number=, Voice-Interface=0x0,

   Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,

   Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ANSWER; Calling Number=6473215943

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Result=-1

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Match Rule=DP_MATCH_ORIGINATE; Calling Number=6473215943

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:

   Is Incoming=TRUE, Number Expansion=FALSE

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchCore:

   Dial String=, Expanded String=, Calling Number=6473215943T

   Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/MatchNextPeer:

   Result=Success(0); Incoming Dial-peer=101 Is Matched

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchPeertype:exit@6076

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=101

*Dec 16 14:44:16.697: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin:

   dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0

*Dec   16 14:44:16.697:   //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeer:exit@6704 Dial   String=2893211281, Expanded String=2893211281, Calling Number=

   Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH

*Dec 16 14:44:16.701: //-1/5F70C0688201/DPM/MatchNextPeer:

   Result=Success(0); Outgoing Dial-peer=101 Is Matched

*Dec 16 14:44:16.701: //-1/5F70C0688201/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

*Dec 16 14:44:16.701: //-1/5F70C0688201/DPM/dpMatchSafModulePlugin:

   dialstring=2893211281, saf_enabled=1, saf_dndb_lookup=1, dp_result=0

*Dec 16 14:44:16.701: //-1/5F70C0688201/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=101

DEBUG CCSIP ALL

*Dec   16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpIPv4SocketReads:   Msg enqueued for SPI with IP addr: [184.75.215.114]:5060,   local_address:[64.187.178.132]

*Dec 16 06:56:19.627:   //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event:   ccsip_spi_get_msg_type returned: 2 for event 1

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x408C10E8

*Dec   16 06:56:19.627:   //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg:   gConnTab=0x408C10E8, addr=184.75.215.1

SEC-HO-VGATEWAY01#14, port=5060, local_addr=64.187.178.132, connid=3, transport=UDP

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/sipHolderGetConnInstance: Return existing connection for port 5060 connId 3

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

INVITE sip:2893211281@64.187.178.132 SIP/2.0

Via: SIP/2.0/UDP 184.75.215.114:5060;branch=z9hG4bK29e50406;rport

Max-Forwards: 70

From: "6473215943" <sip:6473215943@184.75.215.114>;tag=as0ef7e899

To: <sip:2893211281@64.187.178.132>

Contact: <sip:6473215943@184.75.215.114:5060>

Call-ID: 63e5ab0b6e4ce5d3427bfa7c10e46a49@184.75.215.114:5060

CSeq: 102 INVITE

User-Agent: voip.ms

Date: Mon, 16 Dec 2013 06:58:12 GMT

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH

Supported: replaces, timer

Remote-Party-ID: "6473215943" <sip:6473215943@184.75.215.114>;party=calling;privacy=off;screen=no

Content-Type: application/sdp

Content-Length: 274

v=0

o=root 1354162751 1354162751 IN IP4 184.75.215.114

s=voip.ms

c=IN IP4 184.75.215.114

t=0 0

m=audio 13254 RTP/AVP 0 18 101

a=rtpmap:0 PCMU/8000

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

a=sendrecv

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x

SEC-HO-VGATEWAY01#40CA2A48) with key=[24] to table

*Dec 16 06:56:19.627: //-1/000000000000/SIP/Info/ccsip_offer_ans_init:

*Dec 16 06:56:19.627: //-1/000000000000/SIP/Info/ccsip_iwf_init: 

*Dec 16 06:56:19.627: //-1/000000000000/SIP/Info/ccsip_ipip_media_service_init:

*Dec 16 06:56:19.627: //-1/000000000000/SIP/Info/sipSPI_ipip_vcc_Initialization:  Entry...

*Dec 16 06:56:19.627: //-1/000000000000/SIP/Info/ccsip_ipip_media_forking_init: MF: Queue is initialised..

*Dec   16 06:56:19.627:   //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog   Transaction Address 184.75.215.114,Port 5060, Transport 1, SentBy Port   5060

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 64.187.178.132 for SIP

*Dec 16 06:56:19.627: //-1/000000000000/SIP/Info/resolve_sig_ip_address_to_bind: signaling bind address : 64.187.178.132

*Dec   16 06:56:19.627: //-1/00347728803E/SIP/State/sipSPIChangeState:   0x40CA2A48 : State change from (STATE_NONE, SUBSTATE_NONE)  to   (STATE_IDLE, SUBSTATE_NONE)

*Dec 16 06:56:19.627:   //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog   Transaction Address 184.75.215.114,Port 5060, Transport 1, SentBy Port   5060

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT

*Dec   16 06:56:19.627:   //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog   Transaction Address 184.75.215.114,Port 5060, Transport 1, SentBy Port   5060

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPICheckAssertedIdConfig: Dialpeer match is not yet done

*Dec 16 06:56:19.627: //-

SEC-HO-VGATEWAY01#1/00347728803E/SIP/Info/ccsip_ipip_media_forking_copy_prev_best_rpid:   MF: This rpid could/could not be best one..

*Dec 16  06:56:19.627:   //-1/00347728803E/SIP/Info/sipSPIUpdateCallingInfoUsingRpidOrFrom:   Updating Calling Info with RPID header data

*Dec 16 06:56:19.627:   //-1/00347728803E/SIP/Info/sipSPISetInfoFromRpid: Received current   remote name: 6473215943, current remote number: 6473215943

*Dec  16  06:56:19.627: //-1/00347728803E/SIP/Info/sipSPISetInfoFromRpid:   Received ;screen=no ;privacy=off -> Setting Octet3A 0x80,   extended_privacy 0x00

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPICheckAssertedIdConfig: Dialpeer match is not yet done

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentGTD: No GTD found in inbound container

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentCSTA: No CSTA found in inbound container

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIUaddCcbToUASReqTable: ****Adding to UAS Request table.

*Dec   16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIUaddCcbToTable:  Added  to table. ccb=0x40CA2A48   key=63e5ab0b6e4ce5d3427bfa7c10e46a49@184.75.215.114:50602893211281

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on carrier id

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on Incoming called number: 2893211281

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on destination pattern: 6473215943

*Dec   16 06:56:19.627:   //-1/00347728803E/SIP/Info/ccsipUpdateIncomingCallParams: ccCallInfo:   Calling name 6473215943, number 6473215943, Calling oct3 0x00, oct_3a   0x80, Called number 2893211281

*Dec 16 06:56:19.627:   //-1/00347728803E/SIP/Info/sipSPIGetViaHostInURLFormat: VIA   URL:sip:184.75.215.114:5060, Host:184.75.215.114

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetShrlPeer: Try match incoming dialpeer for Calling number: : 6473215943

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetFromCalledPartyId: P-Called-Party-ID header not found

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetPeerByCal

SEC-HO-VGATEWAY01#ledPartyId: P-Called-Party-ID not found or parse error

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: No match found for P-Called-Party-ID

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Peer tag 1 matched for incoming call

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header

*Dec 16 06:56:19.627: //-1/xxxxxxxxxxxx/SIP/Info/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 64.187.178.132 for SIP

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/resolve_sig_ip_address_to_bind: signaling bind address : 64.187.178.132

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: This call is being treated for E911

*Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Media Antitrombone disabled

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPISetMediaFlowMode: Storing the configured mode as FLOW-THROUGH

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPISetMediaFlowMode: xcoder high-density disabled

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPISetMediaFlowMode: Flow Mode set to FLOW_THROUGH

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Checking Video Type Rate=-1 video_codec_allowed=1F

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Media/sipSPICopyStunConfigFromPeerToCCB: Firewall traversal is not enabled

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIGetModemInfoPerCall: peer_callID=0

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Error/ccsip_ipip_media_forking_update_preferred_codec:

MF: Not a Forked SIP leg..

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Incoming: No defer BYE for last

                              call stats

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Media forking disabled

*Dec   16 06:56:19.631:   //-1/00347728803E/SIP/Info/ccsip_ipip_media_forking_anchor_leg_config:   MF: en_p->encap_s.voIP.voipPeerCfgMediaClass = 0

*Dec 16   06:56:19.631:   //-1/00347728803E/SIP/Info/ccsip_ipip_media_forking_anchor_leg_config:   MF: Dial-peer has no media class recorder.

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIMFChangeState: MF: Prev state = 0 & New state = -1

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/ccsip_ipip_media_forking_anchor_leg_reset: MF: Anchor leg config reset done...

*Dec   16 06:56:19.631: //-1/00347728803E/SIP/Info/ccsipInitDSCPPolicyInfo:  No  DSCP Profile configured, No RPH 2 DSCP Mapping and DSCP policing

*Dec 16 06:56:19.631: //

SEC-HO-VGATEWAY01#-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Initilise the DSCP policy

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPISetOverlapConfiguration: Overlap signaling: FALSE: Endpt: SIP Trunk

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPI_ipip_GetCopyListCfg: Copy-list config:2 tag:0

*Dec   16 06:56:19.631:   //-1/00347728803E/SIP/Info/sipSPI_ipip_build_consolidated_header_list:   Both passthru and copylist are disabled

*Dec 16 06:56:19.631:   //-1/00347728803E/SIP/Info/sipSPIContinueNewMsgInvite: Calling name   6473215943, number 6473215943, Calling oct3 0x00, oct_3a 0x80, ext_priv   0x00, Called number 2893211281, oct3 0x00

*Dec 16 06:56:19.631:   //-1/00347728803E/SIP/Info/sipSPIContinueNewMsgInvite: Carrier id code  ,  prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIValidateRequestUri: Not Enabled

*Dec 16 06:56:19.631: //-1/00347728803E/SIP/Info/sipSPIRscmsmAvail: Value returned by check is = 0

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_IsSDPPassthruEnabled:  - 0

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SESSION_REFRESH_REQ

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Event/Session-Timer/sipSTSLMain: dir:2, method:102, resp_code:0, container:3CFE25D8

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/Session-Timer/sipSTSLExtractSessionExpiresHdr:   Not received session expires header

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/Session-Timer/sipSTSLGetInternalSREvent: E_STSL_INITIAL_SR_REQ

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Event/Session-Timer/sipSTSLPrintTDContainer:   Peer-Event: E_STSL_LEG_BY_LEG, SE Value:0, SE Refresher:none, Min-SE   Value:1800, flags:2001

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/Session-Timer/sipSTSLMain:

        SE: 0;refresher:none peer refresher:none, flags:2001, posted event:E_STSL_INVALID_PEER_EVENT, reason:4

        Configured SE:1800, Configured Min-SE:1800

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIProcessHistoryInfoHeader: No HI headers recvd from app container

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIProcessDiversionHeader: No diversion headers recvd from app container

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIProcessReplacesHeader: No replaces hdr found

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIValidateConnectionAddress: Dest port = 13254

SIP: (31) Attribute mid, level 1 instance 1 not found.

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIValidateStreamAddrType: stream:1, Mode : 1

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 64.187.178.132 for SIP

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 64.187.178.132

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) reserved for codec No Codec  

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIUpdateD

SEC-HO-VGATEWAY01#ynamicPayloadunused: Unreserving dynamic payload type 96

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) could not be reserved

                          as its in use by other codec No Codec  

*Dec   16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIUpdateDynamicPT:   Requested payload-Type (101) is  reserved by another application

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 98

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 101

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAllocateFreeDynamicPT: Allocating free Dynamic Payload : 98 for Codec:

*Dec   16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIDoAudioNegotiation:   Codec (g711ulaw) Negotiation Successful on Static Payload for m-line 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIDoPtimeNegotiation: One ptime attribute found - value:20

*Dec   16 06:56:19.631:   //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec:   g711ulaw ptime :20, codecbytes: 160

*Dec 16 06:56:19.631:   //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec:   g711ulaw codecbytes :160, ptime: 20

*Dec 16 06:56:19.631:   //31/00347728803E/SIP/Media/sipSPIDoPtimeNegotiation: Offered ptime:20,   Negotiated ptime:20 Negotiated codec bytes: 160 for codec g711ulaw

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPISetFaxFlags: FAX_PASSTHROUGH = 0, END_FAX_PASSTHROUGH = 0

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIDoDTMFRelayNegotiation: m-line index 1

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) reserved for codec

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) reserved for codec

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 98

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIReserveRtpNtePayload: Reserved the payload type 101 for RTP-NTE

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIDoDTMFRelayNegotiation: RTP-NTE DTMF relay option

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPIDoDTMFRelayNegotiation: Case of full   named event(NE) match in fmtp list of events.

*Dec 16   06:56:19.631:   //-1/xxxxxxxxxxxx/SIP/Info/sip_sdp_get_modem_relay_cap_params: V150 NSE   payload = 0, SSE payload = 0, SPRT payload=0

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPIGetSDPDirectionAttribute: No direction   attribute present or multiple direction attributes that can't be  handled  for m-line:1 and num-a-lines:0

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1

        payload_type=0, codec_bytes=160, codec=g711ulaw, dtmf_relay=rtp-nte

        stream_type=voice+dtmf (1), dest_ip_address=184.75.215.114, dest_port=13254

*Dec   16 06:56:19.631: //31/00347728803E/SIP/State/sipSPIChangeStreamState:   Stream (callid =  -1)  State changed from (STREAM_DEAD) to   (STREAM_ADDING)

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Media/sipSPIUpdCallWithSdpInfo:

        Preferred Codec        : transparent, bytes

        Preferred  DTMF relay  : rtp-nte

        Preferred NTE payload  : 101

        Early Media            : No

        Delayed Media          : No

        Bridge Done            : No

        New Media              : No

        DSP DNLD Reqd          : No

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPIValidateStreamAddrType: stream:1, Mode : 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/resol

SEC-HO-VGATEWAY01#ve_media_ip_address_to_bind: Media already bound, use existing source_media_ip_addr

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 64.187.178.132

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/ccsip_offer_ans_handle_rcvd_sdp:

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/ccsip_offer_ans_process_event:

*Dec   16 06:56:19.631: //31/00347728803E/SIP/State/ccsip_cnfsm_debugs:   OA:cur_container:ccsip_offer_ans_main_container,   cur_state:S_SIP_EARLY_DIALOG_IDLE, event:E_SIP_INVITE_SDP_RCVD

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/ccsip_offer_ans_is_invite_offer_valid:  - 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/ccsip_offer_ans_common_offer_rcvd_hdlr:

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/ccsip_iwf_handle_network_event:

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/ccsip_iwf_process_event: 

*Dec   16 06:56:19.631: //31/00347728803E/SIP/State/ccsip_cnfsm_debugs:   IWF:cur_container:sip_iwf_default_early_dialog_container,   cur_state:S_SIP_IWF_SDP_IDLE, event:E_SIP_IWF_EV_RCVD_SDP

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_def_ed_rcvd_sdp_hdlr:

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo:

CallID 31, sdp 0x3D0DF898 channels 0x40CA41A4

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/copy_channels:

callId 31 size 0 ptr 0x40993DD8)

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_copy_and_init_channelInfo_params:

CCB t38 version 0 ipip_caps version 0

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_copy_and_init_channelInfo_params:

CCB fax rate 2 ipip_caps rate 14400

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo:   stream_callid = 31, peer_stream_callid = -1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo:

Hndl ptype 0 mline 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: Selecting codec g711ulaw

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/codec_found:

Codec to be matched: 5

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 5

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_update_codec_params_in_channelInfo:

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPI_ipip_update_codec_params_in_channelInfo:   Parsing from stream media address

*Dec 16 06:56:19.631:   //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec:   g711ulaw codecbytes :160, ptime: 20

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_update_codec_params_in_channelInfo:

Adding negotiated codec 5 ptype 0 time 20,   bytes 160 as channel 0 mline 1 ss 1 184.75.215.114:13254

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Error/sipSPI_ipip_update_codec_params_in_channelInfo:

failed to update call entry

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: Media   negotiation done:   stream->negotiated_ptime=20,stream->negotiated_codec_bytes=160,stream->mline_index=1,   media_ndx=1

*Dec 16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPIBwCacCalcAudioBandwidth: calculated   audio bandwidth : codec g711ulaw      bw 64000

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo:

Hndl ptype 18 mline 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: Selecting codec g729r8

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/codec_found:

Codec to be matched: 16

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 16

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_update_codec_params_in_channelInfo:

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPI_ipip_update_codec_params_in_channelInfo:   Parsing from stream media address

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_GetCodecBytePtimeFromSdp:

*Dec 16 06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g729r8 ptime :20, codecbytes: 20

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_GetCodecBytePtimeFromSdp: Codec bytes 0, use default packet rate 20

*Dec 16 06:56:19.631: //31/003

SEC-HO-VGATEWAY01#47728803E/SIP/Info/sipSPI_ipip_update_codec_params_in_channelInfo:

Adding negotiated codec 16 ptype 18 time 20,   bytes 20 as channel 1 mline 1 ss 1 184.75.215.114:13254

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Error/sipSPI_ipip_update_codec_params_in_channelInfo:

failed to update call entry

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPIBwCacCalcAudioBandwidth: calculated   audio bandwidth : codec g729r8        bw 8000

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo:

Hndl ptype 101 mline 1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_update_dynamic_codec_params:

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sipSPI_ipip_upd_2833_dtmf_params:

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sipSPI_ipip_upd_2833_dtmf_params: setting   ipip_caps DTMF to RFC2833: callid = 31, dtmf = 6

*Dec 16   06:56:19.631: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime:   Values :Codec: g711ulaw codecbytes :160, ptime: 20

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Error/sipSPI_ipip_update_call_entry:

failed to update call entry

*Dec   16 06:56:19.631:   //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: Copy  sdp  to channel- AFTER CODEC FILTERING:   ccb->pld.ipip_caps.codecInfo[0].codec = 5

*Dec 16  06:56:19.631:   //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: Copy   sdp to channel- AFTER CODEC FILTERING:   ccb->pld.ipip_caps.codecInfo[1].codec = 16

*Dec 16   06:56:19.631:   //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: Copy  sdp  to channel- AFTER CODEC FILTERING:   ccb->pld.ipip_caps.codecInfo[2].codec = -1

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo: srcChannelID = -1, dstChannelID = 31

*Dec 16 06:56:19.631: //31/00347728803E/SIP/Media/sipSPIDisplayStreamInfo:

          Stream type            : voice+dtmf

          Media line             : 1

          State                  : STREAM_ADDING (2)

          Stream address type    : 1

          Callid                 : 31

          Peer Callid            : -1

          RTP/SRTP Negotiated     : 8

          Negotiated Codec       : g711ulaw, bytes :160

          Nego. Codec payload    : 0 (tx), 0 (rx)

          Negotiated DTMF relay  : rtp-nte

          Negotiated NTE payload : 101 (tx), 101 (rx)

          Negotiated CN payload  : 0

          Media Srce Addr/Port   : [64.187.178.132]:0

          Media Dest Addr/Port   : [184.75.215.114]:13254

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_calculate_channel_count: Number of streams to report = 1

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Error/sipSPI_ipip_set_channel_count:

Unable to set CHANNEL_COUNT for callid 31

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Error/sip_iwf_sip_copy_sdp_to_channelInfo:

Channel count is not set at this point. Not SIP-SIP or SET_MODE is not done.

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sip_iwf_sip_copy_sdp_to_channelInfo:   sdp->chnl audio bw 80000 bps video bw 0 bps fax bw 0 bps

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sip_iwf_def_ed_rcvd_sdp_hdlr: Setting media_direction to 4

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sipSPIBwCacUpdateAccountedBw: bwcac update   accounted BW Option 0 flow mode flow-through

audio bw 80000 bps video bw 0 bps fax bw 0 bps total bw 80000 bps  accounted bw 0 bps

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIBwCacUpdateInterfaceBw: bwcac acquiring interface Loopback0 bw 80

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sipSPIBwCacUpdateAccountedBw: bwcac update   accounted bw (initial offer) accounted bw set to 80000

*Dec 16 06:56:19.635: //31/00347728803E/SIP/State/ccsip_cnfsm_debugs: IWF:next_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT

*Dec 16 06:56:19.635: //31/00347728803E/SIP/State/ccsip_cnfsm_debugs: OA:next_state:S_SIP_EARLY_DIALOG_OFFER_RCVD

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Media/sipSPIUpdCallWithSdpInfo:

          Stream type            : voice+dtmf

          Media line             : 1

          State                  : STREAM_ADDING (2)

          Stream address type    : 1

          Callid                 : 31

          Negotiated Codec       : g711ulaw, bytes :160

          Nego. Codec payload    : 0 (tx), 0 (rx)

          Negotiated DTMF relay  : rtp-nte

          Negotiated NTE payload : 101 (tx), 101 (rx)

          Negotiated CN payload  : 0

          Media Srce Addr/Port   : [64.187.178.132]:0

          Media Dest Addr/Port   : [184.75.215.114]:13254

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIHandleInviteMedia:

Negotiated Codec       : g711ulaw, bytes :160

Preferred Codec        : transparent, bytes

Preferred  DTMF relay 1 : 6

Preferred  DTMF relay 2 : 0

Negotiated DTMF relay   : 6

Preferred and Negotiated NTE payloads: 101 101

Preferred and Negotiated NSE payloads: 100 0

Preferred and Negotiated Modem Relay: 0 0

Preferred and Negotiated V150.1 Modem Passthrough: 0 0

Preferred

SEC-HO-VGATEWAY01#and Negotiated V150.1 Modem Relay: 0 0

Preferred and Negotiated Modem Relay GwXid: 1 0

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIBwCacIsDialPeerBwAvailable: bwcac NOP dial-peer bw available tag 1

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIBwCacIsInterfaceBwAvailable: bwcac interface bw threshold not configured

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sipSPIBwCacVerifyBwThreshold: bwcac verify  bw  threshold, bw available allow call total bw 80000 bps

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIDoQoSNegotiationWithMediaLine: QOS negotiation for mline_index 1

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIDoStreamQoSNegotiation: Best effort

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 16418 for stream 1

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUpdateSrcSdpFixedPart: Reserving rtp port for stream 1, src_port=16418

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 16418

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUpdateSrcSdpVariablePart:

SIP update src sdp, negoitated codec 5, payload type 0

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Negotiated method of dtmf relayand pyld: 6 101

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUpdateSrcSdpVariablePart: max_event 16

*Dec   16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIAddBillingInfoToCcb:   sipCallId for billing records =   63e5ab0b6e4ce5d3427bfa7c10e46a49@184.75.215.114:5060

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentCPA: No CPA found in inbound container

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIProcessCPA: No x-cisco-cpa content found

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sipSPI_ipip_ExtractPassthruCopyListHdrsFromSipContainer:   Unsupported header passthru is not configured and no headers are   present in hdr_hash_queue

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_IsContentPassthruEnabled:  - 0

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sipSPI_ipip_ExtractPassthruContentFromSipContainer:   Passthru Content Not Enabled

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/ccsip_api_call_setup_ind: Unable to add unsupp headers to container

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/ccsip_api_call_setup_ind: Set Protocol information

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/ccsip_ipip_media_service_get_event_data: Event id = 26

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_antiTrombone: Entered Antitrombone service

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/ccsip_api_call_setup_ind: Setting media_direction to 4

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_store_channel_info: Store channelInfo in CallInfo

*Dec   16 06:56:19.635:   //31/00347728803E/SIP/Info/sipSPI_ipip_store_channel_info: dtmf   negotiation done, storing negotiated dtmf = 6,

*Dec 16   06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_store_config_info:   Setting mid_call_config_info = 0x0 for callid = 31

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Media/sipSPIDisplayStreamInfo:

          Stream type            : voice+dtmf

          Media line             : 1

          State                  : STREAM_ADDING (2)

          Stream address type    : 1

          Callid                 : 31

          Peer Callid            : -1

          RTP/SRTP Negotiated     : 8

          Negotiated Codec       : g711ulaw, bytes :160

          Nego. Codec payload    : 0 (tx), 0 (rx)

          Negotiated DTMF relay  : rtp-nte

          Negotiated NTE payload : 101 (tx), 101 (rx)

          Negotiated CN payload  : 0

          Media Srce Addr/Port   : [64.187.178.132]:16418

          Media Dest Addr/Port   : [184.75.215.114]:13254

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_calculate_channel_count: Number of streams to report = 1

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPI_ipip_store_channel_info: Setting CHANNEL_COUNT = 1 for callid 31

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIShrlCall: Check peer: 1 for Shared-Line call, callid: 31

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/ccsip_set_bearer_capability:

   Bearer Capability: Speech (0x00)

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentQSIG: No QSIG Body found in inbound container

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentQ931: No RawMsg Body found in inbound container

*Dec 16 06:56:19.635: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateNewRawMsg: No Data to form The Raw Message

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIContinueNewMsgInvite: ccsip_api_call_setup_ind returned: SIP_SUCCESS

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 1F to table

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Info/sipSPIUpdateCallEntry:

Call 31 set InfoType to SPEECH

*Dec 16 06:56:19.635: //31/00347728803E/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SESSION_REFRESH_RESPACK

SEC-HO-VGATEWAY01# sip:2893211281@64.187.178.132 SIP/2.0

Via: SIP/2.0/UDP 184.75.215.114:5060;branch=z9hG4bK29e50406;rport

Max-Forwards: 70

From: "6473215943" <sip:6473215943@184.75.215.114>;tag=as0ef7e899

To: <sip:2893211281@64.187.178.132>;tag=2256B8-227B

Contact: <sip:6473215943@184.75.215.114:5060>

Call-ID: 63e5ab0b6e4ce5d3427bfa7c10e46a49@184.75.215.114:5060

CSeq: 102 ACK

User-Agent: voip.ms

Content-Length: 0

*Dec 16 06:56:21.007: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog

*Dec 16 06:56:21.007: //-1/xxxxxxxxxxxx/SIP/Error/sipSPISipIncomingMsg:

Invalid method for (STATE_IDLE): ACK

Everyone's tags (5)
1 ACCEPTED SOLUTION

Accepted Solutions
VIP Super Bronze

Unable to match incoming calls to a dialpeer

From the logs, we can see that your call is matching dial-peer 1

Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Peer tag 1 matched for incoming call

Dec 16 06:56:19.631:   //-1/00347728803E/SIP/Info/sipSPIContinueNewMsgInvite: Calling name   6473215943, number 6473215943, Calling oct3 0x00, oct_3a 0x80, ext_priv   0x00, Called number 2893211281, oct3 0x00

This is the config on dial-peer 1..

dial-peer voice 1 voip

session protocol sipv2

incoming uri via 1001

dtmf-relay rtp-nte

codec transparent

no vad

Here is what I think is going on..The incoming URI command takes precedence over incoming called number, hence the reason why this dial-peer is matched...Try and remove the incoming URI command on this dial-peer and test again

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts "The essence of christianity is not the enthronement but the obliteration of self --William Barclay"
5 REPLIES
Hall of Fame Super Silver

Unable to match incoming calls to a dialpeer

How about if you change

dial-peer voice 501 voip

incoming called-number .

to

incoming called-number .T

or move dial peer 501 before 101, delete and re-add dial peer 101?

Chris

New Member

Unable to match incoming calls to a dialpeer

Hi Chris,

I have tried it with all possible ways. i.e. .T and .* and also 2893211... etc but nothing seems to be working. I am going to give your other suggestion a try in a little bit and will update you. Thanks for the reply.

Regards,

Ajlal

New Member

Unable to match incoming calls to a dialpeer

Hi Chris,

I tried removing and adding back the dialpeer 101 and adding .T to 501 but still the same result. Please help.

Please see the following:

SEC-HO-VGATEWAY01#show dial-peer voice summ        

dial-peer hunt 1

             AD                                    PRE PASS                OUT

TAG    TYPE  MIN  OPER PREFIX    DEST-PATTERN      FER THRU SESS-TARGET    STAT PORT    KEEPALIVE

501    voip  up   up                                0  syst                    

1001   voip  up   up             5...               1  syst ipv4:10.13.14.21   

1002   voip  up   up             1...$              1  syst ipv4:10.13.14.21   

103    voip  up   up             911$               1  syst dns:toronto2.voip.ms

102    voip  up   up             1[2-9]..[2-9]...-  1  syst dns:toronto2.voip.ms

                                 ...$

101    voip  up   up             [2-9]..[2-9]....-  1  syst dns:toronto2.voip.ms

                                 ..$

SEC-HO-VGATEWAY01#show run | sec dial-peer voice 501

dial-peer voice 501 voip

incoming called-number .T

voice-class sip bind control source-interface Loopback0

voice-class sip bind media source-interface Loopback0

dtmf-relay rtp-nte

codec g711ulaw

no vad

VIP Super Bronze

Unable to match incoming calls to a dialpeer

From the logs, we can see that your call is matching dial-peer 1

Dec 16 06:56:19.627: //-1/00347728803E/SIP/Info/sipSPIGetCallConfig: Peer tag 1 matched for incoming call

Dec 16 06:56:19.631:   //-1/00347728803E/SIP/Info/sipSPIContinueNewMsgInvite: Calling name   6473215943, number 6473215943, Calling oct3 0x00, oct_3a 0x80, ext_priv   0x00, Called number 2893211281, oct3 0x00

This is the config on dial-peer 1..

dial-peer voice 1 voip

session protocol sipv2

incoming uri via 1001

dtmf-relay rtp-nte

codec transparent

no vad

Here is what I think is going on..The incoming URI command takes precedence over incoming called number, hence the reason why this dial-peer is matched...Try and remove the incoming URI command on this dial-peer and test again

Please rate all useful posts

"opportunity is a haughty goddess who waste no time with those who are unprepared"

Please rate all useful posts "The essence of christianity is not the enthronement but the obliteration of self --William Barclay"
New Member

Re: Unable to match incoming calls to a dialpeer

Hi Aokanlawon and Chris,

First of all, thanks a lot for your help. I figured out what the problem was. The reply of Aokanlawon pointed me in the right direction. As Aokanlawon suggested the dial peer 1 was getting matched for the incoming calls as the INCOMING URI command was taking precedence over the INCOMING CALLED-NUMBER . command in the dialpeer 501, however, when I had the DEBUG VOICE DIALPEER ALL on it was only showing dialpeer 101 as the match and that is what created all the confusion. At the same time the DEBUG CCSIP ALL was showing that dialpeer 1 was matching the incoming calls.

So I tought that maybe the incoming dialpeer match is not being showed in the dialpeer debug but it is actually matching. So I got rid of the dialpeer 1 and only kept dialpeer 501 for incoming and also applied the translation rule that converted the incoming called number to a 4 digit extention. The did the trick and the calls started routing.

So to summarize, the incoming dialpeer match is not showed in the DEBUG VOICE DIALPEER ALL only the outbound dialpeer is showed. So when I configured the translation profile on the incoming dialpeer 501 it started showing the output dialpeer to the CUCM as well and that is how it routed the call.

If anyone needs any help with this issue in future or if something is not clear in my explanation please contact me at ajlalhaider13@gmail.com

Regards,

AJ

1141
Views
0
Helpful
5
Replies
CreatePlease login to create content