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

H323 Call Routing - 911

I'm missing something here in this config....

If we dial 10 digits the call goes out the FXO port just fine, 911 gives us a fast-busy.

configs below along w/ the debugs..   weird thing is on the 911 call it appears to be changing the called number and calling number....

config:

Current configuration : 6529 bytes

!

version 12.4

no service pad

service tcp-keepalives-in

service tcp-keepalives-out

service timestamps debug datetime msec localtime show-timezone

service timestamps log datetime msec localtime show-timezone

no service password-encryption

service sequence-numbers

!

hostname Ball

!

boot-start-marker

boot-end-marker

!

logging message-counter syslog

logging buffered 300000

logging console critical

enable secret 5 $1$jQUY$SdW8OgOkgDnXH5Au5GHhQ1

!

no aaa new-model

!

crypto pki trustpoint tti

revocation-check crl

rsakeypair tti

!

crypto pki trustpoint TP-self-signed-1275929792

enrollment selfsigned

subject-name cn=IOS-Self-Signed-Certificate-1275929792

revocation-check none

rsakeypair TP-self-signed-1275929792

!

!

crypto pki certificate chain tti

crypto pki certificate chain TP-self-signed-1275929792

certificate self-signed 01

  3082024C 308201B5 A0030201 02020101 300D0609 2A864886 F70D0101 04050030

  31312F30 2D060355 04031326 494F532D 53656C66 2D536967 6E65642D 43657274

  69666963 6174652D 31323735 39323937 3932301E 170D3131 30373132 31343435

  30305A17 0D323030 31303130 30303030 305A3031 312F302D 06035504 03132649

  4F532D53 656C662D 5369676E 65642D43 65727469 66696361 74652D31 32373539

  32393739 3230819F 300D0609 2A864886 F70D0101 01050003 818D0030 81890281

  8100DC3D CA074470 922DDB00 BFB8479C C2C985E5 E7E607BC 29E29426 DAC68DEF

  4B1106F7 0F22EA07 F78BCF41 5F5CA342 BB764BDE 1A1B7EB8 7AF1FD1F BD0BF0B9

  96B23428 2D6C8E45 11E70E92 D45B3728 00F7082F 508FC058 04AF32A8 7E3D6EB4

  F9270627 B9C42F20 9416C6A9 E8991EC7 CBE2A237 3F676A05 E326EBBC 9C215598

  830F0203 010001A3 74307230 0F060355 1D130101 FF040530 030101FF 301F0603

  551D1104 18301682 1442616C 6C2E6462 69736572 76696365 732E636F 6D301F06

  03551D23 04183016 8014A288 03701404 59072011 4EB37AE7 96DFDF08 38DB301D

  0603551D 0E041604 14A28803 70140459 0720114E B37AE796 DFDF0838 DB300D06

  092A8648 86F70D01 01040500 03818100 470493CF 9EA0F433 DC15C2D9 EA288D43

  1F6CFAB6 373286EA 40E9166E C394604B 9A283227 B0A53F55 F5854EB7 5FB7285B

  EB2CEBFB 5C6160C0 CD488F10 BF46BE7C 995B10F9 1A510C8D 97DE8E6F 65843DEA

  61E84252 45980509 318F8398 3800C9FF B448A42C 44A4AB42 A4B05A1A E44CB646

  43886F38 D09EE75A DA1082A9 C0CBEC43

        quit

no ip source-route

!

!

no ip dhcp use vrf connected

ip dhcp excluded-address 10.4.3.250 10.4.3.254

!

ip dhcp pool Ball-Voice

   network 10.4.3.128 255.255.255.128

   default-router 10.4.3.129

   dns-server 10.0.1.52 10.0.1.39

   option 150 ip 10.0.100.13 10.0.100.12

   domain-name dbiservices.com

!

!

ip cef

no ip bootp server

no ip domain lookup

ip domain name dbiservices.com

!

no ipv6 cef

!

!

multilink bundle-name authenticated

!

!

!

voice service voip

h323

!

!

voice class codec 1

codec preference 1 g711ulaw

codec preference 2 g729r8

!

voice-card 0

codec complexity high

!

!

!

!

!

!

crypto ipsec client ezvpn EzVPN

connect auto

group RemoteOffice key dBiVPN$123

mode network-extension

peer 64.111.143.34

username Pineville password dbi$vpn@cc355

xauth userid mode local

!

!

archive

log config

  hidekeys

!

!

ip tcp synwait-time 10

ip ftp source-interface Vlan40

ip ftp username cisco

ip ftp password cisco

!

class-map match-any voice-signaling

match  dscp cs3

match  dscp af31

class-map match-any voice-traffic

match  dscp ef

match  dscp cs5

!

!

policy-map LAN-QOS

class voice-traffic

  set dscp ef

    priority percent 10

class voice-signaling

  set dscp cs3

policy-map WAN-QOS

class voice-traffic

    priority percent 25

  set dscp ef

class voice-signaling

    bandwidth 64

  set dscp cs3

!

!

!

!

!

interface FastEthernet0

switchport access vlan 40

switchport voice vlan 41

!

interface FastEthernet1

switchport access vlan 40

switchport voice vlan 41

spanning-tree portfast

!

interface FastEthernet2

switchport access vlan 40

switchport voice vlan 41

!

interface FastEthernet3

switchport access vlan 40

switchport voice vlan 41

!

interface FastEthernet4

description $ES_WAN$

ip address dhcp

no ip redirects

no ip unreachables

no ip proxy-arp

ip flow ingress

ip nat outside

ip virtual-reassembly

duplex auto

speed auto

crypto ipsec client ezvpn EzVPN

!

interface Vlan1

no ip address

!

interface Vlan40

ip address 10.4.3.1 255.255.255.128

ip helper-address 10.0.1.20

no ip redirects

no ip unreachables

no ip proxy-arp

ip flow ingress

ip nat inside

ip virtual-reassembly

ip tcp adjust-mss 1452

crypto ipsec client ezvpn EzVPN inside

!

interface Vlan41

ip address 10.4.3.129 255.255.255.128

ip nat inside

ip virtual-reassembly

crypto ipsec client ezvpn EzVPN inside

!

ip forward-protocol nd

ip route 0.0.0.0 0.0.0.0 192.168.99.254

ip route 0.0.0.0 0.0.0.0 dhcp

ip http server

ip http access-class 23

ip http authentication local

ip http secure-server

ip http timeout-policy idle 60 life 86400 requests 10000

!

!

!

logging trap debugging

access-list 23 permit 10.10.10.0 0.0.0.7

access-list 23 permit 10.0.0.0 0.255.255.255

snmp-server community D3Ang3loSnMp_Pub RO 61

snmp-server community D3Ang3loSnMp_Priv RW 61

snmp-server location DeAngelo Brothers Ball LA

snmp-server contact DeAngelo Brothers IT Dept.

snmp-server enable traps tty

!

!

!

!

!

control-plane

!

!

voice-port 0

!

voice-port 1

!

voice-port 2

!

voice-port 3

!

voice-port 4

connection plar 4300

caller-id enable

!

ccm-manager fallback-mgcp

no ccm-manager fax protocol cisco

!

no mgcp package-capability res-package

no mgcp package-capability fxr-package

no mgcp timer receive-rtcp

!

sccp local Vlan41

sccp ccm 10.0.100.12 identifier 2 priority 2 version 5.0.1

sccp ccm 10.0.100.13 identifier 1 priority 1 version 5.0.1

sccp

!

sccp ccm group 1

bind interface Vlan41

associate ccm 1 priority 1

associate profile 1 register Ball881

!

!

!

dial-peer voice 201010 voip

preference 1

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.13

dtmf-relay h245-alphanumeric

!

dial-peer voice 200010 voip

preference 2

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.12

dtmf-relay h245-alphanumeric

!

dial-peer voice 100 pots

preference 1

destination-pattern .T

port 4

!

!

!

Call attempts, to a 10 digit # and to 9,911

Ball#debug voip dialpeer

voip dialpeer default debugging is on

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#debug h225 q931

H.225 Q931 IE Details debugging is on

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#term mon

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x012C

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020                                            002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F                                            43616C6C4D616E61676572003100010100C44000229CAF3D6621302C01B2020A04038200D50D800007000A00640D                                            06B8110000229CAF3D6621302C01B2020A040382010001000100010010A00100140140B50000120D820400200400                                            01030003000103

000131: *Feb 17 19:44:13.092 UTC: //-1/00229CAF2C01/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000132: *Feb 17 19:44:13.092 UTC: //-1/00229CAF2C01/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000133: *Feb 17 19:44:13.092 UTC: //-1/00229CAF2C01/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000134: *Feb 17 19:44:13.092 UTC: //-1/00229CAF2C01/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000135: *Feb 17 19:44:13.096 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersCore:

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

000136: *Feb 17 19:44:13.096 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000137: *Feb 17 19:44:13.096 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000138: *Feb 17 19:44:13.096 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000139: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000140: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000141: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000142: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000143: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000144: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000145: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000146: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000147: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000148: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000149: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000150: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000151: *Feb 17 19:44:13.096 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000152: *Feb 17 19:44:13.100 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000153: *Feb 17 19:44:13.100 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersCore:

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

000154: *Feb 17 19:44:13.100 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000155: *Feb 17 19:44:13.100 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000156: *Feb 17 19:44:13.100 UTC: //-1/00229CAF2C01/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812C

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC5634E5110C110000229CAF3D6621302C01                                            B2020A0403820100010010800100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812C

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A00041100110000229CAF3D6621302C01B2020A04038210800100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x012D

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020                                            002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F                                            43616C6C4D616E61676572003100010100C4400030C3B6496621302D01B3020A04038200D50D800007000A00640D                                            06B811000030C3B6496621302D01B3020A040382010001000100010010A00100140140B50000120D820400200400                                            01030003000103

000157: *Feb 17 19:44:25.124 UTC: //-1/0030C3B62D01/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000158: *Feb 17 19:44:25.124 UTC: //-1/0030C3B62D01/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000159: *Feb 17 19:44:25.124 UTC: //-1/0030C3B62D01/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000160: *Feb 17 19:44:25.124 UTC: //-1/0030C3B62D01/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000161: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersCore:

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

000162: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000163: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000164: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000165: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000166: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000167: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000168: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000169: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000170: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000171: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000172: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000173: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000174: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000175: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000176: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000177: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000178: *Feb 17 19:44:25.128 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000179: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersCore:

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

000180: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

000181: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000182: *Feb 17 19:44:25.128 UTC: //-1/0030C3B62D01/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812D

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56B2EA110C11000030C3B6496621302D01                                            B3020A0403820100010010800100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812D

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A0004110011000030C3B6496621302D01B3020A04038210800100

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x012E

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=6

Data 008134333030

Called Party Number: Length Of IE=12

Data 803133313838343036363337

User-User: Length Of IE=192

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010500464BB73996A0004955D9836621302E01B4020A04038200D50D800007000A00640D06B81100004955D9836621302E01B4020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

000183: *Feb 17 19:45:23.436 UTC: //-1/004955D92E01/DPM/dpAssociateIncomingPeerCore:

   Calling Number=4300, Called Number=13188406637, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000184: *Feb 17 19:45:23.436 UTC: //-1/004955D92E01/DPM/dpAssociateIncomingPeerCore:

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

000185: *Feb 17 19:45:23.436 UTC: //-1/004955D92E01/DPM/dpAssociateIncomingPeerCore:

   Calling Number=4300, Called Number=13188406637, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000186: *Feb 17 19:45:23.436 UTC: //-1/004955D92E01/DPM/dpAssociateIncomingPeerCore:

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

000187: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

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

000188: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=13188406637

000189: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000190: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000191: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000192: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=13188406637

000193: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000194: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000195: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000196: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=13188406637

000197: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000198: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000199: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

000200: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

000201: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

000202: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=13188406637

000203: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000204: *Feb 17 19:45:23.440 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

000205: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

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

000206: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=13188406637

000207: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

000208: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812E

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56E28E110C1100004955D9836621302E01B4020A0403820100010010800100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812E

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A000411001100004955D9836621302E01B4020A04038210800100

Ball#

Ball#

Ball#

Ball#

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x012F

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010100C440801C31FF266F21302F01BF020A04038200D50D800007000A00640D06B81100801C31FF266F21302F01BF020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

000244: *Feb 17 20:22:14.148 UTC: //-1/801C31FF2F01/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

000245: *Feb 17 20:22:14.148 UTC: //-1/801C31FF2F01/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x867581A8, Call Info(

   Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

   Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=725

000246: *Feb 17 20:22:14.148 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000247: *Feb 17 20:22:14.148 UTC: :cc_get_feature_vsa malloc success

000248: *Feb 17 20:22:14.148 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000249: *Feb 17 20:22:14.148 UTC:  cc_get_feature_vsa count is 1

000250: *Feb 17 20:22:14.148 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000251: *Feb 17 20:22:14.148 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2275987968,feature_id:693

000252: *Feb 17 20:22:14.148 UTC: //725/801C31FF2F01/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown))

000253: *Feb 17 20:22:14.148 UTC: //725/801C31FF2F01/CCAPI/cc_process_call_setup_ind:

   Event=0x86DCD638

000254: *Feb 17 20:22:14.148 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 911

000255: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCallSetContext:

   Context=0x8634FFF4

000256: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 725 with tag 0 to app "_ManagedAppProcess_Default"

000257: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

000258: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=100, Params=0x8634F184, Progress Indication=NULL(0)

000259: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCheckClipClir:

   In: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

000260: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCheckClipClir:

   Out: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

000261: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCallSetupRequest:

   Destination Pattern=.T, Called Number=911, Digit Strip=TRUE

000262: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccCallSetupRequest:

   Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=801C31FF-266F-2130-2F01-BF020A040382, Outgoing Dial-peer=100

000263: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

000264: *Feb 17 20:22:14.152 UTC: //725/801C31FF2F01/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

000265: *Feb 17 20:22:14.152 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000266: *Feb 17 20:22:14.152 UTC: :cc_get_feature_vsa malloc success

000267: *Feb 17 20:22:14.152 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000268: *Feb 17 20:22:14.152 UTC:  cc_get_feature_vsa count is 2

000269: *Feb 17 20:22:14.152 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

000270: *Feb 17 20:22:14.152 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2275987744,feature_id:694

000271: *Feb 17 20:22:14.156 UTC: //726/801C31FF2F01/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

000272: *Feb 17 20:22:14.156 UTC: //726/801C31FF2F01/CCAPI/ccCallSetContext:

   Context=0x8634F134

000273: *Feb 17 20:22:14.156 UTC: //725/801C31FF2F01/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=100

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812F

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56BD32110C1100801C31FF266F21302F01BF020A0403820100010010800100

000274: *Feb 17 20:22:14.156 UTC: //726/801C31FF2F01/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

000275: *Feb 17 20:22:15.408 UTC: //726/801C31FF2F01/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=726

000276: *Feb 17 20:22:15.408 UTC: //726/801C31FF2F01/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

000277: *Feb 17 20:22:15.408 UTC: //725/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

000278: *Feb 17 20:22:15.408 UTC: //726/801C31FF2F01/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=726

000279: *Feb 17 20:22:15.408 UTC: //726/801C31FF2F01/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

000280: *Feb 17 20:22:15.408 UTC: //726/801C31FF2F01/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

000281: *Feb 17 20:22:15.412 UTC: //726/801C31FF2F01/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=726,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

000282: *Feb 17 20:22:15.412 UTC: //726/801C31FF2F01/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

000283: *Feb 17 20:22:15.412 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000284: *Feb 17 20:22:15.412 UTC: :cc_free_feature_vsa freeing 87A8D118

000285: *Feb 17 20:22:15.412 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000286: *Feb 17 20:22:15.412 UTC:  vsacount in free is 1

000287: *Feb 17 20:22:15.412 UTC: //725/801C31FF2F01/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

000288: *Feb 17 20:22:15.412 UTC: //725/801C31FF2F01/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

000289: *Feb 17 20:22:15.412 UTC: //725/801C31FF2F01/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x812F

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A000411001100801C31FF266F21302F01BF020A04038210800100

000290: *Feb 17 20:22:15.416 UTC: //725/801C31FF2F01/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x867581A8, Tag=0x0, Call Id=725,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

000291: *Feb 17 20:22:15.416 UTC: //725/801C31FF2F01/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

000292: *Feb 17 20:22:15.416 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000293: *Feb 17 20:22:15.416 UTC: :cc_free_feature_vsa freeing 87A8D1F8

000294: *Feb 17 20:22:15.416 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

000295: *Feb 17 20:22:15.416 UTC:  vsacount in free is 0

Everyone's tags (1)
1 ACCEPTED SOLUTION

Accepted Solutions
Green

H323 Call Routing - 911

Hi,

Can you have a look at post

https://supportforums.cisco.com/thread/2213848

Suffering from the same isue as you.

Looks to be a cabling/Service provider issue.

I cant understand why your other call works when the voice port is reporting "fxols_power_denial_detected"

because this means it is not seeing the correct voltage on the telephone line.

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
19 REPLIES
Green

H323 Call Routing - 911

Hi

This looks to be due digit stripping on
your dial peer 100.

!
dial-peer voice 100 pots
preference 1
destination-pattern .T
port 4
!


You have .T as your patern

Looking at you long dialled number 13188406637
that is 11 digits so the first digit (1) is being dropped
resulting in 10 digits to line 3188406637

When we look at the 911 call only 11 will be sent to line
This will be an incomplete number for the service provider

In my opinion as 911 is so important you should build
a dial peer just for the emergency service.

!
dial-peer voice 911 pots
description *** EMERGENCY SERVICE ***
preference 1
incoming called-number .
destination-pattern 911
no digit-strip
port 4
!

If you are actually sending 9911 to the gateway
then use this instead

!
dial-peer voice 911 pots
description *** EMERGENCY SERVICE ***
preference 1
incoming called-number .
destination-pattern 9911
forward-digits 3
port 4
!

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

Will try this as soon as they are in the office, thanks ALEX.

New Member

H323 Call Routing - 911

Alex,

Seems the calls are not hitting the 911 dial-peer, they are still hitting dial-peer 100 according to the debugs.

User is dialing 9911 from an IP phone.

dial-peer voice 100 pots

preference 1

destination-pattern .T

port 4

!

dial-peer voice 911 pots

preference 1

destination-pattern 9.911

incoming called-number .

port 4

FAST BUSY

006003: *Feb 18 14:42:53.012 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1

006004: *Feb 18 14:42:53.016 UTC: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x87BF6B7C) is in use

006005: *Feb 18 14:42:53.016 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1

006006: *Feb 18 14:42:53.016 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x87A9F0AC, len=221, msgPtr=0x87ABA6D0

006007: *Feb 18 14:42:53.016 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x0135

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010100C44000FFB1C21F7131303501FF020A04038200D50D800007000A00640D06B8110000FFB1C21F7131303501FF020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

006008: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry

006009: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID

006010: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl

006011: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006012: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number

006013: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006014: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern

006015: *Feb 18 14:42:53.020 UTC: //-1/00FFB1C23501/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006016: *Feb 18 14:42:53.020 UTC: //-1/00FFB1C23501/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006017: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006018: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/common_idle_setupInd_hdlr: ccb ccm bits = system[0x0028]

006019: *Feb 18 14:42:53.020 UTC: //-1/00FFB1C23501/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006020: *Feb 18 14:42:53.020 UTC: //-1/00FFB1C23501/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006021: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006022: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0

006023: *Feb 18 14:42:53.020 UTC: //-1/00FFB1C23501/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

006024: *Feb 18 14:42:53.020 UTC: //-1/00FFB1C23501/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x867581A8, Call Info(

   Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

   Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=943

006025: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006026: *Feb 18 14:42:53.020 UTC: :cc_get_feature_vsa malloc success

006027: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006028: *Feb 18 14:42:53.020 UTC:  cc_get_feature_vsa count is 1

006029: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006030: *Feb 18 14:42:53.020 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2270469880,feature_id:906

006031: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown))

006032: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container:

cch323_create_call_info_type_container: creating callInfoType container for callID = 943

006033: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0

006034: *Feb 18 14:42:53.020 UTC: //943/00FFB1C23501/CCAPI/cc_process_call_setup_ind:

   Event=0x86DCD638

006035: *Feb 18 14:42:53.020 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 911

006036: *Feb 18 14:42:53.024 UTC: //943/00FFB1C23501/CCAPI/ccCallSetContext:

   Context=0x8634C4F4

006037: *Feb 18 14:42:53.024 UTC: //943/00FFB1C23501/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 943 with tag 0 to app "_ManagedAppProcess_Default"

006038: *Feb 18 14:42:53.024 UTC: //943/00FFB1C23501/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

006039: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersCore:

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

006040: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006041: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006042: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006043: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006044: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006045: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006046: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006047: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006048: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006049: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006050: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006051: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006052: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006053: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006054: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006055: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006056: *Feb 18 14:42:53.024 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006057: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersCore:

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

006058: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006059: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006060: *Feb 18 14:42:53.024 UTC: //-1/00FFB1C23501/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006061: *Feb 18 14:42:53.024 UTC: //943/00FFB1C23501/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=100, Params=0x8634E2C4, Progress Indication=NULL(0)

006062: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/ccCheckClipClir:

   In: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006063: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/ccCheckClipClir:

   Out: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006064: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/ccCallSetupRequest:

   Destination Pattern=.T, Called Number=911, Digit Strip=TRUE

006065: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/ccCallSetupRequest:

   Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=00FFB1C2-1F71-3130-3501-FF020A040382, Outgoing Dial-peer=100

006066: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

006067: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

006068: *Feb 18 14:42:53.028 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006069: *Feb 18 14:42:53.028 UTC: :cc_get_feature_vsa malloc success

006070: *Feb 18 14:42:53.028 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006071: *Feb 18 14:42:53.028 UTC:  cc_get_feature_vsa count is 2

006072: *Feb 18 14:42:53.028 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006073: *Feb 18 14:42:53.028 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2270469656,feature_id:907

006074: *Feb 18 14:42:53.028 UTC: //944/00FFB1C23501/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

006075: *Feb 18 14:42:53.028 UTC: //944/00FFB1C23501/CCAPI/ccCallSetContext:

   Context=0x8634E274

006076: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=100

006077: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/H323/cch323_do_set_dialpeer_tag: gw_id=1

006078: *Feb 18 14:42:53.028 UTC: //944/00FFB1C23501/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

006079: *Feb 18 14:42:53.028 UTC: //943/00FFB1C23501/H323/cch323_do_call_proceeding: gw_id=1

006080: *Feb 18 14:42:53.032 UTC: //943/00FFB1C23501/H323/cch323_do_call_proceeding: gw_id=1

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8135

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56F832110C110000FFB1C21F7131303501FF020A0403820100010010800100

006081: *Feb 18 14:42:54.280 UTC: //944/00FFB1C23501/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=944

006082: *Feb 18 14:42:54.280 UTC: //944/00FFB1C23501/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

006083: *Feb 18 14:42:54.280 UTC: //943/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

006084: *Feb 18 14:42:54.280 UTC: //944/00FFB1C23501/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=944

006085: *Feb 18 14:42:54.280 UTC: //944/00FFB1C23501/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

006086: *Feb 18 14:42:54.280 UTC: //944/00FFB1C23501/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006087: *Feb 18 14:42:54.284 UTC: //944/00FFB1C23501/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=944,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006088: *Feb 18 14:42:54.284 UTC: //944/00FFB1C23501/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006089: *Feb 18 14:42:54.284 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006090: *Feb 18 14:42:54.284 UTC: :cc_free_feature_vsa freeing 87549E10

006091: *Feb 18 14:42:54.284 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006092: *Feb 18 14:42:54.284 UTC:  vsacount in free is 1

006093: *Feb 18 14:42:54.284 UTC: //-1/xxxxxxxxxxxx/H323/cch323_post_call_statistics: callID=943

006094: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

006095: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006096: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

006097: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/H323/cch323_do_call_disconnect: gw_id=1, discCause=34

006098: *Feb 18 14:42:54.284 UTC: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8135

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A00041100110000FFB1C21F7131303501FF020A04038210800100

006099: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/H323/cch323_call_generic_cleanup: Disconnected flag 1

006100: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/H323/cch323_store_call_history_entry: Call Active Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006101: *Feb 18 14:42:54.284 UTC: //943/00FFB1C23501/H323/cch323_store_call_history_entry: Call History Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006102: *Feb 18 14:42:54.288 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2

006103: *Feb 18 14:42:54.288 UTC: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl

006104: *Feb 18 14:42:54.288 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 3

006105: *Feb 18 14:42:54.288 UTC: //943/00FFB1C23501/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x867581A8, Tag=0x0, Call Id=943,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006106: *Feb 18 14:42:54.288 UTC: //943/00FFB1C23501/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006107: *Feb 18 14:42:54.288 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006108: *Feb 18 14:42:54.288 UTC: :cc_free_feature_vsa freeing 87549EF0

006109: *Feb 18 14:42:54.288 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006110: *Feb 18 14:42:54.288 UTC:  vsacount in free is 0

006111: *Feb 18 14:42:54.288 UTC: //-1/xxxxxxxxxxxx/H323/cch323_call_generic_cleanup: Freeing ccb (0x87BF6B7C)

NEW CONFIG

FAST BUSY

dial-peer voice 100 pots

preference 1

destination-pattern .T

port 4

!

dial-peer voice 911 pots

preference 1

destination-pattern 9911

incoming called-number .

port 4

forward-digits 3

!

!

!

line con 0

login local

no modem enable

line aux 0

line vty 0 4

access-class 101 in

login local

length 0

transport input telnet ssh

!

scheduler max-task-time 5000

scheduler allocate 4000 1000

scheduler interval 500

end

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

006114: *Feb 18 14:54:59.287 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1

006115: *Feb 18 14:54:59.287 UTC: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x87BF6B7C) is in use

006116: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1

006117: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x87A9EDF4, len=221, msgPtr=0x86695D1C

006118: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x0136

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010100C44000CE6C73F5733130360101020A04038200D50D800007000A00640D06B8110000CE6C73F5733130360101020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

006119: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry

006120: *Feb 18 14:54:59.291 UTC: //945/00CE6C733601/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID

006121: *Feb 18 14:54:59.291 UTC: //945/00CE6C733601/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl

006122: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006123: *Feb 18 14:54:59.291 UTC: //945/00CE6C733601/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number

006124: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006125: *Feb 18 14:54:59.291 UTC: //945/00CE6C733601/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern

006126: *Feb 18 14:54:59.291 UTC: //-1/00CE6C733601/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006127: *Feb 18 14:54:59.291 UTC: //-1/00CE6C733601/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006128: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006129: *Feb 18 14:54:59.291 UTC: //945/00CE6C733601/H323/common_idle_setupInd_hdlr: ccb ccm bits = system[0x0028]

006130: *Feb 18 14:54:59.291 UTC: //-1/00CE6C733601/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006131: *Feb 18 14:54:59.291 UTC: //-1/00CE6C733601/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006132: *Feb 18 14:54:59.291 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006133: *Feb 18 14:54:59.291 UTC: //945/00CE6C733601/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0

006134: *Feb 18 14:54:59.291 UTC: //-1/00CE6C733601/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

006135: *Feb 18 14:54:59.295 UTC: //-1/00CE6C733601/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x867581A8, Call Info(

   Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

   Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=945

006136: *Feb 18 14:54:59.295 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006137: *Feb 18 14:54:59.295 UTC: :cc_get_feature_vsa malloc success

006138: *Feb 18 14:54:59.295 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006139: *Feb 18 14:54:59.295 UTC:  cc_get_feature_vsa count is 1

006140: *Feb 18 14:54:59.295 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006141: *Feb 18 14:54:59.295 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2275987968,feature_id:908

006142: *Feb 18 14:54:59.295 UTC: //945/00CE6C733601/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown))

006143: *Feb 18 14:54:59.295 UTC: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container:

cch323_create_call_info_type_container: creating callInfoType container for callID = 945

006144: *Feb 18 14:54:59.295 UTC: //945/00CE6C733601/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0

006145: *Feb 18 14:54:59.295 UTC: //945/00CE6C733601/CCAPI/cc_process_call_setup_ind:

   Event=0x86DCD638

006146: *Feb 18 14:54:59.295 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 911

006147: *Feb 18 14:54:59.295 UTC: //945/00CE6C733601/CCAPI/ccCallSetContext:

   Context=0x8634B634

006148: *Feb 18 14:54:59.295 UTC: //945/00CE6C733601/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 945 with tag 0 to app "_ManagedAppProcess_Default"

006149: *Feb 18 14:54:59.299 UTC: //945/00CE6C733601/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

006150: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersCore:

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

006151: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006152: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006153: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006154: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006155: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006156: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006157: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006158: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006159: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006160: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006161: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006162: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006163: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006164: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006165: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006166: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006167: *Feb 18 14:54:59.299 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006168: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersCore:

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

006169: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006170: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006171: *Feb 18 14:54:59.299 UTC: //-1/00CE6C733601/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=100

006172: *Feb 18 14:54:59.299 UTC: //945/00CE6C733601/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=100, Params=0x8634A7C4, Progress Indication=NULL(0)

006173: *Feb 18 14:54:59.299 UTC: //945/00CE6C733601/CCAPI/ccCheckClipClir:

   In: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006174: *Feb 18 14:54:59.299 UTC: //945/00CE6C733601/CCAPI/ccCheckClipClir:

   Out: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006175: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/CCAPI/ccCallSetupRequest:

   Destination Pattern=.T, Called Number=911, Digit Strip=TRUE

006176: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/CCAPI/ccCallSetupRequest:

   Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=00CE6C73-F573-3130-3601-01020A040382, Outgoing Dial-peer=100

006177: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

006178: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

006179: *Feb 18 14:54:59.303 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006180: *Feb 18 14:54:59.303 UTC: :cc_get_feature_vsa malloc success

006181: *Feb 18 14:54:59.303 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006182: *Feb 18 14:54:59.303 UTC:  cc_get_feature_vsa count is 2

006183: *Feb 18 14:54:59.303 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

006184: *Feb 18 14:54:59.303 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2275987744,feature_id:909

006185: *Feb 18 14:54:59.303 UTC: //946/00CE6C733601/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

006186: *Feb 18 14:54:59.303 UTC: //946/00CE6C733601/CCAPI/ccCallSetContext:

   Context=0x8634A774

006187: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=100

006188: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/H323/cch323_do_set_dialpeer_tag: gw_id=1

006189: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/H323/cch323_do_call_proceeding: gw_id=1

006190: *Feb 18 14:54:59.303 UTC: //945/00CE6C733601/H323/cch323_do_call_proceeding: gw_id=1

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8136

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56BECB110C110000CE6C73F5733130360101020A0403820100010010800100

006191: *Feb 18 14:54:59.307 UTC: //946/00CE6C733601/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

006192: *Feb 18 14:55:00.559 UTC: //946/00CE6C733601/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=946

006193: *Feb 18 14:55:00.559 UTC: //946/00CE6C733601/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

006194: *Feb 18 14:55:00.559 UTC: //945/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

006195: *Feb 18 14:55:00.559 UTC: //946/00CE6C733601/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=946

006196: *Feb 18 14:55:00.559 UTC: //946/00CE6C733601/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

006197: *Feb 18 14:55:00.559 UTC: //946/00CE6C733601/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006198: *Feb 18 14:55:00.563 UTC: //946/00CE6C733601/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=946,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006199: *Feb 18 14:55:00.563 UTC: //946/00CE6C733601/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006200: *Feb 18 14:55:00.563 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006201: *Feb 18 14:55:00.563 UTC: :cc_free_feature_vsa freeing 87A8D118

006202: *Feb 18 14:55:00.563 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006203: *Feb 18 14:55:00.563 UTC:  vsacount in free is 1

006204: *Feb 18 14:55:00.563 UTC: //-1/xxxxxxxxxxxx/H323/cch323_post_call_statistics: callID=945

006205: *Feb 18 14:55:00.563 UTC: //945/00CE6C733601/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

006206: *Feb 18 14:55:00.563 UTC: //945/00CE6C733601/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006207: *Feb 18 14:55:00.563 UTC: //945/00CE6C733601/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

006208: *Feb 18 14:55:00.563 UTC: //945/00CE6C733601/H323/cch323_do_call_disconnect: gw_id=1, discCause=34

006209: *Feb 18 14:55:00.563 UTC: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8136

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A00041100110000CE6C73F5733130360101020A04038210800100

006210: *Feb 18 14:55:00.567 UTC: //945/00CE6C733601/H323/cch323_call_generic_cleanup: Disconnected flag 1

006211: *Feb 18 14:55:00.567 UTC: //945/00CE6C733601/H323/cch323_store_call_history_entry: Call Active Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006212: *Feb 18 14:55:00.567 UTC: //945/00CE6C733601/H323/cch323_store_call_history_entry: Call History Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006213: *Feb 18 14:55:00.567 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2

006214: *Feb 18 14:55:00.567 UTC: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl

006215: *Feb 18 14:55:00.567 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 3

006216: *Feb 18 14:55:00.567 UTC: //945/00CE6C733601/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x867581A8, Tag=0x0, Call Id=945,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006217: *Feb 18 14:55:00.567 UTC: //945/00CE6C733601/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006218: *Feb 18 14:55:00.567 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006219: *Feb 18 14:55:00.567 UTC: :cc_free_feature_vsa freeing 87A8D1F8

006220: *Feb 18 14:55:00.567 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

006221: *Feb 18 14:55:00.567 UTC:  vsacount in free is 0

006222: *Feb 18 14:55:00.567 UTC: //-1/xxxxxxxxxxxx/H323/cch323_call_generic_cleanup: Freeing ccb (0x87BF6B7C)

Green

H323 Call Routing - 911

Hi,

Can you fix your dial peer

!

dial-peer voice 911 pots

preference 1

destination-pattern 9.911

incoming called-number .

port 4

Change this to 2 dial peers as below:-

!

no dial-peer voice 9911 pots

!

dial-peer voice 9911 pots

preference 1

destination-pattern 9911

incoming called-number .

forward-digits 3

port 4

!

dial-peer voice 911 pots

preference 1

destination-pattern 911

incoming called-number .

forward-digits 3

port 4

!

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

Alex, same, but seems to be hitting the correct dial-peer now...


also not sure if this is normal operation:

List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006664: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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


why does it say calling and called is 911???


Ball#sh run | b dial-peer

dial-peer voice 201010 voip

preference 1

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.13

dtmf-relay h245-alphanumeric

!

dial-peer voice 200010 voip

preference 2

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.12

dtmf-relay h245-alphanumeric

!

dial-peer voice 100 pots

preference 1

destination-pattern .T

port 4

!

dial-peer voice 9911 pots

preference 1

destination-pattern 9911

incoming called-number .

port 4

forward-digits 3

!

dial-peer voice 911 pots

preference 1

destination-pattern 911

incoming called-number .

port 4

forward-digits 3

!

!

!

line con 0

login local

no modem enable

line aux 0

line vty 0 4

access-class 101 in

login local

length 0

transport input telnet ssh

!

scheduler max-task-time 5000

scheduler allocate 4000 1000

scheduler interval 500

end


Ball#

Ball#

Ball#

Ball#term mon

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

006620: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1

006621: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x87BF6B7C) is in use

006622: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1

006623: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x87A9EF50, len=221, msgPtr=0x8772F388

006624: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x0138

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010100C440006BE4D457803130380115020A04038200D50D800007000A00640D06B81100006BE4D457803130380115020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

006625: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry

006626: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID

006627: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl

006628: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006629: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number

006630: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006631: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern

006632: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Calling Number=

3186411542

, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006633: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006634: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006635: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/common_idle_setupInd_hdlr: ccb ccm bits = system[0x0028]

006636: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Calling Number=

3186411542

, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006637: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006638: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006639: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0

006640: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=

3186411542


   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


006641: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x867581A8, Call Info(

   Calling Number=

3186411542

,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

   Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=956

006642: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006643: *Feb 18 15:47:48.391 UTC: :cc_get_feature_vsa malloc success

006644: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006645: *Feb 18 15:47:48.391 UTC:  cc_get_feature_vsa count is 1

006646: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006647: *Feb 18 15:47:48.391 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:

2272984256

,feature_id:919

006648: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown))

006649: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container:

cch323_create_call_info_type_container: creating callInfoType container for callID = 956

006650: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0

006651: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/cc_process_call_setup_ind:

   Event=0x86DCD638

006652: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 911

006653: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/ccCallSetContext:

   Context=0x86350EB4

006654: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 956 with tag 0 to app "_ManagedAppProcess_Default"

006655: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

006656: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

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

006657: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006658: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006659: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   Ball#sh run | b dial-peer

dial-peer voice 201010 voip

preference 1

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.13

dtmf-relay h245-alphanumeric

!

dial-peer voice 200010 voip

preference 2

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.12

dtmf-relay h245-alphanumeric

!

dial-peer voice 100 pots

preference 1

destination-pattern .T

port 4

!

dial-peer voice 9911 pots

preference 1

destination-pattern 9911

incoming called-number .

port 4

forward-digits 3

!

dial-peer voice 911 pots

preference 1

destination-pattern 911

incoming called-number .

port 4

forward-digits 3

!

!

!

line con 0

login local

no modem enable

line aux 0

line vty 0 4

access-class 101 in

login local

length 0

transport input telnet ssh

!

scheduler max-task-time 5000

scheduler allocate 4000 1000

scheduler interval 500

end


Ball#

Ball#

Ball#

Ball#term mon

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

006620: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1

006621: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x87BF6B7C) is in use

006622: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1

006623: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x87A9EF50, len=221, msgPtr=0x8772F388

006624: *Feb 18 15:47:48.387 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x0138

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010100C440006BE4D457803130380115020A04038200D50D800007000A00640D06B81100006BE4D457803130380115020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

006625: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry

006626: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID

006627: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl

006628: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006629: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number

006630: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

006631: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern

006632: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Calling Number=

3186411542

, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006633: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006634: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006635: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/common_idle_setupInd_hdlr: ccb ccm bits = system[0x0028]

006636: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Calling Number=

3186411542

, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006637: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006638: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = -1

006639: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0

006640: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=

3186411542


   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


006641: *Feb 18 15:47:48.391 UTC: //-1/006BE4D43801/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x867581A8, Call Info(

   Calling Number=

3186411542

,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

   Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=956

006642: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006643: *Feb 18 15:47:48.391 UTC: :cc_get_feature_vsa malloc success

006644: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006645: *Feb 18 15:47:48.391 UTC:  cc_get_feature_vsa count is 1

006646: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006647: *Feb 18 15:47:48.391 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:

2272984256

,feature_id:919

006648: *Feb 18 15:47:48.391 UTC: //956/006BE4D43801/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown))

006649: *Feb 18 15:47:48.391 UTC: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container:

cch323_create_call_info_type_container: creating callInfoType container for callID = 956

006650: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0

006651: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/cc_process_call_setup_ind:

   Event=0x86DCD638

006652: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 911

006653: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/ccCallSetContext:

   Context=0x86350EB4

006654: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 956 with tag 0 to app "_ManagedAppProcess_Default"

006655: *Feb 18 15:47:48.395 UTC: //956/006BE4D43801/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

006656: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

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

006657: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006658: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006659: *Feb 18 15:47:48.395 UTC: //-1/006BE4D43801/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006660: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006661: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006662: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006663: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006664: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006665: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006666: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006667: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006668: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006669: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006670: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006671: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006672: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006673: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006674: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

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

006675: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006676: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006677: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006678: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=911, Params=0x86348A44, Progress Indication=NULL(0)

006679: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   In: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006680: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   Out: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006681: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination Pattern=911, Called Number=911, Digit Strip=TRUE

006682: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=006BE4D4-5780-3130-3801-15020A040382, Outgoing Dial-peer=911

006683: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=

3186411542


   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


006684: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=

3186411542

,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=911, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

006685: *Feb 18 15:47:48.399 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006686: *Feb 18 15:47:48.399 UTC: :cc_get_feature_vsa malloc success

006687: *Feb 18 15:47:48.399 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006688: *Feb 18 15:47:48.399 UTC:  cc_get_feature_vsa count is 2

006689: *Feb 18 15:47:48.399 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006690: *Feb 18 15:47:48.399 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:

2272984032

,feature_id:920

006691: *Feb 18 15:47:48.399 UTC: //957/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

006692: *Feb 18 15:47:48.399 UTC: //957/006BE4D43801/CCAPI/ccCallSetContext:

   Context=0x863489F4

006693: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=911

006694: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/H323/cch323_do_set_dialpeer_tag: gw_id=1

006695: *Feb 18 15:47:48.403 UTC: //957/006BE4D43801/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

006696: *Feb 18 15:47:48.403 UTC: //956/006BE4D43801/H323/cch323_do_call_proceeding: gw_id=1

006697: *Feb 18 15:47:48.403 UTC: //956/006BE4D43801/H323/cch323_do_call_proceeding: gw_id=1

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8138

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56AE3E110C1100006BE4D457803130380115020A0403820100010010800100

006698: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=957

006699: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

006700: *Feb 18 15:47:49.651 UTC: //956/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

006701: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/ccCallSetAAA_Accounting:

   Accounting=1, Call Id=957

006702: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

006703: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006704: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=957,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006705: *Feb 18 15:47:49.655 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006706: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006707: *Feb 18 15:47:49.655 UTC: :cc_free_feature_vsa freeing 877AFBD8

006708: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006709: *Feb 18 15:47:49.655 UTC:  vsacount in free is 1

006710: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=100, Params=0x86358504, Progress Indication=NULL(0)

006711: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   In: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006712: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   Out: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006713: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination Pattern=.T, Called Number=911, Digit Strip=TRUE

006714: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=006BE4D4-5780-3130-3801-15020A040382, Outgoing Dial-peer=100

006715: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=

3186411542


   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


006716: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=

3186411542

,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

006717: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006718: *Feb 18 15:47:49.655 UTC: :cc_get_feature_vsa malloc success

006719: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006720: *Feb 18 15:47:49.655 UTC:  cc_get_feature_vsa count is 2

006721: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006722: *Feb 18 15:47:49.655 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:

2272984032

,feature_id:921

006723: *Feb 18 15:47:49.655 UTC: //958/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

006724: *Feb 18 15:47:49.655 UTC: //958/006BE4D43801/CCAPI/ccCallSetContext:

   Context=0x863584B4

006725: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=100

006726: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/H323/cch323_do_set_dialpeer_tag: gw_id=1

006727: *Feb 18 15:47:49.659 UTC: //958/006BE4D43801/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

006728: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=958

006729: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

006730: *Feb 18 15:47:50.911 UTC: //956/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

006731: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=958

006732: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

006733: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006734: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=958,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006735: *Feb 18 15:47:50.915 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006736: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006737: *Feb 18 15:47:50.915 UTC: :cc_free_feature_vsa freeing 877AFBD8

006738: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006739: *Feb 18 15:47:50.915 UTC:  vsacount in free is 1

006740: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/H323/cch323_post_call_statistics: callID=956

006741: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

006742: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006743: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

006744: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_do_call_disconnect: gw_id=1, discCause=34

006745: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8138

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A000411001100006BE4D457803130380115020A04038210800100

006746: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_call_generic_cleanup: Disconnected flag 1

006747: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_store_call_history_entry: Call Active Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006748: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_store_call_history_entry: Call History Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006749: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2

006750: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl

006751: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 3

006752: *Feb 18 15:47:50.919 UTC: //956/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x867581A8, Tag=0x0, Call Id=956,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006753: *Feb 18 15:47:50.919 UTC: //956/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006754: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006755: *Feb 18 15:47:50.919 UTC: :cc_free_feature_vsa freeing 877AFCB8

006756: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006757: *Feb 18 15:47:50.919 UTC:  vsacount in free is 0

006758: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/cch323_call_generic_cleanup: Freeing ccb (0x87BF6B7C) Peer Info Type=DIALPEER_INFO_SPEECH

006661: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006662: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006663: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006664: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006665: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006666: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006667: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006668: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

006669: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

006670: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

006671: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006672: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006673: *Feb 18 15:47:48.395 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006674: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

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

006675: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

006676: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

006677: *Feb 18 15:47:48.399 UTC: //-1/006BE4D43801/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

006678: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=911, Params=0x86348A44, Progress Indication=NULL(0)

006679: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   In: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006680: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   Out: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006681: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination Pattern=911, Called Number=911, Digit Strip=TRUE

006682: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=006BE4D4-5780-3130-3801-15020A040382, Outgoing Dial-peer=911

006683: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=

3186411542


   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


006684: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=

3186411542

,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=911, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

006685: *Feb 18 15:47:48.399 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006686: *Feb 18 15:47:48.399 UTC: :cc_get_feature_vsa malloc success

006687: *Feb 18 15:47:48.399 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006688: *Feb 18 15:47:48.399 UTC:  cc_get_feature_vsa count is 2

006689: *Feb 18 15:47:48.399 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006690: *Feb 18 15:47:48.399 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:

2272984032

,feature_id:920

006691: *Feb 18 15:47:48.399 UTC: //957/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

006692: *Feb 18 15:47:48.399 UTC: //957/006BE4D43801/CCAPI/ccCallSetContext:

   Context=0x863489F4

006693: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=911

006694: *Feb 18 15:47:48.399 UTC: //956/006BE4D43801/H323/cch323_do_set_dialpeer_tag: gw_id=1

006695: *Feb 18 15:47:48.403 UTC: //957/006BE4D43801/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

006696: *Feb 18 15:47:48.403 UTC: //956/006BE4D43801/H323/cch323_do_call_proceeding: gw_id=1

006697: *Feb 18 15:47:48.403 UTC: //956/006BE4D43801/H323/cch323_do_call_proceeding: gw_id=1

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8138

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56AE3E110C1100006BE4D457803130380115020A0403820100010010800100

006698: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=957

006699: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

006700: *Feb 18 15:47:49.651 UTC: //956/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

006701: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/ccCallSetAAA_Accounting:

   Accounting=1, Call Id=957

006702: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

006703: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006704: *Feb 18 15:47:49.651 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=957,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006705: *Feb 18 15:47:49.655 UTC: //957/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006706: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006707: *Feb 18 15:47:49.655 UTC: :cc_free_feature_vsa freeing 877AFBD8

006708: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006709: *Feb 18 15:47:49.655 UTC:  vsacount in free is 1

006710: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=100, Params=0x86358504, Progress Indication=NULL(0)

006711: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   In: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006712: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCheckClipClir:

   Out: Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

006713: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Destination Pattern=.T, Called Number=911, Digit Strip=TRUE

006714: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccCallSetupRequest:

   Calling Number=

3186411542

(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=006BE4D4-5780-3130-3801-15020A040382, Outgoing Dial-peer=100

006715: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=

3186411542


   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


006716: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=

3186411542

,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

006717: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006718: *Feb 18 15:47:49.655 UTC: :cc_get_feature_vsa malloc success

006719: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006720: *Feb 18 15:47:49.655 UTC:  cc_get_feature_vsa count is 2

006721: *Feb 18 15:47:49.655 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


006722: *Feb 18 15:47:49.655 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:

2272984032

,feature_id:921

006723: *Feb 18 15:47:49.655 UTC: //958/006BE4D43801/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

006724: *Feb 18 15:47:49.655 UTC: //958/006BE4D43801/CCAPI/ccCallSetContext:

   Context=0x863584B4

006725: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=100

006726: *Feb 18 15:47:49.655 UTC: //956/006BE4D43801/H323/cch323_do_set_dialpeer_tag: gw_id=1

006727: *Feb 18 15:47:49.659 UTC: //958/006BE4D43801/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

006728: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=958

006729: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

006730: *Feb 18 15:47:50.911 UTC: //956/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

006731: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=958

006732: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

006733: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006734: *Feb 18 15:47:50.911 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=958,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006735: *Feb 18 15:47:50.915 UTC: //958/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006736: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006737: *Feb 18 15:47:50.915 UTC: :cc_free_feature_vsa freeing 877AFBD8

006738: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006739: *Feb 18 15:47:50.915 UTC:  vsacount in free is 1

006740: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/H323/cch323_post_call_statistics: callID=956

006741: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

006742: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

006743: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

006744: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_do_call_disconnect: gw_id=1, discCause=34

006745: *Feb 18 15:47:50.915 UTC: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8138

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A000411001100006BE4D457803130380115020A04038210800100

006746: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_call_generic_cleanup: Disconnected flag 1

006747: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_store_call_history_entry: Call Active Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006748: *Feb 18 15:47:50.915 UTC: //956/006BE4D43801/H323/cch323_store_call_history_entry: Call History Playout Mode: 0,Init 0, Min 0, Max 0, Fax 0

006749: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2

006750: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl

006751: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 3

006752: *Feb 18 15:47:50.919 UTC: //956/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x867581A8, Tag=0x0, Call Id=956,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

006753: *Feb 18 15:47:50.919 UTC: //956/006BE4D43801/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

006754: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006755: *Feb 18 15:47:50.919 UTC: :cc_free_feature_vsa freeing 877AFCB8

006756: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


006757: *Feb 18 15:47:50.919 UTC:  vsacount in free is 0

006758: *Feb 18 15:47:50.919 UTC: //-1/xxxxxxxxxxxx/H323/cch323_call_generic_cleanup: Freeing ccb (0x87BF6B7C)

New Member

H323 Call Routing - 911

Any updates???

Green

Re: H323 Call Routing - 911

Hi Gerhard

Sorry for the delay

Looking through your latest trace there seems to be be an issue matching the incoming dial peer. (VOIP type)

and matching the default Dial peer 0

As you have now shown we are matching the new DP 911 as the outgoing DP

Can we try tidying up the peers now:

!

no dial-peer voice 9911 pots

! *** This one is not needed as you have shown we now matching 911 ***

!

dial-peer voice 100 pots

incoming called-number .

!

dial-peer voice 201010 voip

incoming called-number .

!

dial-peer voice 200010 voip

incoming called-number .

!

Hopefully you should now be matching the VOIP type DPs

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

Ok i now have this...

Can you explain what the incoming called-number has to do w/ the outbound calling?

I will have them test around 9am EST...   What debugs are the best to collect?

Anything more than i have been doing?

Ball#sh run | b dial-peer

dial-peer voice 201010 voip

preference 1

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.13

incoming called-number .

dtmf-relay h245-alphanumeric

!

dial-peer voice 200010 voip

preference 2

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.12

incoming called-number .

dtmf-relay h245-alphanumeric

!

dial-peer voice 100 pots

preference 1

destination-pattern .T

incoming called-number .

port 4

!

dial-peer voice 911 pots

preference 1

destination-pattern 911

incoming called-number .

port 4

forward-digits 3

!

Green

H323 Call Routing - 911

Gerhard,

Are you saying the issue is now fixed ?

Your question about the dial peers.

Every call whether it is inbound or outbound must use 2 dial peers.

1 for the incoming leg of the call set up and 1 for the outgoing set up.

In your original post you showed a GOOD call to a 10 digit number

Calling Number=4300, Called Number=13188406637, Voice-Interface=0x0,

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

Peer Info Type=DIALPEER_INFO_SPEECH

000184: *Feb 17 19:45:23.436 UTC: //-1/004955D92E01/DPM/dpAssociateIncomingPeerCore:

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

000188: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

Match Rule=DP_MATCH_DEST; Called Number=13188406637

000189: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

Result=Success(0) after DP_MATCH_DEST

000190: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersMoreArg:

Result=SUCCESS(0)

List of Matched Outgoing Dial-peer(s):

1: Dial-peer Tag=100

These were selected by dial peer matching

so your CALLING PHONE No was 4300 that matched DP 201010

and your CALLED No was 13188406637 that mateches the .T in DP 100

When the calls to 911 arefailing they are not matching a usable I/C and O/G DP

when this happens you use a non deleteable DEFAULT DP "0" which is never really suitable

In you case the O/G patern with 911 is GOOD but there is no GOOD match for the VOIP incoming it

therefore use DP "0"

Have read through this:-

http://www.cisco.com/c/en/us/support/docs/voice/call-routing-dial-plans/14074-in-dial-peer-match.html

It will help you understand how DPs are matched and in what order.

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

Alex, No still getting the FAST BUSY... but now appears to be matching both incoming and outgoing DP's..

Any thoughts?

Ball#sh debug

DIALPEER:

  debug voip dialpeer error call is ON (filter is OFF)

  debug voip dialpeer error software is ON

  debug voip dialpeer inout is ON (filter is OFF)

H.225:

  H.225 Q931 IE Details debugging is on

CCH323 SPI: Session tracing is enabled (filter is OFF)

CCAPI:

  debug voip ccapi inout is ON (filter is OFF)

Ball#term mon

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

040759: *Feb 21 14:11:20.246 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 0 Event 0x1

040760: *Feb 21 14:11:20.246 UTC: //-1/xxxxxxxxxxxx/H323/cch323_get_new_ccb: ccb (0x87BF6B7C) is in use

040761: *Feb 21 14:11:20.246 UTC: //-1/xxxxxxxxxxxx/H323/cch323_ct_main: SOCK 2 Event 0x1

040762: *Feb 21 14:11:20.246 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: owner_data=0x87A9ED80, len=221, msgPtr=0x8784C254

040763: *Feb 21 14:11:20.246 UTC: //-1/xxxxxxxxxxxx/H323/cch323_gw_process_read_socket: Received msg for H.225

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x0154

Message Type           : 0x05: SETUP

Bearer Capability: Length Of IE=3

Data 8090A2

Calling Party Number: Length Of IE=12

Data 008133313836343131353432

Called Party Number: Length Of IE=4

Data 80393131

User-User: Length Of IE=188

Data 0520B0060008914A000501401F00420061006C006C00200052006500630065007000740069006F006E0020002D002000340033003000300000000000000000000000000000000000000000000022C0B50000120F436973636F43616C6C4D616E61676572003100010100C44000A9FBDE435E7130540173020A04038200D50D800007000A00640D06B8110000A9FBDE435E7130540173020A040382010001000100010010A00100140140B50000120D82040020040001030003000103

040764: *Feb 21 14:11:20.250 UTC: //-1/xxxxxxxxxxxx/H323/cch323_extract_signaled_carriers: Entry

040765: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_determine_source_ip_group_info: No Source IP group match with Src CarrierId/Zone ID

040766: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_determine_source_ip_group_info: No Source IP group matched with rte id/zone_id/acl

040767: *Feb 21 14:11:20.250 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

040768: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_determine_source_ip_group_info: No Source IP group match with Incoming Called Number

040769: *Feb 21 14:11:20.250 UTC: //-1/xxxxxxxxxxxx/H323/cch323_determine_source_group: Entry

040770: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_determine_source_ip_group_info: No Source IP group match with Destination pattern

040771: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

040772: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_INCOMING_DNIS; Incoming Dial-peer=201010

040773: *Feb 21 14:11:20.250 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = 0

040774: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_set_preferred_codec: Using Voice Class Codec, tag = 1

040775: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_set_peer: peer: 87C8AFC4, peer->voice_peer_tag: 31132, ccb: 87BF6B7C

040776: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_set_peer: ccb h245addr bits = system[0x0007]

040777: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/cch323_set_peer: ccb ccm bits = system[0x0028]

040778: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/DPM/dpAssociateIncomingPeerCore:

   Calling Number=3186411542, Called Number=911, Voice-Interface=0x0,

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

   Peer Info Type=DIALPEER_INFO_SPEECH

040779: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/DPM/dpAssociateIncomingPeerCore:

   Result=Success(0) after DP_MATCH_INCOMING_DNIS; Incoming Dial-peer=201010

040780: *Feb 21 14:11:20.250 UTC: //-1/xxxxxxxxxxxx/H323/cch323_associate_incoming_peer: timeout = 1, reason = 0

040781: *Feb 21 14:11:20.250 UTC: //1765/00A9FBDE5401/H323/h323_gw_setup_ind: is_overlap = 0, info_complete = 0

040782: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

040783: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x867581A8, Call Info(

   Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

   Incoming Dial-peer=201010, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=1765

040784: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/CCAPI/ccCheckClipClir:

   In: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

040785: *Feb 21 14:11:20.250 UTC: //-1/00A9FBDE5401/CCAPI/ccCheckClipClir:

   Out: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

040786: *Feb 21 14:11:20.254 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040787: *Feb 21 14:11:20.254 UTC: :cc_get_feature_vsa malloc success

040788: *Feb 21 14:11:20.254 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040789: *Feb 21 14:11:20.254 UTC:  cc_get_feature_vsa count is 1

040790: *Feb 21 14:11:20.254 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040791: *Feb 21 14:11:20.254 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2271383096,feature_id:1706

040792: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown))

040793: *Feb 21 14:11:20.254 UTC: //-1/xxxxxxxxxxxx/H323/cch323_create_call_info_type_container:

cch323_create_call_info_type_container: creating callInfoType container for callID = 1765

040794: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/H323/cch323_update_call_info_from_dial_peer: Playout Mode: 1,Init 60, Min 40, Max 1000, Fax 300

040795: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/H323/cch323_update_carriers_in_call_info: tg_label_flag 0x0

040796: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/CCAPI/cc_process_call_setup_ind:

   Event=0x86DCD638

040797: *Feb 21 14:11:20.254 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 911

040798: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetContext:

   Context=0x8634B634

040799: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 1765 with tag 201010 to app "_ManagedAppProcess_Default"

040800: *Feb 21 14:11:20.254 UTC: //1765/00A9FBDE5401/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

040801: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersCore:

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

040802: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

040803: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

040804: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

040805: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

040806: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

040807: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

040808: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

040809: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

040810: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

040811: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

040812: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

040813: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

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

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

   Peer Info Type=DIALPEER_INFO_SPEECH

040814: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:

   Result=NO_MATCH(-1) After All Match Rules Attempt

040815: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

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

040816: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

040817: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

040818: *Feb 21 14:11:20.258 UTC: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

040819: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersCore:

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

040820: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersCore:

   Match Rule=DP_MATCH_DEST; Called Number=911

040821: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersCore:

   Result=Success(0) after DP_MATCH_DEST

040822: *Feb 21 14:11:20.258 UTC: //-1/00A9FBDE5401/DPM/dpMatchPeersMoreArg:

   Result=SUCCESS(0)

   List of Matched Outgoing Dial-peer(s):

     1: Dial-peer Tag=911

     2: Dial-peer Tag=100

040823: *Feb 21 14:11:20.258 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=911, Params=0x86358504, Progress Indication=NULL(0)

040824: *Feb 21 14:11:20.258 UTC: //1765/00A9FBDE5401/CCAPI/ccCheckClipClir:

   In: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

040825: *Feb 21 14:11:20.258 UTC: //1765/00A9FBDE5401/CCAPI/ccCheckClipClir:

   Out: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

040826: *Feb 21 14:11:20.258 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetupRequest:

   Destination Pattern=911, Called Number=911, Digit Strip=TRUE

040827: *Feb 21 14:11:20.258 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetupRequest:

   Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=00A9FBDE-435E-7130-5401-73020A040382, Outgoing Dial-peer=911

040828: *Feb 21 14:11:20.258 UTC: //1765/00A9FBDE5401/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

040829: *Feb 21 14:11:20.262 UTC: //1765/00A9FBDE5401/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=911, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

040830: *Feb 21 14:11:20.262 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040831: *Feb 21 14:11:20.262 UTC: :cc_get_feature_vsa malloc success

040832: *Feb 21 14:11:20.262 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040833: *Feb 21 14:11:20.262 UTC:  cc_get_feature_vsa count is 2

040834: *Feb 21 14:11:20.262 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040835: *Feb 21 14:11:20.262 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2271382872,feature_id:1707

040836: *Feb 21 14:11:20.262 UTC: //1766/00A9FBDE5401/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

040837: *Feb 21 14:11:20.262 UTC: //1766/00A9FBDE5401/CCAPI/ccCallSetContext:

   Context=0x863584B4

040838: *Feb 21 14:11:20.262 UTC: //1765/00A9FBDE5401/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=911

040839: *Feb 21 14:11:20.262 UTC: //1765/00A9FBDE5401/H323/cch323_do_set_dialpeer_tag: gw_id=1

040840: *Feb 21 14:11:20.262 UTC: //1765/00A9FBDE5401/H323/cch323_do_call_proceeding: gw_id=1

040841: *Feb 21 14:11:20.262 UTC: //1765/00A9FBDE5401/H323/cch323_do_call_proceeding: gw_id=1

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8154

Message Type           : 0x02: CALL_PROC

User-User: Length Of IE=57

Data 0521C0060008914A00042800B500001240013C05010000ADD9FC56E7E0110C110000A9FBDE435E7130540173020A0403820100010010800100

040842: *Feb 21 14:11:20.266 UTC: //1766/00A9FBDE5401/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

040843: *Feb 21 14:11:21.514 UTC: //1766/00A9FBDE5401/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=1766

040844: *Feb 21 14:11:21.514 UTC: //1766/00A9FBDE5401/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

040845: *Feb 21 14:11:21.514 UTC: //1765/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

040846: *Feb 21 14:11:21.514 UTC: //1766/00A9FBDE5401/CCAPI/ccCallSetAAA_Accounting:

   Accounting=1, Call Id=1766

040847: *Feb 21 14:11:21.514 UTC: //1766/00A9FBDE5401/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

040848: *Feb 21 14:11:21.514 UTC: //1766/00A9FBDE5401/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

040849: *Feb 21 14:11:21.514 UTC: //1766/00A9FBDE5401/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=1766,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

040850: *Feb 21 14:11:21.518 UTC: //1766/00A9FBDE5401/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

040851: *Feb 21 14:11:21.518 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

040852: *Feb 21 14:11:21.518 UTC: :cc_free_feature_vsa freeing 87628D50

040853: *Feb 21 14:11:21.518 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

040854: *Feb 21 14:11:21.518 UTC:  vsacount in free is 1

040855: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=100, Params=0x86349904, Progress Indication=NULL(0)

040856: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccCheckClipClir:

   In: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

040857: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccCheckClipClir:

   Out: Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

040858: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetupRequest:

   Destination Pattern=.T, Called Number=911, Digit Strip=TRUE

040859: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccCallSetupRequest:

   Calling Number=3186411542(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=

   Account Number=Ball Reception - 4300, Final Destination Flag=TRUE,

   Guid=00A9FBDE-435E-7130-5401-73020A040382, Outgoing Dial-peer=100

040860: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=Ball Reception - 4300

   ----- ccCallInfo IE subfields -----

   cisco-ani=3186411542

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=911

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=-1

   cisco-rdnplan=-1

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0

040861: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x86E100A0, Interface Type=6, Destination=, Mode=0x0,

   Call Params(Calling Number=3186411542,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=911(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

040862: *Feb 21 14:11:21.518 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040863: *Feb 21 14:11:21.518 UTC: :cc_get_feature_vsa malloc success

040864: *Feb 21 14:11:21.518 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040865: *Feb 21 14:11:21.518 UTC:  cc_get_feature_vsa count is 2

040866: *Feb 21 14:11:21.518 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

040867: *Feb 21 14:11:21.518 UTC: :FEATURE_VSA attributes are: feature_name:0,feature_time:2271382872,feature_id:1708

040868: *Feb 21 14:11:21.518 UTC: //1767/00A9FBDE5401/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1

040869: *Feb 21 14:11:21.518 UTC: //1767/00A9FBDE5401/CCAPI/ccCallSetContext:

   Context=0x863498B4

040870: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=100

040871: *Feb 21 14:11:21.518 UTC: //1765/00A9FBDE5401/H323/cch323_do_set_dialpeer_tag: gw_id=1

040872: *Feb 21 14:11:21.522 UTC: //1767/00A9FBDE5401/CCAPI/cc_api_call_proceeding:

   Interface=0x86E100A0, Progress Indication=NULL(0)

040873: *Feb 21 14:11:22.774 UTC: //1767/00A9FBDE5401/CCAPI/cc_api_call_disconnected:

   Cause Value=34, Interface=0x86E100A0, Call Id=1767

040874: *Feb 21 14:11:22.774 UTC: //1767/00A9FBDE5401/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=34, Retry Count=0)

040875: *Feb 21 14:11:22.774 UTC: //1765/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

040876: *Feb 21 14:11:22.774 UTC: //1767/00A9FBDE5401/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=1767

040877: *Feb 21 14:11:22.774 UTC: //1767/00A9FBDE5401/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=34)

040878: *Feb 21 14:11:22.774 UTC: //1767/00A9FBDE5401/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

040879: *Feb 21 14:11:22.778 UTC: //1767/00A9FBDE5401/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x86E100A0, Tag=0x0, Call Id=1767,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

040880: *Feb 21 14:11:22.778 UTC: //1767/00A9FBDE5401/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

040881: *Feb 21 14:11:22.778 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

040882: *Feb 21 14:11:22.778 UTC: :cc_free_feature_vsa freeing 87628D50

040883: *Feb 21 14:11:22.778 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

040884: *Feb 21 14:11:22.778 UTC:  vsacount in free is 1

040885: *Feb 21 14:11:22.778 UTC: //-1/xxxxxxxxxxxx/H323/cch323_post_call_statistics: callID=1765

040886: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/CCAPI/ccCallDisconnect:

   Cause Value=34, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

040887: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/CCAPI/ccCallDisconnect:

   Cause Value=34, Call Entry(Responsed=TRUE, Cause Value=34)

040888: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

040889: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/H323/cch323_do_call_disconnect: gw_id=1, discCause=34

040890: *Feb 21 14:11:22.778 UTC: //-1/xxxxxxxxxxxx/H323/cch323_iev_queue_service: Dispatch 0x9 internal event to H225 SM

  Q931 Message IE Decodes

Protocol Discriminator : 0x08

CRV Length             : 2

CRV Value              : 0x8154

Message Type           : 0x5A: RELEASE_COMP

Cause: Length Of IE=2

Data 80A2

User-User: Length Of IE=34

Data 052580060008914A00041100110000A9FBDE435E7130540173020A04038210800100

040891: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/H323/cch323_call_generic_cleanup: Disconnected flag 1

040892: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/H323/cch323_store_call_history_entry: Call Active Playout Mode: 1,Init 60, Min 40, Max 1000, Fax 300

040893: *Feb 21 14:11:22.778 UTC: //1765/00A9FBDE5401/H323/cch323_store_call_history_entry: Call History Playout Mode: 1,Init 60, Min 40, Max 1000, Fax 300

040894: *Feb 21 14:11:22.782 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 2

040895: *Feb 21 14:11:22.782 UTC: //-1/xxxxxxxxxxxx/H323/cch323_cleanup_xport: hashDestroy for TcpFDTbl

040896: *Feb 21 14:11:22.782 UTC: //-1/xxxxxxxxxxxx/H323/h323_gw_clean_send_blocked_watch: fd 3

040897: *Feb 21 14:11:22.782 UTC: //1765/00A9FBDE5401/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x867581A8, Tag=0x0, Call Id=1765,

   Call Entry(Disconnect Cause=34, Voice Class Cause Code=0, Retry Count=0)

040898: *Feb 21 14:11:22.782 UTC: //1765/00A9FBDE5401/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

040899: *Feb 21 14:11:22.782 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

040900: *Feb 21 14:11:22.782 UTC: :cc_free_feature_vsa freeing 87628E30

040901: *Feb 21 14:11:22.782 UTC: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

040902: *Feb 21 14:11:22.782 UTC:  vsacount in free is 0

040903: *Feb 21 14:11:22.782 UTC: //-1/xxxxxxxxxxxx/H323/cch323_call_generic_cleanup: Freeing ccb (0x87BF6B7C)

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#

Ball#FAST BUSY

      ^

% Invalid input detected at '^' marker.

Ball#sh run | b dial-peer

dial-peer voice 201010 voip

preference 1

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.13

incoming called-number .

dtmf-relay h245-alphanumeric

!

dial-peer voice 200010 voip

preference 2

destination-pattern 4300

voice-class codec 1

session target ipv4:10.0.100.12

incoming called-number .

dtmf-relay h245-alphanumeric

!

dial-peer voice 100 pots

preference 1

destination-pattern .T

incoming called-number .

port 4

!

dial-peer voice 911 pots

preference 1

destination-pattern 911

incoming called-number .

port 4

forward-digits 3

!

!

!

line con 0

login local

no modem enable

line aux 0

line vty 0 4

access-class 101 in

login local

length 0

transport input telnet ssh

!

scheduler max-task-time 5000

scheduler allocate 4000 1000

scheduler interval 500

end

Ball#

Ball#

Green

H323 Call Routing - 911

Gerhard,

Could you run the call again buth this time with only debug vpm signal

undebug all

debug vpm signal

I want see what is happening on the actual FXO interface

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

041076: *Feb 21 15:57:38.205 UTC: htsp_timer_stop3 htsp_setup_req

041077: *Feb 21 15:57:38.209 UTC: htsp_process_event: [4, FXOLS_ONHOOK, E_HTSP_SETUP_REQ]fxols_onhook_setup

041078: *Feb 21 15:57:38.209 UTC: [4] set signal state = 0xC timestamp = 0

041079: *Feb 21 15:57:38.209 UTC: htsp_timer - 1300 msec

041080: *Feb 21 15:57:38.461 UTC: htsp_process_event: [4, FXOLS_WAIT_DIAL_TONE, E_DSP_SIG_1100]fxols_power_denial_detected

041081: *Feb 21 15:57:38.461 UTC: htsp_timer2 - 1000 msec

041082: *Feb 21 15:57:38.461 UTC: htsp_timer_stop

041083: *Feb 21 15:57:39.461 UTC: htsp_process_event: [4, FXOLS_WAIT_DIAL_TONE, E_HTSP_EVENT_TIMER2]fxols_power_den_disc

041084: *Feb 21 15:57:39.461 UTC: htsp_timer_stop

041085: *Feb 21 15:57:39.461 UTC: htsp_timer_stop2

041086: *Feb 21 15:57:39.461 UTC: [4] set signal state = 0x4 timestamp = 0

041087: *Feb 21 15:57:39.461 UTC: htsp_process_event: [4, FXOLS_ONHOOK, E_HTSP_RELEASE_REQ]fxols_onhook_release

041088: *Feb 21 15:57:39.465 UTC: htsp_timer_stop3 htsp_setup_req

041089: *Feb 21 15:57:39.465 UTC: htsp_process_event: [4, FXOLS_ONHOOK, E_HTSP_SETUP_REQ]fxols_onhook_setup

041090: *Feb 21 15:57:39.465 UTC: [4] set signal state = 0xC timestamp = 0

041091: *Feb 21 15:57:39.465 UTC: htsp_timer - 1300 msec

041092: *Feb 21 15:57:39.717 UTC: htsp_process_event: [4, FXOLS_WAIT_DIAL_TONE, E_DSP_SIG_1100]fxols_power_denial_detected

041093: *Feb 21 15:57:39.717 UTC: htsp_timer2 - 1000 msec

041094: *Feb 21 15:57:39.717 UTC: htsp_timer_stop

041095: *Feb 21 15:57:40.717 UTC: htsp_process_event: [4, FXOLS_WAIT_DIAL_TONE, E_HTSP_EVENT_TIMER2]fxols_power_den_disc

041096: *Feb 21 15:57:40.717 UTC: htsp_timer_stop

041097: *Feb 21 15:57:40.717 UTC: htsp_timer_stop2

041098: *Feb 21 15:57:40.717 UTC: [4] set signal state = 0x4 timestamp = 0

041099: *Feb 21 15:57:40.717 UTC: htsp_process_event: [4, FXOLS_ONHOOK, E_HTSP_RELEASE_REQ]fxols_onhook_release

Ball#

Ball#

Ball#

Green

H323 Call Routing - 911

Gerhard,

FXOLS_WAIT_DIAL_TONE, E_DSP_SIG_1100]fxols_power_denial_detected

The FXO port is reporting that it does not have dial tone

Can you ensure that you have the right signal type configured to match your service provider

The default is loop-start

but it can be ground-start if that was asked for

Can you also ensure that you have only connected 2 wires on you FXO/RJ11

Only pins 3 & 4 should be connected to the lines tip & ring ( or A & B)

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

Alex,

what doesn't make sense is why is the other call going throught then?   this office is remote to me... like a plane ride, so i don't have access to verify some of the things you've asked...   this was a snip from the previous post.

We only have 1 POTS line in the router on port 4.....

In your original post you showed a GOOD call to a 10 digit number

Calling Number=4300, Called Number=13188406637, Voice-Interface=0x0,

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

Peer Info Type=DIALPEER_INFO_SPEECH

000184: *Feb 17 19:45:23.436 UTC: //-1/004955D92E01/DPM/dpAssociateIncomingPeerCore:

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

000188: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

Match Rule=DP_MATCH_DEST; Called Number=13188406637

000189: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersCore:

Result=Success(0) after DP_MATCH_DEST

000190: *Feb 17 19:45:23.440 UTC: //-1/004955D92E01/DPM/dpMatchPeersMoreArg:

Result=SUCCESS(0)

List of Matched Outgoing Dial-peer(s):

1: Dial-peer Tag=100

These were selected by dial peer matching

so your CALLING PHONE No was 4300 that matched DP 201010

and your CALLED No was 13188406637 that mateches the .T in DP 100

New Member

H323 Call Routing - 911

whats odd, i had them call the number again and the debug vpm signal yields the same results, but the call works....

Ball#13188406637

% Unknown command or computer name, or unable to find computer address

Ball#

041117: *Feb 21 17:17:56.417 UTC: htsp_timer_stop3 htsp_setup_req

041118: *Feb 21 17:17:56.421 UTC: htsp_process_event: [4, FXOLS_ONHOOK, E_HTSP_SETUP_REQ]fxols_onhook_setup

041119: *Feb 21 17:17:56.421 UTC: [4] set signal state = 0xC timestamp = 0

041120: *Feb 21 17:17:56.421 UTC: htsp_timer - 1300 msec

041121: *Feb 21 17:17:56.673 UTC: htsp_process_event: [4, FXOLS_WAIT_DIAL_TONE, E_DSP_SIG_1100]fxols_power_denial_detected

041122: *Feb 21 17:17:56.673 UTC: htsp_timer2 - 1000 msec

041123: *Feb 21 17:17:56.673 UTC: htsp_timer_stop

041124: *Feb 21 17:17:57.673 UTC: htsp_process_event: [4, FXOLS_WAIT_DIAL_TONE, E_HTSP_EVENT_TIMER2]fxols_power_den_disc

041125: *Feb 21 17:17:57.673 UTC: htsp_timer_stop

041126: *Feb 21 17:17:57.673 UTC: htsp_timer_stop2

041127: *Feb 21 17:17:57.673 UTC: [4] set signal state = 0x4 timestamp = 0

041128: *Feb 21 17:17:57.673 UTC: htsp_process_event: [4, FXOLS_ONHOOK, E_HTSP_RELEASE_REQ]fxols_onhook_release

New Member

H323 Call Routing - 911

call was to the 1318 number listed above the debug

New Member

H323 Call Routing - 911

This is the only config on the voice port.

voice-port 4

connection plar 4300

caller-id enable

!

Green

H323 Call Routing - 911

Hi,

Can you have a look at post

https://supportforums.cisco.com/thread/2213848

Suffering from the same isue as you.

Looks to be a cabling/Service provider issue.

I cant understand why your other call works when the voice port is reporting "fxols_power_denial_detected"

because this means it is not seeing the correct voltage on the telephone line.

Regards,
Alex.
Please rate useful posts.

Regards, Alex. Please rate useful posts.
New Member

H323 Call Routing - 911

Alex,

We were hitting many things here.... Mis information on my remotes end... amongst other things...

Turns out the line connected to the FXO port was disconnect by telco... OMG!!!!

I think we have it now... THANKS FOR ALL YOUR HELP!!!!!!!!

644
Views
0
Helpful
19
Replies
CreatePlease login to create content