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

Incoming Calls Have No Ringback, Goes to Fast Busy Tone

Recently, our provider had an outage. Coming back from the outage, our incoming calls are not working. Caller dials in and gets no ring back and then gets a fast busy tone. Carrier says everything is okay on their end. Any clues to why calls aren't working normally?

These are the logs I collected:

vg-3845#debug voip vtsp all

voip vtsp all debugging is on

vg-3845#u all

Jan 24 19:02:36 MST: //-1/xxxxxxxxxxxx/VTSP:(0/1/0:1):-1:-1:-1/vtsp_allocate_cdb:

   CDB=0x6B0F98C0

Jan 24 19:02:36 MST: //-1/xxxxxxxxxxxx/VTSP:(0/1/0:1):-1:-1:-1/vtsp_do_call_setup_ind:

   Event=E_TSP_SETUP_IND

   Progress Indication=3, CarrierIDCode=, Info Trans Capability=144, Source Carrier ID=, tg_label_flag=0

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_do_normal_call_setup_ind:

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_timer:

   Timer Start Time=2788497, Timer Value=180000(ms)

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_do_normal_call_setup_ind:

   XCC State Machine (XCCSM) Added

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_insert_cdb:

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_dsm_opened_cb:

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_SETUP_IND_PEND, event:E_VTSP_DSM_OPEN_SUCCESS]

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/act_setup_ind_pend_success:

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_realloc_cdb:

   CDB=0x6B0F98C0

Jan 24 19:02:36 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_indicate_call:

Jan 24 19:02:36 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_insert_cdb:

vg-3845#u all

Jan 24 19:02:36 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_timer:

   Timer Start Time=2788497, Timer Value=180000(ms)

vg-3845#u all

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_SETUP_INDICATED, event:E_TSP_DISCONNECT_IND]

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/act_generate_disc:

   Cause Value=31

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_timer_stop:

   Timer Stop Time=2788797

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_ring_noan_timer_stop:

   Timer Stop Time=2788797

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_set_release_source:

   Release Direction=PSTN, Release Source=Calling Party-PSTN

vg-3845#u all

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_cc_call_disconnected:

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_cc_call_disconnected:

   Cause Value=31

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_timer:

   Timer Start Time=2788797, Timer Value=15000(ms)

Jan 24 19:02:39 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/act_generate_disc:

   Return Code=0

vg-3845#u all

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_WAIT_HOST_DISC, event:E_TSP_CALL_FEATURE_IND]

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   Unexpected EVENT [E_TSP_CALL_FEATURE_IND] Received For STATE [S_WAIT_HOST_DISC];

   Previous STATE [0.3 ]

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_WAIT_HOST_DISC, event:E_TSP_DISCONNECT_CONF]

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/act_wrelease_release:

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_play_busy_timer_stop:

   Timer Stop Time=2789008

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_timer_stop:

   Timer Stop Time=2789008

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_do_call_history:

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:1:1/vtsp_do_call_history:

   Coder Rate=-1

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_dsm_closed_cb:

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_process_event:

   [state:S_CLOSE_DSPRM, event:E_VTSP_DSM_CLOSE_COMPLETE]

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/act_terminate:

Jan 24 19:02:41 MST: //458/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_timer_stop:

   Timer Stop Time=2789008

Jan 24 19:02:41 MST: //-1/983D3CBA8726/VTSP:(0/1/0:1):-1:-1:-1/vtsp_free_cdb:

   CDB=0x6B0F98C0

Jan 24 19:02:41 MST: //-1/xxxxxxxxxxxx/VTSP:(0/1/0:1):-1:-1:-1/vtsp_allocate_cdb:

   CDB=0x6B0F9600

Jan 24 19:02:41 MST: //-1/xxxxxxxxxxxx/VTSP:(0/1/0:1):-1:-1:-1/vtsp_do_call_setup_ind:

   Event=E_TSP_SETUP_IND

   Progress Indication=3, CarrierIDCode=, Info Trans Capability=144, Source Carrier ID=, tg_label_flag=0

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_do_normal_call_setup_ind:

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_timer:

   Timer Start Time=2789016, Timer Value=180000(ms)

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_do_normal_call_setup_ind:

   XCC State Machine (XCCSM) Added

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_insert_cdb:

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_dsm_opened_cb:

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_SETUP_IND_PEND, event:E_VTSP_DSM_OPEN_SUCCESS]

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/act_setup_ind_pend_success:

vg-3845#u all

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_realloc_cdb:

   CDB=0x6B0F9600

Jan 24 19:02:41 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_indicate_call:

Jan 24 19:02:41 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_insert_cdb:

Jan 24 19:02:41 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_timer:

   Timer Start Time=2789016, Timer Value=180000(ms)

vg-3845#u all

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_SETUP_INDICATED, event:E_TSP_DISCONNECT_IND]

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/act_generate_disc:

   Cause Value=31

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_timer_stop:

   Timer Stop Time=2789316

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_ring_noan_timer_stop:

   Timer Stop Time=2789316

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_set_release_source:

   Release Direction=PSTN, Release Source=Calling Party-PSTN

vg-3845#u all

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_cc_call_disconnected:

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_cc_call_disconnected:

   Cause Value=31

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_timer:

   Timer Start Time=2789316, Timer Value=15000(ms)

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/act_generate_disc:

   Return Code=0

vg-3845#u all

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_WAIT_HOST_DISC, event:E_TSP_CALL_FEATURE_IND]

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   Unexpected EVENT [E_TSP_CALL_FEATURE_IND] Received For STATE [S_WAIT_HOST_DISC];

   Previous STATE [0.3 ]

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_process_event:

   [state:S_WAIT_HOST_DISC, event:E_TSP_DISCONNECT_CONF]

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/act_wrelease_release:

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_play_busy_timer_stop:

   Timer Stop Time=2789525

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_timer_stop:

   Timer Stop Time=2789525

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_do_call_history:

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_do_call_history:

   Coder Rate=-1

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_dsm_closed_cb:

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_process_event:

   [state:S_CLOSE_DSPRM, event:E_VTSP_DSM_CLOSE_COMPLETE]

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/act_terminate:

vg-3845#u all

Jan 24 19:02:46 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_timer_stop:

   Timer Stop Time=2789525

Jan 24 19:02:46 MST: //-1/9B54DDED872A/VTSP:(0/1/0:1):-1:-1:-1/vtsp_free_cdb:

   CDB=0x6B0F9600

vg-3845#debug voip ccapi inout

voip ccapi inout debugging is on

vg-3845#ual        

Jan 24 19:22:00 MST: htsp_process_event: [0/1/0:1(24), EM_ONHOOK, E_DSP_SIG_1100]em_onhook_offhook

Jan 24 19:22:00 MST: htsp_timer - 50 msec

Jan 24 19:22:00 MST: htsp_process_event: [0/1/0:1(24), EM_QUALIFY_SEIZURE, E_HTSP_EVENT_TIMER]em_qualify_seizure_timeouthtsp_setup_ind

Jan 24 19:22:00 MST: [0/1/0:1(24)] get_local_station_id calling num= calling name= calling time=01/24 19:22  orig called=

Jan 24 19:22:00 MST: htsp_timer - 3000 msec

Jan 24 19:22:00 MST: //-1/4E84F6B58782/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-rdie=FFFFFFFF

   cisco-rdn=

   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 24 19:22:00 MST: //-1/4E84F6B58782/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x66F27200, Call Info(

   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=999010991, 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 24 19:22:00 MST: //-1/4E84F6B58782/CCAPI/ccCheckClipClir:

   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:00 MST: //-1/4E84F6B58782/CCAPI/ccCheckClipClir:

   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:00 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:00 MST: :cc_get_feature_vsa malloc success

Jan 24 19:22:00 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:00 MST:  cc_get_feature_vsa count is 1

Jan 24 19:22:00 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:00 MST: :FEATURE_VSA attributes are: feature_name:0,feature_time:1722625968,feature_id:481

Jan 24 19:22:00 MST: //481/4E84F6B58782/CCAPI/cc_api_call_setup_ind_common:

vg-3845#Set Up Event Sent;

   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

Jan 24 19:22:00 MST: //481/4E84F6B58782/CCAPI/cc_process_call_setup_ind:

   Event=0x6B504AE0

Jan 24 19:22:00 MST: //481/4E84F6B58782/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 481 with tag 999010991 to app "MGCPAPP"

vg-3845#

Jan 24 19:22:03 MST: htsp_process_event: [0/1/0:1(24), EM_WAIT_SETUP_ACK, E_HTSP_EVENT_TIMER]em_wait_setup_ack_timer

Jan 24 19:22:03 MST: em_start_timer: 400 ms

Jan 24 19:22:03 MST: htsp_timer - 400 msec

Jan 24 19:22:03 MST: htsp_timer_stop2 em_onhook (0)vnm_dsp_set_sig_state:[recEive and transMit0/1/0:1(24)] set signal state = 0x0

Jan 24 19:22:03 MST: //481/4E84F6B58782/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x66F27200, Call Id=481

Jan 24 19:22:03 MST: //481/4E84F6B58782/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=FALSE, Cause Value=31, Retry Count=0)

vg-3845#

Jan 24 19:22:04 MST: htsp_process_event: [0/1/0:1(24), EM_GUARD_ALL, E_HTSP_EVENT_TIMER]em_guard_all_timer

Jan 24 19:22:04 MST: em_stop_timers

Jan 24 19:22:04 MST: htsp_timer_stop

Jan 24 19:22:04 MST: em_start_timer: 3000 ms

Jan 24 19:22:04 MST: htsp_timer - 3000 msec

Jan 24 19:22:04 MST: htsp_process_event: [0/1/0:1(24), EM_PARK, E_DSP_SIG_1100]em_park_offhook

Jan 24 19:22:04 MST: htsp_timer_stop

Jan 24 19:22:04 MST: htsp_timer_stop2

Jan 24 19:22:04 MST: htsp_timer2 - 10000 msec

Jan 24 19:22:05 MST: htsp_process_event: [0/1/0:1(23), EM_ONHOOK, E_DSP_SIG_1100]em_onhook_offhook

Jan 24 19:22:05 MST: htsp_timer - 50 msec

Jan 24 19:22:05 MST: htsp_process_event: [0/1/0:1(24), EM_PARK, E_DSP_SIG_0000]em_park_onhook

Jan 24 19:22:05 MST: htsp_timer_stop

Jan 24 19:22:05 MST: htsp_timer_stop2 htsp_report_onhook_sig

Jan 24 19:22:05 MST: //481/4E84F6B58782/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x66F27200, Tag=0x0, Call Id=481,

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

Jan 24 19:22:05 MST: //481/4E84F6B58782/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 24 19:22:05 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:05 MST: :cc_free_feature_vsa freeing 66AD2FA8

Jan 24 19:22:05 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:05 MST:  vsacount in free is 0

Jan 24 19:22:06 MST: htsp_process_event: [0/1/0:1(23), EM_QUALIFY_SEIZURE, E_HTSP_EVENT_TIMER]em_qualify_seizure_timeouthtsp_setup_ind

Jan 24 19:22:06 MST: [0/1/0:1(23)] get_local_station_id calling num= calling name= calling time=01/24 19:22  orig called=

Jan 24 19:22:06 MST: htsp_timer - 3000 msec

Jan 24 19:22:06 MST: //-1/519B619D8786/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-rdie=FFFFFFFF

   cisco-rdn=

   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 24 19:22:06 MST: //-1/519B619D8786/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x66F27200, Call Info(

   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=999010991, 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 24 19:22:06 MST: //-1/519B619D8786/CCAPI/ccCheckClipClir:

   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:06 MST: //-1/519B619D8786/CCAPI/ccCheckClipClir:

   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:06 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:06 MST: :cc_get_feature_vsa malloc success

Jan 24 19:22:06 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:06 MST:  cc_get_feature_vsa count is 1

Jan 24 19:22:06 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:06 MST: :FEATURE_VSA attributes are: feature_name:0,feature_time:1722625968,feature_id:482

Jan 24 19:22:06 MST: //482/519B619D8786/CCAPI/cc_api_call_setup_ind_common:

vg-3845#Set Up Event Sent;

   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

Jan 24 19:22:06 MST: //482/519B619D8786/CCAPI/cc_process_call_setup_ind:

   Event=0x6B502EF0

Jan 24 19:22:06 MST: //482/519B619D8786/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 482 with tag 999010991 to app "MGCPAPP"

vg-3845#

Jan 24 19:22:09 MST: htsp_process_event: [0/1/0:1(23), EM_WAIT_SETUP_ACK, E_HTSP_EVENT_TIMER]em_wait_setup_ack_timer

Jan 24 19:22:09 MST: em_start_timer: 400 ms

Jan 24 19:22:09 MST: htsp_timer - 400 msec

Jan 24 19:22:09 MST: htsp_timer_stop2 em_onhook (0)vnm_dsp_set_sig_state:[recEive and transMit0/1/0:1(23)] set signal state = 0x0

Jan 24 19:22:09 MST: //482/519B619D8786/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x66F27200, Call Id=482

Jan 24 19:22:09 MST: //482/519B619D8786/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=FALSE, Cause Value=31, Retry Count=0)

vg-3845#

Jan 24 19:22:09 MST: htsp_process_event: [0/1/0:1(23), EM_GUARD_ALL, E_HTSP_EVENT_TIMER]em_guard_all_timer

Jan 24 19:22:09 MST: em_stop_timers

Jan 24 19:22:09 MST: htsp_timer_stop

Jan 24 19:22:09 MST: em_start_timer: 3000 ms

Jan 24 19:22:09 MST: htsp_timer - 3000 msec

Jan 24 19:22:09 MST: htsp_process_event: [0/1/0:1(23), EM_PARK, E_DSP_SIG_1100]em_park_offhook

Jan 24 19:22:09 MST: htsp_timer_stop

Jan 24 19:22:09 MST: htsp_timer_stop2

Jan 24 19:22:09 MST: htsp_timer2 - 10000 msec

vg-3845#

Jan 24 19:22:11 MST: htsp_process_event: [0/1/0:1(23), EM_PARK, E_DSP_SIG_0000]em_park_onhook

Jan 24 19:22:11 MST: htsp_timer_stop

Jan 24 19:22:11 MST: htsp_timer_stop2 htsp_report_onhook_sig

Jan 24 19:22:11 MST: //482/519B619D8786/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x66F27200, Tag=0x0, Call Id=482,

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

Jan 24 19:22:11 MST: //482/519B619D8786/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 24 19:22:11 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:11 MST: :cc_free_feature_vsa freeing 66AD2FA8

vg-3845#

Jan 24 19:22:11 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:11 MST:  vsacount in free is 0

Jan 24 19:22:12 MST: htsp_process_event: [0/1/0:1(24), EM_ONHOOK, E_DSP_SIG_1100]em_onhook_offhook

Jan 24 19:22:12 MST: htsp_timer - 50 msec

Jan 24 19:22:12 MST: htsp_process_event: [0/1/0:1(24), EM_QUALIFY_SEIZURE, E_HTSP_EVENT_TIMER]em_qualify_seizure_timeouthtsp_setup_ind

Jan 24 19:22:12 MST: [0/1/0:1(24)] get_local_station_id calling num= calling name= calling time=01/24 19:22  orig called=

Jan 24 19:22:12 MST: htsp_timer - 3000 msec

Jan 24 19:22:12 MST: //-1/5573456C878A/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-rdie=FFFFFFFF

   cisco-rdn=

   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 24 19:22:12 MST: //-1/5573456C878A/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x66F27200, Call Info(

   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=999010991, 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 24 19:22:12 MST: //-1/5573456C878A/CCAPI/ccCheckClipClir:

   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:12 MST: //-1/5573456C878A/CCAPI/ccCheckClipClir:

   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:12 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:12 MST: :cc_get_feature_vsa malloc success

Jan 24 19:22:12 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:12 MST:  cc_get_feature_vsa count is 1

Jan 24 19:22:12 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:12 MST: :FEATURE_VSA attributes are: feature_name:0,feature_time:1722625968,feature_id:483

Jan 24 19:22:12 MST: //483/5573456C878A/CCAPI/cc_api_call_setup_ind_common:

vg-3845#Set Up Event Sent;

   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

Jan 24 19:22:12 MST: //483/5573456C878A/CCAPI/cc_process_call_setup_ind:

   Event=0x6B501300

Jan 24 19:22:12 MST: //483/5573456C878A/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 483 with tag 999010991 to app "MGCPAPP"

vg-3845#

Jan 24 19:22:15 MST: htsp_process_event: [0/1/0:1(24), EM_WAIT_SETUP_ACK, E_HTSP_EVENT_TIMER]em_wait_setup_ack_timer

Jan 24 19:22:15 MST: em_start_timer: 400 ms

Jan 24 19:22:15 MST: htsp_timer - 400 msec

Jan 24 19:22:15 MST: htsp_timer_stop2 em_onhook (0)vnm_dsp_set_sig_state:[recEive and transMit0/1/0:1(24)] set signal state = 0x0

Jan 24 19:22:15 MST: //483/5573456C878A/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x66F27200, Call Id=483

Jan 24 19:22:15 MST: //483/5573456C878A/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=FALSE, Cause Value=31, Retry Count=0)

vg-3845#

Jan 24 19:22:15 MST: htsp_process_event: [0/1/0:1(24), EM_GUARD_ALL, E_HTSP_EVENT_TIMER]em_guard_all_timer

Jan 24 19:22:15 MST: em_stop_timers

Jan 24 19:22:15 MST: htsp_timer_stop

Jan 24 19:22:15 MST: em_start_timer: 3000 ms

Jan 24 19:22:15 MST: htsp_timer - 3000 msec

Jan 24 19:22:15 MST: htsp_process_event: [0/1/0:1(24), EM_PARK, E_DSP_SIG_1100]em_park_offhook

Jan 24 19:22:15 MST: htsp_timer_stop

Jan 24 19:22:15 MST: htsp_timer_stop2

Jan 24 19:22:15 MST: htsp_timer2 - 10000 msec

vg-3845#

Jan 24 19:22:17 MST: htsp_process_event: [0/1/0:1(24), EM_PARK, E_DSP_SIG_0000]em_park_onhook

Jan 24 19:22:17 MST: htsp_timer_stop

Jan 24 19:22:17 MST: htsp_timer_stop2 htsp_report_onhook_sig

Jan 24 19:22:17 MST: //483/5573456C878A/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x66F27200, Tag=0x0, Call Id=483,

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

Jan 24 19:22:17 MST: //483/5573456C878A/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 24 19:22:17 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:17 MST: :cc_free_feature_vsa freeing 66AD2FA8

Jan 24 19:22:17 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:17 MST:  vsacount in free is 0

Jan 24 19:22:17 MST: htsp_process_event: [0/1/0:1(23), EM_ONHOOK, E_DSP_SIG_1100]em_onhook_offhook

Jan 24 19:22:17 MST: htsp_timer - 50 msec

Jan 24 19:22:17 MST: htsp_process_event: [0/1/0:1(23), EM_QUALIFY_SEIZURE, E_HTSP_EVENT_TIMER]em_qualify_seizure_timeouthtsp_setup_ind

Jan 24 19:22:17 MST: [0/1/0:1(23)] get_local_station_id calling num= calling name= calling time=01/24 19:22  orig called=

Jan 24 19:22:17 MST: htsp_timer - 3000 msec

Jan 24 19:22:17 MST: //-1/588C1F88878E/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-rdie=FFFFFFFF

   cisco-rdn=

   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 24 19:22:17 MST: //-1/588C1F88878E/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x66F27200, Call Info(

   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=999010991, 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 24 19:22:17 MST: //-1/588C1F88878E/CCAPI/ccCheckClipClir:

   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:17 MST: //-1/588C1F88878E/CCAPI/ccCheckClipClir:

   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:17 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:17 MST: :cc_get_feature_vsa malloc success

Jan 24 19:22:17 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:17 MST:  cc_get_feature_vsa count is 1

Jan 24 19:22:17 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:17 MST: :FEATURE_VSA attributes are: feature_name:0,feature_time:1722625968,feature_id:484

Jan 24 19:22:17 MST: //484/588C1F88878E/CCAPI/cc_api_call_setup_ind_common:

vg-3845#Set Up Event Sent;

   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

Jan 24 19:22:17 MST: //484/588C1F88878E/CCAPI/cc_process_call_setup_ind:

   Event=0x6B4FF710

Jan 24 19:22:17 MST: //484/588C1F88878E/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 484 with tag 999010991 to app "MGCPAPP"

vg-3845#

Jan 24 19:22:20 MST: htsp_process_event: [0/1/0:1(23), EM_WAIT_SETUP_ACK, E_HTSP_EVENT_TIMER]em_wait_setup_ack_timer

Jan 24 19:22:20 MST: em_start_timer: 400 ms

Jan 24 19:22:20 MST: htsp_timer - 400 msec

Jan 24 19:22:20 MST: htsp_timer_stop2 em_onhook (0)vnm_dsp_set_sig_state:[recEive and transMit0/1/0:1(23)] set signal state = 0x0

Jan 24 19:22:20 MST: //484/588C1F88878E/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x66F27200, Call Id=484

Jan 24 19:22:20 MST: //484/588C1F88878E/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=FALSE, Cause Value=31, Retry Count=0)

vg-3845#

Jan 24 19:22:21 MST: htsp_process_event: [0/1/0:1(23), EM_GUARD_ALL, E_HTSP_EVENT_TIMER]em_guard_all_timer

Jan 24 19:22:21 MST: em_stop_timers

Jan 24 19:22:21 MST: htsp_timer_stop

Jan 24 19:22:21 MST: em_start_timer: 3000 ms

Jan 24 19:22:21 MST: htsp_timer - 3000 msec

Jan 24 19:22:21 MST: htsp_process_event: [0/1/0:1(23), EM_PARK, E_DSP_SIG_1100]em_park_offhook

Jan 24 19:22:21 MST: htsp_timer_stop

Jan 24 19:22:21 MST: htsp_timer_stop2

Jan 24 19:22:21 MST: htsp_timer2 - 10000 msec

Jan 24 19:22:22 MST: htsp_process_event: [0/1/0:1(23), EM_PARK, E_DSP_SIG_0000]em_park_onhook

Jan 24 19:22:22 MST: htsp_timer_stop

Jan 24 19:22:22 MST: htsp_timer_stop2 htsp_report_onhook_sig

Jan 24 19:22:22 MST: //484/588C1F88878E/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x66F27200, Tag=0x0, Call Id=484,

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

Jan 24 19:22:22 MST: //484/588C1F88878E/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 24 19:22:22 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:22 MST: :cc_free_feature_vsa freeing 66AD2FA8

vg-3845#

Jan 24 19:22:22 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:22 MST:  vsacount in free is 0

vg-3845#

Jan 24 19:22:24 MST: htsp_process_event: [0/1/0:1(24), EM_ONHOOK, E_DSP_SIG_1100]em_onhook_offhook

Jan 24 19:22:24 MST: htsp_timer - 50 msec

Jan 24 19:22:24 MST: htsp_process_event: [0/1/0:1(24), EM_QUALIFY_SEIZURE, E_HTSP_EVENT_TIMER]em_qualify_seizure_timeouthtsp_setup_ind

Jan 24 19:22:24 MST: [0/1/0:1(24)] get_local_station_id calling num= calling name= calling time=01/24 19:22  orig called=

Jan 24 19:22:24 MST: htsp_timer - 3000 msec

Jan 24 19:22:24 MST: //-1/5C7172948792/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-rdie=FFFFFFFF

   cisco-rdn=

   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 24 19:22:24 MST: //-1/5C7172948792/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x66F27200, Call Info(

   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=999010991, 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 24 19:22:24 MST: //-1/5C7172948792/CCAPI/ccCheckClipClir:

   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:24 MST: //-1/5C7172948792/CCAPI/ccCheckClipClir:

   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:24 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:24 MST: :cc_get_feature_vsa malloc success

Jan 24 19:22:24 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:24 MST:  cc_get_feature_vsa count is 1

Jan 24 19:22:24 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:24 MST: :FEATURE_VSA attributes are: feature_name:0,feature_time:1722625968,feature_id:485

Jan 24 19:22:24 MST: //485/5C7172948792/CCAPI/cc_api_call_setup_ind_common:

vg-3845#Set Up Event Sent;

   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

Jan 24 19:22:24 MST: //485/5C7172948792/CCAPI/cc_process_call_setup_ind:

   Event=0x6B4FDB20

Jan 24 19:22:24 MST: //485/5C7172948792/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 485 with tag 999010991 to app "MGCPAPP"

vg-3845#

Jan 24 19:22:27 MST: htsp_process_event: [0/1/0:1(24), EM_WAIT_SETUP_ACK, E_HTSP_EVENT_TIMER]em_wait_setup_ack_timer

Jan 24 19:22:27 MST: em_start_timer: 400 ms

Jan 24 19:22:27 MST: htsp_timer - 400 msec

Jan 24 19:22:27 MST: htsp_timer_stop2 em_onhook (0)vnm_dsp_set_sig_state:[recEive and transMit0/1/0:1(24)] set signal state = 0x0

Jan 24 19:22:27 MST: //485/5C7172948792/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x66F27200, Call Id=485

Jan 24 19:22:27 MST: //485/5C7172948792/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=FALSE, Cause Value=31, Retry Count=0)

vg-3845#

Jan 24 19:22:27 MST: htsp_process_event: [0/1/0:1(24), EM_GUARD_ALL, E_HTSP_EVENT_TIMER]em_guard_all_timer

Jan 24 19:22:27 MST: em_stop_timers

Jan 24 19:22:27 MST: htsp_timer_stop

Jan 24 19:22:27 MST: em_start_timer: 3000 ms

Jan 24 19:22:27 MST: htsp_timer - 3000 msec

Jan 24 19:22:27 MST: htsp_process_event: [0/1/0:1(24), EM_PARK, E_DSP_SIG_1100]em_park_offhook

Jan 24 19:22:27 MST: htsp_timer_stop

Jan 24 19:22:27 MST: htsp_timer_stop2

Jan 24 19:22:27 MST: htsp_timer2 - 10000 msec

vg-3845#

Jan 24 19:22:29 MST: htsp_process_event: [0/1/0:1(23), EM_ONHOOK, E_DSP_SIG_1100]em_onhook_offhook

Jan 24 19:22:29 MST: htsp_timer - 50 msec

Jan 24 19:22:29 MST: htsp_process_event: [0/1/0:1(24), EM_PARK, E_DSP_SIG_0000]em_park_onhook

Jan 24 19:22:29 MST: htsp_timer_stop

Jan 24 19:22:29 MST: htsp_timer_stop2 htsp_report_onhook_sig

Jan 24 19:22:29 MST: //485/5C7172948792/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x66F27200, Tag=0x0, Call Id=485,

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

Jan 24 19:22:29 MST: //485/5C7172948792/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 24 19:22:29 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:29 MST: :cc_free_feature_vsa freeing 66AD2FA8

Jan 24 19:22:29 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:29 MST:  vsacount in free is 0

Jan 24 19:22:29 MST: htsp_process_event: [0/1/0:1(23), EM_QUALIFY_SEIZURE, E_HTSP_EVENT_TIMER]em_qualify_seizure_timeouthtsp_setup_ind

Jan 24 19:22:29 MST: [0/1/0:1(23)] get_local_station_id calling num= calling name= calling time=01/24 19:22  orig called=

Jan 24 19:22:29 MST: htsp_timer - 3000 msec

Jan 24 19:22:29 MST: //-1/5F87DB788796/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-rdie=FFFFFFFF

   cisco-rdn=

   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 24 19:22:29 MST: //-1/5F87DB788796/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x66F27200, Call Info(

   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=999010991, 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 24 19:22:29 MST: //-1/5F87DB788796/CCAPI/ccCheckClipClir:

   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:29 MST: //-1/5F87DB788796/CCAPI/ccCheckClipClir:

   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

Jan 24 19:22:29 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:29 MST: :cc_get_feature_vsa malloc success

Jan 24 19:22:29 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:29 MST:  cc_get_feature_vsa count is 1

Jan 24 19:22:29 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 19:22:29 MST: :FEATURE_VSA attributes are: feature_name:0,feature_time:1722625968,feature_id:486

Jan 24 19:22:29 MST: //486/5F87DB788796/CCAPI/cc_api_call_setup_ind_common:

vg-3845#Set Up Event Sent;

   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

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

Jan 24 19:22:29 MST: //486/5F87DB788796/CCAPI/cc_process_call_setup_ind:

   Event=0x6B4FBF30

Jan 24 19:22:29 MST: //486/5F87DB788796/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 486 with tag 999010991 to app "MGCPAPP"

vg-3845#

Jan 24 19:22:32 MST: htsp_process_event: [0/1/0:1(23), EM_WAIT_SETUP_ACK, E_HTSP_EVENT_TIMER]em_wait_setup_ack_timer

Jan 24 19:22:32 MST: em_start_timer: 400 ms

Jan 24 19:22:32 MST: htsp_timer - 400 msec

Jan 24 19:22:32 MST: htsp_timer_stop2 em_onhook (0)vnm_dsp_set_sig_state:[recEive and transMit0/1/0:1(23)] set signal state = 0x0

Jan 24 19:22:32 MST: //486/5F87DB788796/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x66F27200, Call Id=486

Jan 24 19:22:32 MST: //486/5F87DB788796/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=FALSE, Cause Value=31, Retry Count=0)

vg-3845#

Jan 24 19:22:32 MST: htsp_process_event: [0/1/0:1(23), EM_GUARD_ALL, E_HTSP_EVENT_TIMER]em_guard_all_timer

Jan 24 19:22:32 MST: em_stop_timers

Jan 24 19:22:32 MST: htsp_timer_stop

Jan 24 19:22:32 MST: em_start_timer: 3000 ms

Jan 24 19:22:32 MST: htsp_timer - 3000 msec

Jan 24 19:22:32 MST: htsp_process_event: [0/1/0:1(23), EM_PARK, E_DSP_SIG_1100]em_park_offhook

Jan 24 19:22:32 MST: htsp_timer_stop

Jan 24 19:22:32 MST: htsp_timer_stop2

Jan 24 19:22:32 MST: htsp_timer2 - 10000 msec

vg-3845#

Jan 24 19:22:34 MST: htsp_process_event: [0/1/0:1(23), EM_PARK, E_DSP_SIG_0000]em_park_onhook

Jan 24 19:22:34 MST: htsp_timer_stop

Jan 24 19:22:34 MST: htsp_timer_stop2 htsp_report_onhook_sig

Jan 24 19:22:34 MST: //486/5F87DB788796/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x66F27200, Tag=0x0, Call Id=486,

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

Jan 24 19:22:34 MST: //486/5F87DB788796/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Jan 24 19:22:34 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:34 MST: :cc_free_feature_vsa freeing 66AD2FA8

vg-3845#

Jan 24 19:22:34 MST: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 19:22:34 MST:  vsacount in free is 0

Everyone's tags (1)
2 REPLIES

Incoming Calls Have No Ringback, Goes to Fast Busy Tone

Hi,

It seems the provider is releasing the call with cause code 31,

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/act_generate_disc:

   Cause Value=31      >> this is reported as a normal event only when no other cause in the normal class applies

Jan 24 19:02:44 MST: //459/9B54DDED872A/VTSP:(0/1/0:1):-1:1:1/vtsp_set_release_source:

   Release Direction=PSTN, Release Source=Calling Party-PSTN

So please check with your provider once again and tell them we are receiving the disconnect from pstn.

     >> Are the outbound calls working ok?

Please rate all the useful posts

//Suresh Please rate all the useful posts.
Community Member

Incoming Calls Have No Ringback, Goes to Fast Busy Tone

I ended up figuring it out. There was a number expansion command redirecting the caller to an extension that wasn't available due to a bug in the system.

I had to run "no mgcp" and then "mgcp" because the voice gateway lost connectivity to Call Manager.

854
Views
0
Helpful
2
Replies
CreatePlease to create content