cme auto attendent not working

syed baseeruddin · ‎01-20-2013

in our site one call manger and one gateway and one fxo line gateway ip add 192.168.100.254

call manger ip add 192.168.1.10

sh terma
HQ-Router#terminal le
HQ-Router#terminal length n 0
HQ-Router#sh run
Building configuration...

Current configuration : 2046 bytes
!
! Last configuration change at 08:40:10 UTC Sun Jan 20 2013
!
version 15.0
service timestamps debug datetime msec
service timestamps log datetime msec
no service password-encryption
!
hostname HQ-Router
!
boot-start-marker
boot-end-marker
!
! card type command needed for slot/vwic-slot 0/0
enable password cisco
!
no aaa new-model
!
no ipv6 cef
ip source-route
ip cef
!
!
!
!
multilink bundle-name authenticated
!
!
!
!
!
!
!
voice-card 0
!
!
!
!
!
!
!
application
service aa flash:stc-r1.tcl
paramspace english language en
paramspace english index 1
paramspace english location flash:
param aaPilot 3000
paramspace english prefix en
param oprtr 3005
!
!
license udi pid CISCO2951/K9 sn FGL150412TT
hw-module pvdm 0/0
!
!
!
!
redundancy
!
!
!
!
!
!
interface GigabitEthernet0/0
ip address 192.168.100.254 255.255.255.0
duplex auto
speed auto
!
interface GigabitEthernet0/1
ip address 192.168.150.254 255.255.255.0
duplex auto
speed auto
!
interface GigabitEthernet0/2
no ip address
shutdown
duplex auto
speed auto
!
ip forward-protocol nd
!
no ip http server
no ip http secure-server
!
ip route 0.0.0.0 0.0.0.0 192.168.150.1
ip route 192.168.1.0 255.255.255.0 192.168.100.1
ip route 192.168.10.0 255.255.255.0 192.168.100.1
ip route 192.168.70.0 255.255.255.0 192.168.100.1
!
!
nls resp-timeout 1
cpd cr-id 1
!
!
control-plane
!
!
voice-port 0/1/0
supervisory disconnect dualtone mid-call
input gain 6
cptone SA
timeouts call-disconnect 2
timeouts wait-release 2
connection plar opx 3000
caller-id enable
!
voice-port 0/1/1
!
!
!
!
dial-peer voice 20 pots
service aa
incoming called-number 3000
port 0/1/0
!
dial-peer voice 22 voip
description AUTO-ATTANDENT-PILOT-NUMBER
service aa
destination-pattern 3000
session target ipv4:192.168.100.254
incoming called-number 3000
dtmf-relay h245-alphanumeric
codec g711ulaw
no vad
!
dial-peer voice 25 pots
service aa
port 0/1/0
!
!
!
!
gatekeeper
shutdown
!
!
line con 0
line aux 0
line vty 0 4
password cisco
login
!
scheduler allocate 20000 1000
end

HQ-Router#ter
HQ-Router#terminal l

debug voice ccapi INOUt
voip ccapi inout debugging is on
HQ-Router#
*Jan 20 08:28:30.054: //-1/3447097D8016/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=3000
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Jan 20 08:28:30.054: //-1/3447097D8016/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x1264653C, Call Info(
   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3000(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=20, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
*Jan 20 08:28:30.054: //-1/3447097D8016/CCAPI/ccCheckClipClir:
   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jan 20 08:28:30.054: //-1/3447097D8016/CCAPI/ccCheckClipClir:
   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jan 20 08:28:30.054: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jan 20 08:28:30.054: :cc_get_feature_vsa malloc success
*Jan 20 08:28:30.054: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jan 20 08:28:30.054: cc_get_feature_vsa count is 1
*Jan 20 08:28:30.054: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jan 20 08:28:30.054: :FEATURE_VSA attributes are: feature_name:0,feature_time:296072744,feature_id:9
*Jan 20 08:28:30.054: //17/3447097D8016/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3000(TON=Unknown, NPI=Unknown))
*Jan 20 08:28:30.054: //17/3447097D8016/CCAPI/cc_process_call_setup_ind:
   Event=0x1261A040
*Jan 20 08:28:30.054: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 3000
*Jan 20 08:28:30.054: //17/3447097D8016/CCAPI/ccCallSetContext:
   Context=0x11AA7998
*Jan 20 08:28:30.054: //17/3447097D8016/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 17 with tag 20 to app "_ManagedAppProcess_aa"
*Jan 20 08:28:30.054: //17/3447097D8016/CCAPI/ccCallSetupAck:
   Call Id=17
*Jan 20 08:28:30.054: //17/3447097D8016/CCAPI/cc_api_set_transfer_info:
   Transfer Number=, Transfer Reason=0x0
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccCallApp:
   Call Id=17
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=FALSE, Mode=0,
   Outgoing Dial-peer=22, Params=0x11AA8CF0, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccCheckClipClir:
   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccCheckClipClir:
   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccCallSetupRequest:
   Destination Pattern=3000, Called Number=3000, Digit Strip=FALSE
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccCallSetupRequest:
   Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3000(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=
   Account Number=, Final Destination Flag=TRUE,
   Guid=3447097D-6212-11E2-8016-FD6F26A381EC, Outgoing Dial-peer=22
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=3000
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x969D37C, Interface Type=1, Destination=, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3000(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=22, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*Jan 20 08:28:30.058: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jan 20 08:28:30.058: :cc_get_feature_vsa malloc success
*Jan 20 08:28:30.058: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jan 20 08:28:30.058: cc_get_feature_vsa count is 2
*Jan 20 08:28:30.058: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jan 20 08:28:30.058: :FEATURE_VSA attributes are: feature_name:0,feature_time:296072520,feature_id:10
*Jan 20 08:28:30.058: //18/3447097D8016/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=1, FlowMode=1
*Jan 20 08:28:30.058: //18/3447097D8016/CCAPI/ccCallSetContext:
   Context=0x11AA8CA0
*Jan 20 08:28:30.058: //17/3447097D8016/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=22
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/cc_api_call_disconnected:
   Cause Value=27, Interface=0x969D37C, Call Id=18
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=27, Retry Count=0)
*Jan 20 08:28:30.066: //17/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/ccCallSetAAA_Accounting:
   Accounting=0, Call Id=18
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/ccCallDisconnect:
   Cause Value=27, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=27)
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/ccCallDisconnect:
   Cause Value=27, Call Entry(Responsed=TRUE, Cause Value=27)
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x969D37C, Tag=0x0, Call Id=18,
   Call Entry(Disconnect Cause=27, Voice Class Cause Code=0, Retry Count=0)
*Jan 20 08:28:30.066: //18/3447097D8016/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Jan 20 08:28:30.066: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jan 20 08:28:30.066: :cc_free_feature_vsa freeing 11A5B540
*Jan 20 08:28:30.066: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jan 20 08:28:30.066: vsacount in free is 1
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/ccCallAppReturn:
   Conference Id=0xFFFFFFFF, Call Id=17
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/ccCallSetContext:
   Context=0x11AA7998
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
*Jan 20 08:28:30.066: //17/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x11, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=17
*Jan 20 08:28:30.066: //17/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x1264653C, callID=0x11, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x1264653C, Call Id=17
*Jan 20 08:28:30.066: //17/3447097D8016/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/ccDisassociateStream:
   Record Context=0x0, Stream Call Id=19, Call Id=17
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/ccDisassociateStream:
   Call Entry(Stream Status=1, Digit Enable=TRUE)
*Jan 20 08:28:30.118: //17/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x11, digit_event=0x0, enable=FALSE, consume=FALSE)
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=17
*Jan 20 08:28:30.118: //17/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x1264653C, callID=0x11, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x1264653C, Call Id=17
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x1264653C, Tag=0x0, Call Id=17,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jan 20 08:28:30.118: //17/3447097D8016/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Jan 20 08:28:30.118: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jan 20 08:28:30.118: :cc_free_feature_vsa freeing 11A5B620
*Jan 20 08:28:30.118: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jan 20 08:28:30.118: vsacount in free is 0

giftonabel · ‎01-23-2013

Hi Syed,

I see a CallDisconnect with a Cause Value=27, which describes "Application no longer exists".

Can you pls check if the tcl script is correct.

Note: also check if the command "param aa-pilot aa-pilot-number" is configured properly.

HTH,

Gifton Abel.

syed baseeruddin · ‎01-23-2013

Hi giftonabel

the commands param from script are

proc init_ConfigVars { }

global destination

global aaPilot

global oprtr

we also test default script also the call is only ringing at the gateway and no autoattendent greeting is playing

when we change the script and and apply default script its showing cause 16 error how to understand this cause value

giftonabel · ‎01-24-2013

Hi Syed,

The cause 16 describes "Normal call clearing", you can refer the below URL to check cause code information-

http://www.cisco.com/en/US/docs/ios/12_3/vvf_c/voice_troubleshooting/old/vts_appa.html

Regards,

Gifton Abel.