[cisco-voip] Integrating Channel Bank IVR with 2811/CCM
Dave Wolgast
dwolgas1 at rochester.rr.com
Tue Dec 12 11:27:27 EST 2006
Per Barbie's suggestion, I created a specific inbound dialpeer:
dial-peer voice 8522 pots
incoming called-number 8522
port 0/0/0:1
which appears to be matched when the IVR goes off hook. We currently have
the IVR repeatedly trying to place a call. For each debug I attach, one
call cycle is included.
Here are the debug results:
debug vpm sig
*Dec 12 12:12:04.355: htsp_process_event: [0/0/0:1(13), FXSLS_ONHOOK,
E_DSP_SIG_
1100]fxsls_onhook_offhook htsp_setup_ind
*Dec 12 12:12:04.355: [0/0/0:1(13)] get_local_station_id calling num=
calling na
me= calling time=12/12 12:12 orig called=
*Dec 12 12:12:04.359: htsp_process_event: [0/0/0:1(13),
FXSLS_WAIT_SETUP_ACK, E_
HTSP_SETUP_ACK]fxsls_check_auto_call
*Dec 12 12:12:06.483: htsp_process_event: [0/0/0:1(13), FXSLS_OFFHOOK,
E_DSP_SIG
_0100]fxsls_offhook_onhook, HF duration Max=1000, HF duration Min=150
*Dec 12 12:12:06.483: htsp_timer - 1000 msec
*Dec 12 12:12:07.483: htsp_process_event: [0/0/0:1(13), FXSLS_OFFHOOK,
E_HTSP_EV
ENT_TIMER]fxsls_offhook_timer
*Dec 12 12:12:07.491: htsp_process_event: [0/0/0:1(13), FXSLS_ONHOOK,
E_HTSP_REL
EASE_REQ]fxsls_onhook_release
*Dec 12 12:12:07.491: htsp_timer_stop
debug voip dialpeer
*Dec 12 12:09:53.563: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:
Calling Number=, Called Number=, Voice-Interface=0x44CF465C,
Timeout=TRUE, Peer Encap Type=ENCAP_VOICE, Peer Search
Type=PEER_TYPE_VOICE,
Peer Info Type=DIALPEER_INFO_SPEECH
*Dec 12 12:09:53.563: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:
Match Rule=DP_MATCH_PORT;
*Dec 12 12:09:53.563: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore:
Result=Success(0) after DP_MATCH_PORT; Incoming Dial-peer=8522
*Dec 12 12:09:53.563: //-
1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerSPI:exit at 5931
debug voip vtsp all
*Dec 12 12:04:51.347:
//-1/CBDF20C08237/VTSP:(0/0/0:1):-1:-1:-1/vtsp_free_cdb:
CDB=0x457EC080
*Dec 12 12:04:52.347:
//-1/xxxxxxxxxxxx/VTSP:(0/0/0:1):-1:-1:-1/vtsp_allocate_cd
b:
CDB=0x457EBDD8
*Dec 12 12:04:52.347:
//-1/xxxxxxxxxxxx/VTSP:(0/0/0:1):-1:-1:-1/vtsp_do_call_set
up_ind:
Event=E_TSP_SETUP_IND
Progress Indication=3, CarrierIDCode=, Info Trans Capability=144, Source
Carr
ier ID=, tg_label_flag=0
*Dec 12 12:04:52.347:
//-1/CEBB8D46823A/VTSP:(0/0/0:1):-1:-1:-1/vtsp_do_normal_c
all_setup_ind:
*Dec 12 12:04:52.347: //-1/CEBB8D46823A/VTSP:(0/0/0:1):-1:-1:-1/vtsp_timer:
Timer Start Time=6612339, Timer Value=180000(ms)
*Dec 12 12:04:52.347:
//-1/CEBB8D46823A/VTSP:(0/0/0:1):-1:-1:-1/vtsp_do_normal_c
all_setup_ind:
IC State Machine (ICSM) Added
*Dec 12 12:04:52.351:
//-1/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_indicate_call
:
*Dec 12 12:04:52.351:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_insert_cdb:
*Dec 12 12:04:52.351:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_report_digit
_control:
*Dec 12 12:04:52.351:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_report_digit
_control:
Digit Reporting=TRUE
*Dec 12 12:04:52.351:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_process_even
t:
[state:S_SETUP_INDICATED, event:E_CC_SETUP_ACK]
*Dec 12 12:04:52.351:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_setup_ind_ack
:
Fax Relay=TRUE, Dial Tone=TRUE, Digit Collect=TRUE, Overlap=FALSE,
DID=FALSE
*Dec 12 12:04:52.351:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_timer_stop:
Timer Stop Time=6612340
*Dec 12 12:04:55.451:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_process_even
t:
[state:S_DIGIT_COLLECT, event:E_TSP_CALL_FEATURE_IND]
*Dec 12 12:04:55.451:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_call_feature_
ind:
Feature Type=5
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_process_even
t:
[state:S_DIGIT_COLLECT, event:E_TSP_DISCONNECT_IND]
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_generate_disc
:
Cause Value=16
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_timer_stop:
Timer Stop Time=6612777
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_ring_noan_ti
mer_stop:
Timer Stop Time=6612777
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_set_release_
source:
Release Direction=PSTN, Release Source=Calling Party-PSTN
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_cc_call_disc
onnected:
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_cc_call_disc
onnected:
Cause Value=16
*Dec 12 12:04:56.727: //275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_timer:
Timer Start Time=6612777, Timer Value=15000(ms)
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_generate_disc
:
Return Code=0
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_process_even
t:
[state:S_WAIT_HOST_DISC, event:E_CC_DISCONNECT]
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_host_disc_cle
anup:
dsm_indicate_error=0, short_cleardown_timeout=1, Mode=0
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_dsm_save_fax
_config:
*Dec 12 12:04:56.727:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_dsm_save_fax
_config:
Call Entry=NULL, Call Id=-1
*Dec 12 12:04:56.731:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_host_disc_cle
anup:
Exit State=16
*Dec 12 12:04:56.731:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_process_even
t:
[state:S_WAIT_STATS, event:E_VTSP_DSM_STATS_COMPLETE]
*Dec 12 12:04:56.731:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_dsm_dsp_stats
_complete:
*Dec 12 12:04:56.735: //275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_timer:
Timer Start Time=6612778, Timer Value=60000(ms)
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_process_even
t:
[state:S_WAIT_RELEASE, event:E_TSP_DISCONNECT_CONF]
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/act_wrelease_rele
ase:
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_play_busy_ti
mer_stop:
Timer Stop Time=6612778
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_timer_stop:
Timer Stop Time=6612778
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_do_call_hist
ory:
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_do_call_hist
ory:
Coder Rate=-1
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:3:1/vtsp_dsm_closed_c
b:
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:-1:-1/vtsp_process_ev
ent:
[state:S_CLOSE_DSPRM, event:E_VTSP_DSM_CLOSE_COMPLETE]
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:-1:-1/act_terminate:
*Dec 12 12:04:56.735:
//275/CEBB8D46823A/VTSP:(0/0/0:1):-1:-1:-1/vtsp_timer_stop
:
Timer Stop Time=6612778
debug voip ccapi inout
*Dec 12 12:03:19.847: //-1/97988EDC81FE/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=
cisco-desttype=0
cisco-destplan=0
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=0
*Dec 12 12:03:19.847: //-1/97988EDC81FE/CCAPI/cc_api_call_setup_ind_common:
Interface=0x44CF465C, Call Info(
Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened,
Presentatio
n=Allowed),
Called Number=(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subsriber Type Str=RegularLine,
FinalDestinationFla
g=FALSE,
Incoming Dial-peer=8522, Progress Indication=ORIGINATING SIDE IS NON
ISDN(3),
Calling IE Present=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID
Transparent=FALS
E), Call Id=-1
*Dec 12 12:03:19.847: //-1/97988EDC81FE/CCAPI/ccCheckClipClir:
In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened,
Present
ation=Allowed)
*Dec 12 12:03:19.847: //-1/97988EDC81FE/CCAPI/ccCheckClipClir:
Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened,
Presen
tation=Allowed)
*Dec 12 12:03:19.847: //255/97988EDC81FE/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not
Screened, P
resentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown))
*Dec 12 12:03:19.847: //255/97988EDC81FE/CCAPI/cc_process_call_setup_ind:
Event=0x45328288
*Dec 12 12:03:19.847: //255/97988EDC81FE/CCAPI/ccCallSetContext:
Context=0x457F4064
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 255 with tag 8522 to app "Default"
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/ccCallSetupAck:
Call Id=255
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/cc_api_set_transfer_info:
Transfer Number=, Transfer Reason=0x0
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=TRUE, Tone=Dial Tone,
Tone Direction=Network, Params=0x0, Call Id=255
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/ccSetDigitTimeouts:
Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/ccSetDigitTimeouts:
Call Entry(Inter Digit Timeout=10000(ms), Initial Digit
Timeout=10000(ms))
*Dec 12 12:03:19.851: //255/97988EDC81FE/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=255
*Dec 12 12:03:19.851:
//255/97988EDC81FE/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x44CF465C, Call Id=255
*Dec 12 12:03:19.851:
//255/97988EDC81FE/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=10000(ms), Inter Digit
Timeout=10000(ms))
*Dec 12 12:03:22.359: //255/97988EDC81FE/CCAPI/cc_api_call_feature:
Feature Type=5, Interface=0x44CF465C, Call Id=255
*Dec 12 12:03:23.599: //255/97988EDC81FE/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x44CF465C, Call Id=255
*Dec 12 12:03:23.599: //255/97988EDC81FE/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=FALSE, Cause Value=16, Retry Count=0)
*Dec 12 12:03:23.599: //255/97988EDC81FE/CCAPI/ccRestartDigitTimeoutMsec:
Digit Timeout=0, Call Id=255
*Dec 12 12:03:23.599: //255/97988EDC81FE/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0,
Disconnect C
ause=16)
*Dec 12 12:03:23.599: //255/97988EDC81FE/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Dec 12 12:03:23.599: //255/97988EDC81FE/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
*Dec 12 12:03:23.603: //255/97988EDC81FE/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x44CF465C, Tag=0x0, Call Id=255,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Dec 12 12:03:23.603: //255/97988EDC81FE/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Any h.245 and h.225 debugs produce no result.
Any additional help is greatly appreciated.
--
Dave Wolgast
Livonia, NY
-------------- next part --------------
An HTML attachment was scrubbed...
URL: https://puck.nether.net/pipermail/cisco-voip/attachments/20061212/bb7102ef/attachment.html
More information about the cisco-voip
mailing list