[cisco-voip] strange auto attendant issue

sam singapore sam4sg at gmail.com
Tue Apr 12 04:59:30 EDT 2011


Hi,

dial-peer voice 44 voip
 translation-profile incoming INIVR
 destination-pattern 555
 session protocol sipv2
 session target ipv4:10.150.0.2
 incoming called-number .T
 dtmf-relay rtp-nte
 codec g711ulaw
 no vad
!

the INIVR translates calls to our sip username: 123456 to 555 ; 555 plays
the auto attendant


!
ephone-dn  19  dual-line
 number 199 no-reg both
 label XXX
 description XXX
 name XXX
 call-forward busy 200
 call-forward noan 200 timeout 15
 no huntstop
 mwi sip
 hold-alert 30 originator
!
!

Do we need extra routing to point extension 199 ?

Or you mean in CUE has no idea of the phones/extensions in CME and need to
put rules to map 199 to exension 199 ?


Thanks,
Sam


On Tue, Apr 12, 2011 at 12:59 AM, Mati Gil <mgilqui at gmail.com> wrote:

> I guess you have a
>
> dial-peer voice 44 voip
>  service aa-xxxxx
>  session target ipv4:<Ip CME>
>  incoming called-number 555
>  dtmf-relay ????
>
> There is no outgoing call created to go to ext 199 and in the debugs I see
> "Outgoing Dial-peer=0" !??
> I don't see any message like:
> "//223500//TCL :/tcl_PutsObjCmd: TCL AA: ++ Playing Welcome Prompt and
> options menu ++"
>
> Can you review you dail-peer config for the pilot number?
>
> Rgds,
> Mati
>
> 2011/4/11 sam singapore <sam4sg at gmail.com>
>
>> Also,
>>
>> voice translation-rule 44
>>  rule 1 /123456/ /555/
>>
>> If i change that /555/ to /199/ or /503/  - any of the extensions, I can
>> get the calls there and talk OK.
>> /555/ is for auto attendant, and via auto-attendant, its not connecting.
>>
>>
>>
>> Thanks,
>> Sam
>>
>>
>> On Mon, Apr 11, 2011 at 11:35 PM, sam singapore <sam4sg at gmail.com> wrote:
>>
>>> 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/20110412/6cc493bb/attachment.html>


More information about the cisco-voip mailing list