[cisco-voip] strange auto attendant issue

sam singapore sam4sg at gmail.com
Mon Apr 11 11:35:18 EDT 2011 

Hi Mati,


sh debugging


CCAPI:
  debug voip ccapi inout is ON (filter is OFF)

  debug voip application script is ON (filter is OFF)



Apr 11 15:32:26.126: //40322/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:
   Call Entry Is Not Found
Apr 11 15:32:26.126: //-1/BCD851C083B4/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=0033033
   ----- ccCallInfo IE subfields -----
   cisco-ani=0033033
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=123456
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=-1
   cisco-rdnsi=-1
   cisco-redirectreason=-1   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Apr 11 15:32:26.130: //-1/BCD851C083B4/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x4A633A40, Call Info(
   Calling Number=0033033,(Calling Name=)(TON=Unknown, NPI=Unknown,
Screening=Not Screened, Presentation=Allowed),
   Called Number=123456(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown,
FinalDestinationFlag=TRUE,
   Incoming Dial-peer=44, Progress Indication=NULL(0), Calling IE
Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID
Transparent=FALSE), Call Id=40322
Apr 11 15:32:26.130: //-1/BCD851C083B4/CCAPI/ccCheckClipClir:
   In: Calling Number=0033033(TON=Unknown, NPI=Unknown, Screening=Not
Screened, Presentation=Allowed)
Apr 11 15:32:26.130: //-1/BCD851C083B4/CCAPI/ccCheckClipClir:
   Out: Calling Number=0033033(TON=Unknown, NPI=Unknown, Screening=Not
Screened, Presentation=Allowed)
Apr 11 15:32:26.130: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:26.130: :cc_get_feature_vsa malloc success
Apr 11 15:32:26.130: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:26.130:  cc_get_feature_vsa count is 1
Apr 11 15:32:26.130: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:26.130: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312524296,feature_id:393
Apr 11 15:32:26.130:
//40322/BCD851C083B4/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=0033033(TON=Unknown, NPI=Unknown, Screening=Not
Screened, Presentation=Allowed),
   Called Number=123456(TON=Unknown, NPI=Unknown))
Apr 11 15:32:26.134: //40322/BCD851C083B4/CCAPI/cc_process_call_setup_ind:
   Event=0x4C0CB960
Apr 11 15:32:26.134: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 123456
Apr 11 15:32:26.138: //40322/BCD851C083B4/CCAPI/ccCallSetContext:
   Context=0x48E2E508
Apr 11 15:32:26.138: //40322/BCD851C083B4/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 40322 with tag 44 to app
"_ManagedAppProcess_Default"
Apr 11 15:32:26.142: //40322/BCD851C083B4/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Apr 11 15:32:26.146: //40322/BCD851C083B4/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=44, Params=0x48E2F960, Progress Indication=NULL(0)
Apr 11 15:32:26.146: //40322/BCD851C083B4/CCAPI/ccCheckClipClir:
   In: Calling Number=0033033(TON=Unknown, NPI=Unknown, Screening=Not
Screened, Presentation=Allowed)
Apr 11 15:32:26.146: //40322/BCD851C083B4/CCAPI/ccCheckClipClir:
   Out: Calling Number=0033033(TON=Unknown, NPI=Unknown, Screening=Not
Screened, Presentation=Allowed)
Apr 11 15:32:26.146: //40322/BCD851C083B4/CCAPI/ccCallSetupRequest:
   Destination Pattern=555, Called Number=555, Digit Strip=FALSE
Apr 11 15:32:26.146: //40322/BCD851C083B4/CCAPI/ccCallSetupRequest:
   Calling Number=0033033(TON=Unknown, NPI=Unknown, Screening=Not Screened,
Presentation=Allowed),
   Called Number=555(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=0033033
   Account Number=0033033, Final Destination Flag=TRUE,
   Guid=BCD851C0-6387-11E0-83B4-904A11C1F34D, Outgoing Dial-peer=44
Apr 11 15:32:26.150: //40322/BCD851C083B4/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=0033033
   ----- ccCallInfo IE subfields -----
   cisco-ani=0033033
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=555
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=-1
   cisco-rdnsi=-1
   cisco-redirectreason=-1   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

Apr 11 15:32:26.150: //40322/BCD851C083B4/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x4A633A40, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=0033033,(Calling Name=0033033)(TON=Unknown,
NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=555(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing
Dial-peer=44, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0,
Application Call Id=)
Apr 11 15:32:26.150: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:26.150: :cc_get_feature_vsa malloc success
Apr 11 15:32:26.150: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:26.150:  cc_get_feature_vsa count is 2
Apr 11 15:32:26.150: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:26.150: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312523624,feature_id:394
Apr 11 15:32:26.150: //40323/BCD851C083B4/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Apr 11 15:32:26.154: //40323/BCD851C083B4/CCAPI/ccCallSetContext:
   Context=0x48E2F910
Apr 11 15:32:26.154: //40322/BCD851C083B4/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=44
Apr 11 15:32:26.158: //40323/BCD851C083B4/CCAPI/cc_api_call_proceeding:
   Interface=0x4A633A40, Progress Indication=NULL(0)
Apr 11 15:32:26.206: //40323/BCD851C083B4/CCAPI/cc_api_call_alert:
   Interface=0x4A633A40, Progress Indication=NULL(0), Signal
Indication=SIGNAL RINGBACK(1)
Apr 11 15:32:26.206: //40323/BCD851C083B4/CCAPI/cc_api_call_alert:
   Call Entry(Retry Count=0, Responsed=TRUE)
Apr 11 15:32:26.206: //40322/BCD851C083B4/CCAPI/ccCallAlert:
   Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)
Apr 11 15:32:26.206: //40322/BCD851C083B4/CCAPI/ccCallAlert:
   Call Entry(Responsed=TRUE, Alert Sent=TRUE)
Apr 11 15:32:26.246: //40323/BCD851C083B4/CCAPI/cc_api_caps_ind:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=40323,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x0, Codec Bytes=20, Signal Type=2)
Apr 11 15:32:26.246: //40323/BCD851C083B4/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Apr 11 15:32:26.246: //40322/BCD851C083B4/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=40323, Source Call
Id=40322,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=1)
Apr 11 15:32:26.246: //40323/BCD851C083B4/CCAPI/cc_api_event_indication:
   Event=165, Call Id=40323
Apr 11 15:32:26.246: //40323/BCD851C083B4/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
Apr 11 15:32:26.246: //40323/BCD851C083B4/CCAPI/cc_api_call_connected:
   Interface=0x4A633A40, Data Bitmask=0x1, Progress Indication=NULL(0),
   Connection Handle=0
Apr 11 15:32:26.246: //40323/BCD851C083B4/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
Apr 11 15:32:26.250: //40322/BCD851C083B4/CCAPI/ccConferenceCreate:
   (confID=0x4E47D4EC, callID1=0x9D82,
gcid=BCD98A10-638711E0-83B7904A-11C1F34D, tag=0x0)
Apr 11 15:32:26.250: //40323/BCD851C083B4/CCAPI/ccConferenceCreate:
   (confID=0x4E47D4EC, callID2=0x9D83,
gcid=BCD98A10-638711E0-83B7904A-11C1F34D, tag=0x0)
Apr 11 15:32:26.250: //40322/BCD851C083B4/CCAPI/ccConferenceCreate:
   Conference Id=0x4E47D4EC, Call Id1=40322, Call Id2=40323, Tag=0x0
Apr 11 15:32:26.254: //40322/BCD851C083B4/CCAPI/ccConferenceCreate:

Apr 11 15:32:26.254: ccConferenceCreate: ret1=0, codecMask1=1, bytes1=160,
negot1=1, dtmf1=6
                    ret2=0, codecMask2=1, bytes2=160, negot2=1, dtmf2=6,
                    tx_dynamic_pt1=0, rx_dynamic_pt1=0, codec_mode1=0,
params_bitmap1 =0
                    tx_dynamic_pt2=0, rx_dynamic_pt2=0, codec_mode2=0,
params_bitmap2 =0
Apr 11 15:32:26.254: //40322/BCD851C083B4/CCAPI/ccConferenceCreate:
   delay media to slow start case, codec negotation is not done
Apr 11 15:32:26.254: //40322/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Apr 11 15:32:26.254: cc_api_get_xcode_stream : 4683
Apr 11 15:32:26.254: //40322/BCD851C083B4/CCAPI/cc_api_bridge_done:
   Conference Id=0x46, Source Interface=0x4A633A40, Source Call Id=40322,
   Destination Call Id=40323, Disposition=0x0, Tag=0x0
Apr 11 15:32:26.254: //40323/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Apr 11 15:32:26.254: cc_api_get_xcode_stream : 4683
Apr 11 15:32:26.254: //40323/BCD851C083B4/CCAPI/cc_api_bridge_done:
   Conference Id=0x46, Source Interface=0x4A633A40, Source Call Id=40323,
   Destination Call Id=40322, Disposition=0x0, Tag=0x0
Apr 11 15:32:26.254: //40322/BCD851C083B4/CCAPI/cc_generic_bridge_done:
   Conference Id=0x46, Source Interface=0x4A633A40, Source Call Id=40323,
   Destination Call Id=40322, Disposition=0x0, Tag=0x0
Apr 11 15:32:26.258: //40322/BCD851C083B4/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x46, Destination Call Id=40323)
Apr 11 15:32:26.258: //40323/BCD851C083B4/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x46, Destination Call Id=40322)
Apr 11 15:32:26.258:
//40322/BCD851C083B4/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x46, Call Id1=40322, Call Id2=40323
Apr 11 15:32:26.258: //40322/BCD851C083B4/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x1
Apr 11 15:32:26.262: //40322/BCD851C083B4/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
Apr 11 15:32:34.714: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 1 to dstCallId 0x9D83
Apr 11 15:32:34.714:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
Apr 11 15:32:34.834: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 1 to dstCallId 0x9D83
Apr 11 15:32:34.834:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
Apr 11 15:32:38.746: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 1 to dstCallId 0x9D83
Apr 11 15:32:38.750:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
Apr 11 15:32:38.850: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 1 to dstCallId 0x9D83
Apr 11 15:32:38.850:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
Apr 11 15:32:39.270: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 9 to dstCallId 0x9D83
Apr 11 15:32:39.270:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
Apr 11 15:32:39.382: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 9 to dstCallId 0x9D83
Apr 11 15:32:39.382:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
Apr 11 15:32:39.582: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 9 to dstCallId 0x9D83
Apr 11 15:32:39.582:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
Apr 11 15:32:39.694: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 9 to dstCallId 0x9D83
Apr 11 15:32:39.694:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
Apr 11 15:32:40.326: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit # to dstCallId 0x9D83
Apr 11 15:32:40.326:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
Apr 11 15:32:40.450: //40322/BCD851C083B4/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit # to dstCallId 0x9D83
Apr 11 15:32:40.450:
//40322/BCD851C083B4/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
Apr 11 15:32:44.858: //40322/BCD851C083B4/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=FALSE, Tone=Null,
   Tone Direction=Sum Network, Params=0x0, Call Id=40322
Apr 11 15:32:44.858: //40323/BCD851C083B4/CCAPI/cc_api_call_facility:
   Interface=0x4A633A40, Call Id=40323
Apr 11 15:32:44.862:
//40323/BCD851C083B4/CCAPI/cc_api_get_ssCTreRoutingNotSupported:
   CallInfo(ssCTreRoutingNotSupported=FALSE)
Apr 11 15:32:44.862: //40322/BCD851C083B4/CCAPI/ccConferenceDestroy:
   Conference Id=0x46, Tag=0x0
Apr 11 15:32:44.862: //40322/BCD851C083B4/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x46, Source Interface=0x4A633A40, Source Call Id=40322,
   Destination Call Id=40323, Disposition=0x0, Tag=0x0
Apr 11 15:32:44.862: //40323/BCD851C083B4/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x46, Source Interface=0x4A633A40, Source Call Id=40323,
   Destination Call Id=40322, Disposition=0x0, Tag=0x0
Apr 11 15:32:44.862: //40322/BCD851C083B4/CCAPI/cc_generic_bridge_done:
   Conference Id=0x46, Source Interface=0x4A633A40, Source Call Id=40323,
   Destination Call Id=40322, Disposition=0x0, Tag=0x0
Apr 11 15:32:44.862: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.862: :cc_get_feature_vsa malloc success
Apr 11 15:32:44.862: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.862:  cc_get_feature_vsa count is 3
Apr 11 15:32:44.862: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.862: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312524072,feature_id:395
Apr 11 15:32:44.862: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.862:  feature_vsa is 4E3B8560,featname is 0
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.866: :cc_get_feature_vsa malloc success
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.866:  cc_get_feature_vsa count is 4
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.866: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312524968,feature_id:396
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.866: : Generating new featurevsa,inserting it
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.866:  feature call forward featname is 4
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.866:  feature_vsa is 4E3B8800,featname is 0
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.866: :cc_get_feature_vsa malloc success
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.866:  cc_get_feature_vsa count is 5
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.866: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312524520,feature_id:397
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.866: : Generating new featurevsa,inserting it
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.866:  feature call forward featname is 4
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:44.866: :cc_free_feature_vsa freeing 4E3B8720
Apr 11 15:32:44.866: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:44.866:  vsacount in free is 4
Apr 11 15:32:44.870: //40322/BCD851C083B4/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=0
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.874: :cc_get_feature_vsa malloc success
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.874:  cc_get_feature_vsa count is 5
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:44.874: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312524072,feature_id:398
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.874: : updating existing feature vsa
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:

Apr 11 15:32:44.874:  feature call forward featname is 4
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:44.874: :cc_free_feature_vsa freeing 4E3B8720
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:44.874:  vsacount in free is 4
Apr 11 15:32:44.874:
//40322/BCD851C083B4/CCAPI/cc_api_get_ssCTreRoutingNotSupported:
   CallInfo(ssCTreRoutingNotSupported=FALSE)
Apr 11 15:32:44.874: //40322/BCD851C083B4/CCAPI/cc_api_get_ccm_detected:
   CallInfo(ccm detected=FALSE)
Apr 11 15:32:44.874: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 199
Apr 11 15:32:44.878: //40322/BCD851C083B4/CCAPI/ccCallTransferRequest:
   Transfer Info=0x4E4EABAC, Call Id=40322, Peer=20015
Apr 11 15:32:45.046: //40322/BCD851C083B4/CCAPI/cc_api_call_suspend_ack_ind:
   Interface=0x4A633A40, Call Id=40322
Apr 11 15:32:45.218: //40322/BCD851C083B4/CCAPI/cc_api_call_transfer_status:
   TransferRsp=1, Disposition=0x0, Interface=0x4A633A40, Call Id=40322
Apr 11 15:32:45.218: //40322/BCD851C083B4/CCAPI/cc_api_call_transfer_status:
   Event(Status=1)
Apr 11 15:32:45.222: //40322/BCD851C083B4/CCAPI/cc_api_call_transfer_status:
   TransferRsp=3, Disposition=0x0, Interface=0x4A633A40, Call Id=40322
Apr 11 15:32:45.222: //40322/BCD851C083B4/CCAPI/cc_api_call_transfer_status:
   Event(Status=3)
Apr 11 15:32:45.222: //40322/BCD851C083B4/CCAPI/cc_api_call_transfer_done:
   TransferRsp=4, Interface=0x4A633A40, Disposition=0x0, Call Id=40322
Apr 11 15:32:45.222: //40322/BCD851C083B4/CCAPI/cc_api_call_transfer_done:
   Event(Status=4)
Apr 11 15:32:45.234: //40323/BCD851C083B4/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0,
Disconnect Cause=0)
Apr 11 15:32:45.234: //40323/BCD851C083B4/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Apr 11 15:32:45.234: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:45.234: :cc_get_feature_vsa malloc success
Apr 11 15:32:45.234: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:45.234:  cc_get_feature_vsa count is 5
Apr 11 15:32:45.234: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 11 15:32:45.234: :FEATURE_VSA attributes are:
feature_name:0,feature_time:1312524072,feature_id:399
Apr 11 15:32:45.234: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.234: :cc_free_feature_vsa freeing 4E3B8720
Apr 11 15:32:45.234: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.234:  vsacount in free is 4
Apr 11 15:32:45.234: //40322/BCD851C083B4/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0,
Disconnect Cause=0)
Apr 11 15:32:45.238: //40322/BCD851C083B4/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Apr 11 15:32:45.238: //40323/BCD851C083B4/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x4A633A40, Tag=0x0, Call Id=40323,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Apr 11 15:32:45.238: //40323/BCD851C083B4/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Apr 11 15:32:45.242: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.242: :cc_free_feature_vsa freeing 4E3B8AA0
Apr 11 15:32:45.242: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.242:  vsacount in free is 3
Apr 11 15:32:45.242: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.242:  vsacount in free is 2
Apr 11 15:32:45.398: //40322/BCD851C083B4/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x4A633A40, Tag=0x0, Call Id=40322,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Apr 11 15:32:45.398: //40322/BCD851C083B4/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Apr 11 15:32:45.398: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.398: :cc_free_feature_vsa freeing 4E3B88E0
Apr 11 15:32:45.398: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.398:  vsacount in free is 1
Apr 11 15:32:45.398: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 11 15:32:45.398:  vsacount in free is 0


On Mon, Apr 11, 2011 at 11:29 PM, Mati Gil <mgilqui at gmail.com> wrote:

> What is the disconnect cause reported in the logs?
> "debug voip application script" and "debug voice ccapi inout" could help.
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://puck.nether.net/pipermail/cisco-voip/attachments/20110411/a8b7ada1/attachment.html>

More information about the cisco-voip mailing list