Hi,
We use Cisco 2901 as a tested product to convert SIP to ISDN so we can use this technology with Legacy PaBX's.
We have never come accross this problem, but when dialling out it takes 10 seconds to make the call. In a trace we case the router ISDN side does a vsacount in free is 10 down to 1, then the call is made. I cannot locate what adjusts this VSA count. Example trace is as below;
*Jun 29 10:26:00.137: //8604/028B1FFABDC0/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=FALSE, Tone=Null,
Tone Direction=Sum Network, Params=0x0, Call Id=8604
*Jun 29 10:26:00.137: //8603/028B1FFABDC0/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x30BE32B0, Call Id=8603
*Jun 29 10:26:00.137: //8603/028B1FFABDC0/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
*Jun 29 10:26:00.137: //8603/028B1FFABDC0/CCAPI/ccConferenceDestroy:
Conference Id=0xA2C, Tag=0x0
*Jun 29 10:26:00.137: //8603/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
Conference Id=0xA2C, Source Interface=0x30BE32B0, Source Call Id=8603,
Destination Call Id=8604, Disposition=0x0, Tag=0x0
*Jun 29 10:26:00.137: //8604/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
Conference Id=0xA2C, Source Interface=0x30E19354, Source Call Id=8604,
Destination Call Id=8603, Disposition=0x0, Tag=0x0
*Jun 29 10:26:00.137: //8603/028B1FFABDC0/CCAPI/cc_generic_bridge_done:
Conference Id=0xA2C, Source Interface=0x30E19354, Source Call Id=8604,
Destination Call Id=8603, Disposition=0x0, Tag=0x0
*Jun 29 10:26:00.137: //8603/028B1FFABDC0/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
*Jun 29 10:26:00.137: //8603/028B1FFABDC0/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Jun 29 10:26:00.137: //8604/028B1FFABDC0/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Jun 29 10:26:00.137: //8604/028B1FFABDC0/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Jun 29 10:26:00.137: //8604/028B1FFABDC0/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
*Jun 29 10:26:00.141: //8603/028B1FFABDC0/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x30BE32B0, Tag=0x0, Call Id=8603,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jun 29 10:26:00.141: //8603/028B1FFABDC0/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Jun 29 10:26:00.141: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Jun 29 10:26:00.141: :cc_free_feature_vsa freeing 312A6560
*Jun 29 10:26:00.141: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Jun 29 10:26:00.141: vsacount in free is 9
*Jun 29 10:26:00.165: %ISDN-6-DISCONNECT: Interface Serial0/0/0:0 disconnected from 213401 , call lasted 277 seconds
*Jun 29 10:26:00.165: ISDN Se0/0/0:15 Q931: TX -> DISCONNECT pd = 8 callref = 0x0AB7
Cause i = 0x8290 - Normal call clearing
*Jun 29 10:26:00.169: ISDN Se0/0/0:15 Q931: RX <- RELEASE pd = 8 callref = 0x8AB7
*Jun 29 10:26:00.173: ISDN Se0/0/0:15 Q931: TX -> RELEASE_COMP pd = 8 callref = 0x0AB7
*Jun 29 10:26:00.173: //8604/028B1FFABDC0/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x30E19354, Tag=0x0, Call Id=8604,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jun 29 10:26:00.173: //8604/028B1FFABDC0/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Jun 29 10:26:00.173: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Jun 29 10:26:00.173: :cc_free_feature_vsa freeing 312A6640
*Jun 29 10:26:00.173: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
*Jun 29 10:26:00.173: vsacount in free is 8
*Jun 29 10:26:00.697: ISDN Se0/0/0:15 Q931: RX <- SETUP pd = 8 callref = 0x0038
Bearer Capability i = 0x8090A3
Standard = CCITT
Transfer Capability = Speech
Transfer Mode = Circuit
Transfer Rate = 64 kbit/s
Calling Party Number i = 0x80, '213391'
Plan:Unknown, Type:Unknown
Called Party Number i = 0x80, 'xxxxxx'
Plan:Unknown, Type:Unknown
R1-RHS-VincentSq-2901#
*Jun 29 10:26:00.697: ISDN Se0/0/0:15 Q931: Received SETUP callref = 0x8038 callID = 0x0015 switch = primary-net5 inter
face = Network
*Jun 29 10:26:00.701: ISDN Se0/0/0:15 Q931: TX -> SETUP_ACK pd = 8 callref = 0x8038
Channel ID i = 0xA98381
Exclusive, Channel 1
*Jun 29 10:26:01.201: //-1/A81B28908016/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=213391
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=xxxx
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-lastrdn=
cisco-rdntype=-1
cisco-rdnplan=-1
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
*Jun 29 10:26:01.201: //-1/A81B28908016/CCAPI/cc_api_call_setup_ind_common:
Interface=0x30E19354, Call Info(
Calling Number=213391,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=xxxx9(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE,
Incoming Dial-peer=1, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
*Jun 29 10:26:01.201: //-1/A81B28908016/CCAPI/ccCheckClipClir:
In: Calling Number=213391(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 29 10:26:01.201: //-1/A81B28908016/CCAPI/ccCheckClipClir:
Out: Calling Number=213391(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 29 10:26:01.201: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Jun 29 10:26:01.201: :cc_get_feature_vsa malloc success
*Jun 29 10:26:01.201: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Jun 29 10:26:01.201: cc_get_feature_vsa count is 9
*Jun 29 10:26:01.201: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
*Jun 29 10:26:01.201: :FEATURE_VSA attributes are: feature_name:0,feature_time:824862280,feature_id:5281
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=213391(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=xxxx(TON=Unknown, NPI=Unknown))
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/cc_process_call_setup_ind:
Event=0x30DF5B68
*Jun 29 10:26:01.201: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number xxxxx
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/ccCallSetContext:
Context=0x409C1ED4
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 8618 with tag 1 to app "_ManagedAppProcess_Default"
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=100, Params=0x409C0C1C, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/ccCheckClipClir:
In: Calling Number=213391(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 29 10:26:01.201: //8618/A81B28908016/CCAPI/ccCheckClipClir:
Out: Calling Number=213391(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 29 10:26:01.205: //8618/A81B28908016/CCAPI/ccCallSetupRequest:
Destination Pattern=.T, Called Number=xxxx, Digit Strip=FALSE
*Jun 29 10:26:01.205: //8618/A81B28908016/CCAPI/ccCallSetupRequest:
Calling Number=213391(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=xxxxTON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=
Account Number=, Final Destination Flag=TRUE,
Guid=A81B2890-C10B-11E1-8016-1CDF0F9E4D00, Outgoing Dial-peer=100
*Jun 29 10:26:01.205: //8618/A81B28908016/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=213391
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=xxxx
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-lastrdn=
cisco-rdntype=-1
cisco-rdnplan=-1
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
*Jun 29 10:26:01.205: //8618/A81B28908016/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x30BE32B0, Interface Type=3, Destination=, Mode=0x0,
Call Params(Calling Number=213391,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allo
wed),
Called Number=xxxx(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*Jun 29 10:26:01.205: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
