cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
852
Views
0
Helpful
1
Replies

call failing from a certain number

Oleg Serstjuk
Level 1
Level 1

Hi,

We have a customer who is having issue receiving a call from one certain number not being able to call them, call flow isdn --> h323 --> cucm

This was initially logged with the provider and a workaround was created, the provider hid the caller ID and the call works fine. If you call this number from another phone the call works. but if a call comes from 8075380 there is no ring back and provider sends a disconnect message after 15seconds without receiving alerting.

Any suggestions where to look next?

Here is the debug from the failed call

Sep 13 11:09:40.946: ISDN Se0/0/0:15 Q931: RX <- SETUP pd= 8  callref = 0x5600

                Sending Complete

               Bearer Capability i = 0x8090A3

                               Standard = CCITT

                                Transfer Capability = Speech 

                                Transfer Mode = Circuit

                               Transfer Rate = 64 kbit/s

               Channel ID i = 0xA18382

                                Preferred, Channel 2

               Progress Ind i = 0x8081 - Call not end-to-end ISDN, may have in-band info

               Calling Party Number i = 0x4183, '8075380'

                                Plan:ISDN, Type:Subscriber(local)

               Called Party Number i = 0x81, '2005'

                                Plan:ISDN, Type:Unknown

               Low Layer Compat i = 0x8090A3

               High Layer Compat i = 0x9181

Sep 13 11:09:40.950: ISDN Se0/0/0:15 Q931: ReceivedSETUP  callref = 0xD600 callID = 0x2B20 switch = primary-net5 interface =User

Sep 13 11:09:40.958://-1/D211BC94AA61/CCAPI/cc_api_display_ie_subfields:

Sep 13 11:09:40.966://740125/D211BC94AA61/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x4A6EBB0C, Interface Type=1, Destination=, Mode=0x0,

   Call Params(Calling Number=8075380,(CallingName=)(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

   Called Number=2005(TON=Unknown, NPI=ISDN),Calling Translated=FALSE,

   Subscriber Type Str=RegularLine,FinalDestinationFlag=TRUE, Outgoing Dial-peer=2000, Call Count On=FALSE,

   Source Trkgrp Route Label=1, Target TrkgrpRoute Label=, tg_label_flag=1, Application Call Id=)

Sep 13 11:09:40.974: ISDN Se0/0/0:15 Q931: TX ->CALL_PROC pd = 8  callref = 0xD600

               Channel ID i = 0xA98382

                                Exclusive, Channel 2

Sep 13 11:09:55.982://740125/D211BC94AA61/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource. My guess is this is something to do with transcending, but the same call works if caller ID is hidden(i dont have the debugs for that call though)

Sep 13 11:09:55.990://740125/D211BC94AA61/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=2010, Params=0x4F6A6798,Progress Indication=ORIGINATING SIDE IS NON ISDN(3)

Sep 13 11:09:55.994: //740125/D211BC94AA61/CCAPI/ccCheckClipClir:

   In: Calling Number=8075380(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed)

Sep 13 11:09:55.994://740125/D211BC94AA61/CCAPI/ccCheckClipClir:

   Out: Calling Number=8075380(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed)

Sep 13 11:09:55.994://740125/D211BC94AA61/CCAPI/ccCallSetupRequest:

   Destination Pattern=2..., Called Number=2005, Digit Strip=FALSE

Sep 13 11:09:55.994://740125/D211BC94AA61/CCAPI/ccCallSetupRequest:

   Calling Number=8075380(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

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

   Redirect Number=, Display Info=

   Account Number=, Final Destination Flag=TRUE,

   Guid=D211BC94-1B9B-11E3-AA61-0014F2AAB290,Outgoing Dial-peer=2010

Sep 13 11:09:55.994://740125/D211BC94AA61/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=

   ----- ccCallInfo IE subfields -----

   cisco-ani=8075380

   cisco-anitype=4

   cisco-aniplan=1

   cisco-anipi=0

   cisco-anisi=3

   dest=2005

   cisco-desttype=0

   cisco-destplan=1

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   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

Sep 13 11:09:55.994://740125/D211BC94AA61/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x4A6EBB0C, Interface Type=1, Destination=, Mode=0x0,

   Call Params(Calling Number=8075380,(CallingName=)(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

   Called Number=2005(TON=Unknown, NPI=ISDN),Calling Translated=FALSE,

   Subscriber Type Str=RegularLine,FinalDestinationFlag=TRUE, Outgoing Dial-peer=2010, Call Count On=FALSE,

   Source Trkgrp Route Label=1, Target TrkgrpRoute Label=, tg_label_flag=1, Application Call Id=)

Sep 13 11:10:05.719: ISDN Se0/0/0:15 Q931: RX <-DISCONNECT pd = 8  callref = 0x5600

               Cause i = 0x05809F - Normal, unspecified

Sep 13 11:10:05.751: ISDN Se0/0/0:15 Q931: TX -> RELEASEpd = 8  callref = 0xD600

Sep 13 11:10:05.751://740125/D211BC94AA61/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x4B116398, Call Id=740125

Sep 13 11:10:05.755://740125/D211BC94AA61/CCAPI/cc_api_call_disconnected:

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

Here is a succesfull call

dgfpel-2821-r1#ter  mon 

dgfpel-2821-r1#

Sep 13 12:17:59.968: ISDN Se0/0/0:15 Q931: RX <- SETUP pd = 8  callref = 0x2C00

        Sending Complete

        Bearer Capability i = 0x9090A3

                Standard = CCITT

                Transfer Capability = 3.1kHz Audio

                Transfer Mode = Circuit

                Transfer Rate = 64 kbit/s

        Channel ID i = 0xA18398

                Preferred, Channel 24

        Progress Ind i = 0x8A81 - Call not end-to-end ISDN, may have in-band info 

        Calling Party Number i = 0x4183, '4611923'

                Plan:ISDN, Type:Subscriber(local)

        Called Party Number i = 0x81, '2005'

                Plan:ISDN, Type:Unknown

Sep 13 12:17:59.968: ISDN Se0/0/0:15 Q931: Received SETUP  callref = 0xAC00 callID = 0x2B75 switch = primary-net5 interface = User

Sep 13 12:17:59.972: //-1/5D462822AAB6/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=

   ----- ccCallInfo IE subfields -----

   cisco-ani=4611923

   cisco-anitype=4

   cisco-aniplan=1

   cisco-anipi=0

   cisco-anisi=3

   dest=2005

   cisco-desttype=0

   cisco-destplan=1

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   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

Sep 13 12:17:59.976: //-1/5D462822AAB6/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x4B116398, Call Info(

   Calling Number=4611923,(Calling Name=)(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

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

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

   Incoming Dial-peer=22, Progress Indication=NOT END TO END ISDN(1), Calling IE Present=TRUE,

   Source Trkgrp Route Label=1, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1

Sep 13 12:17:59.976: //-1/5D462822AAB6/CCAPI/ccCheckClipClir:

   In: Calling Number=4611923(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed)

Sep 13 12:17:59.976: //-1/5D462822AAB6/CCAPI/ccCheckClipClir:

   Out: Calling Number=4611923(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed)

Sep 13 12:17:59.976: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Sep 13 12:17:59.976: :cc_get_feature_vsa malloc success

Sep 13 12:17:59.976: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Sep 13 12:17:59.976:  cc_get_feature_vsa count is 1

Sep 13 12:17:59.976: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Sep 13 12:17:59.976: :FEATURE_VSA attributes are: feature_name:0,feature_time:1322795336,feature_id:740487

Sep 13 12:17:59.976: //740493/5D462822AAB6/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=4611923(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

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

Sep 13 12:17:59.976: //740493/5D462822AAB6/CCAPI/cc_process_call_setup_ind:

   Event=0x4B0D10F8

Sep 13 12:17:59.976: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 2005

Sep 13 12:17:59.976: //740493/5D462822AAB6/CCAPI/ccCallSetContext:

   Context=0x4F6AA588

Sep 13 12:17:59.976: //740493/5D462822AAB6/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 740493 with tag 22 to app "_ManagedAppProcess_Default"

Sep 13 12:17:59.980: //740493/5D462822AAB6/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

Sep 13 12:17:59.980: //740493/5D462822AAB6/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=2000, Params=0x4F275394, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)

Sep 13 12:17:59.980: //740493/5D462822AAB6/CCAPI/ccCheckClipClir:

   In: Calling Number=4611923(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed)

Sep 13 12:17:59.984: //740493/5D462822AAB6/CCAPI/ccCheckClipClir:

   Out: Calling Number=4611923(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed)

Sep 13 12:17:59.984: //740493/5D462822AAB6/CCAPI/ccCallSetupRequest:

   Destination Pattern=2..., Called Number=2005, Digit Strip=FALSE

Sep 13 12:17:59.984: //740493/5D462822AAB6/CCAPI/ccCallSetupRequest:

   Calling Number=4611923(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

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

   Redirect Number=, Display Info=

   Account Number=, Final Destination Flag=TRUE,

   Guid=5D462822-1BA5-11E3-AAB6-0014F2AAB290, Outgoing Dial-peer=2000

Sep 13 12:17:59.984: //740493/5D462822AAB6/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=

   ----- ccCallInfo IE subfields -----

   cisco-ani=4611923

   cisco-anitype=4

   cisco-aniplan=1

   cisco-anipi=0

   cisco-anisi=3

   dest=2005

   cisco-desttype=0

   cisco-destplan=1

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   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

Sep 13 12:17:59.984: //740493/5D462822AAB6/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x4A6EBB0C, Interface Type=1, Destination=, Mode=0x0,

   Call Params(Calling Number=4611923,(Calling Name=)(TON=Subscriber, NPI=ISDN, Screening=Network, Presentation=Allowed),

   Called Number=2005(TON=Unknown, NPI=ISDN), Calling Translated=FALSE,

   Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=2000, Call Count On=FALSE,

   Source Trkgrp Route Label=1, Target Trkgrp Route Label=, tg_label_flag=1, Application Call Id=)

Sep 13 12:17:59.984: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Sep 13 12:17:59.984: :cc_get_feature_vsa malloc success

Sep 13 12:17:59.984: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Sep 13 12:17:59.984:  cc_get_feature_vsa count is 2

Sep 13 12:17:59.984: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Sep 13 12:17:59.984: :FEATURE_VSA attributes are: feature_name:0,feature_time:1322788168,feature_id:740488

Sep 13 12:17:59.984: //740494/5D462822AAB6/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=1, FlowMode=1

Sep 13 12:17:59.984: //740494/5D462822AAB6/CCAPI/ccCallSetContext:

   Context=0x4F275344

Sep 13 12:17:59.984: //740493/5D462822AAB6/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=2000

Sep 13 12:17:59.988: ISDN Se0/0/0:15 Q931: TX -> CALL_PROC pd = 8  callref = 0xAC00

        Channel ID i = 0xA98398

                Exclusive, Channel 24

Sep 13 12:18:00.100: //740494/5D462822AAB6/CCAPI/cc_api_set_called_ccm_detected:

   CallInfo(called ccm detected=TRUE ccmVersion 3)

Sep 13 12:18:00.104: //740494/5D462822AAB6/CCAPI/cc_api_call_proceeding:

   Interface=0x4A6EBB0C, Progress Indication=NULL(0)

Sep 13 12:18:00.208: //740494/5D462822AAB6/CCAPI/cc_api_set_called_ccm_detected:

   CallInfo(called ccm detected=TRUE ccmVersion 3)

Sep 13 12:18:00.208: //740494/5D462822AAB6/CCAPI/cc_api_set_delay_xport:

   CallInfo(delay xport=TRUE)

Sep 13 12:18:00.208: //740494/5D462822AAB6/CCAPI/cc_api_call_alert:

   Interface=0x4A6EBB0C, Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)

Sep 13 12:18:00.208: //740494/5D462822AAB6/CCAPI/cc_api_call_alert:

   Call Entry(Retry Count=0, Responsed=TRUE)

Sep 13 12:18:00.212: //740493/5D462822AAB6/CCAPI/ccCallAlert:

   Progress Indication=NULL(0), Signal Indication=SIGNAL RINGBACK(1)

Sep 13 12:18:00.212: //740493/5D462822AAB6/CCAPI/ccCallAlert:

   Call Entry(Responsed=TRUE, Alert Sent=TRUE)

Sep 13 12:18:00.216: ISDN Se0/0/0:15 Q931: TX -> ALERTING pd = 8  callref = 0xAC00

        Progress Ind i = 0x8188 - In-band info or appropriate now available

Sep 13 12:18:00.216: //740494/5D462822AAB6/CCAPI/cc_api_set_called_ccm_detected:

   CallInfo(called ccm detected=TRUE ccmVersion 3)

Sep 13 12:18:00.216: //740494/5D462822AAB6/CCAPI/cc_api_call_notify:

   Data Bitmask=0x5, Interface=0x4A6EBB0C, Call Id=740494

Sep 13 12:18:00.216: //740494/5D462822AAB6/CCAPI/cc_api_get_ssCTreRoutingNotSupported:

   CallInfo(ssCTreRoutingNotSupported=FALSE)

Sep 13 12:18:00.216: //740494/5D462822AAB6/CCAPI/cc_api_get_ccm_detected:

   CallInfo(ccm detected=TRUE)

Sep 13 12:18:00.216: //740493/5D462822AAB6/CCAPI/ccCallNotify:

   Data Bitmask=0x5, Call Id=740493

Sep 13 12:18:04.716: ISDN Se0/0/0:15 Q931: RX <- DISCONNECT pd = 8  callref = 0x2C00

        Cause i = 0x00809F - Normal, unspecified

Sep 13 12:18:04.720: ISDN Se0/0/0:15 Q931: TX -> RELEASE pd = 8  callref = 0xAC00

Sep 13 12:18:04.720: //740493/5D462822AAB6/CCAPI/cc_api_call_disconnected:

   Cause Value=31, Interface=0x4B116398, Call Id=740493

Sep 13 12:18:04.720: //740493/5D462822AAB6/CCAPI/cc_api_call_disconnected:

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

Sep 13 12:18:04.724: //740493/5D462822AAB6/CCAPI/ccGenerateToneInfo:

   Stop Tone On Digit=FALSE, Tone=Null,

   Tone Direction=Network, Params=0x0, Call Id=740493

Sep 13 12:18:04.724: //740494/5D462822AAB6/CCAPI/ccCallDisconnect:

   Cause Value=31, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

Sep 13 12:18:04.724: //740494/5D462822AAB6/CCAPI/ccCallDisconnect:

   Cause Value=31, Call Entry(Responsed=TRUE, Cause Value=31)

Sep 13 12:18:04.724: //740494/5D462822AAB6/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Sep 13 12:18:04.724: //740493/5D462822AAB6/CCAPI/ccCallDisconnect:

   Cause Value=31, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=31)

Sep 13 12:18:04.724: //740493/5D462822AAB6/CCAPI/ccCallDisconnect:

   Cause Value=31, Call Entry(Responsed=TRUE, Cause Value=31)

Sep 13 12:18:04.724: //740493/5D462822AAB6/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Sep 13 12:18:04.732: //740494/5D462822AAB6/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x4A6EBB0C, Tag=0x0, Call Id=740494,

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

Sep 13 12:18:04.732: //740494/5D462822AAB6/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Sep 13 12:18:04.732: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Sep 13 12:18:04.732: :cc_free_feature_vsa freeing 4ED82540

Sep 13 12:18:04.732: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Sep 13 12:18:04.732:  vsacount in free is 1

dgfpel-2821-r1#

dgfpel-2821-r1#

dgfpel-2821-r1#

dgfpel-2821-r1#

Sep 13 12:18:04.744: ISDN Se0/0/0:15 Q931: RX <- RELEASE_COMP pd = 8  callref = 0x2C00

Sep 13 12:18:04.752: //740493/5D462822AAB6/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x4B116398, Tag=0x0, Call Id=740493,

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

Sep 13 12:18:04.752: //740493/5D462822AAB6/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Sep 13 12:18:04.752: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Sep 13 12:18:04.752: :cc_free_feature_vsa freeing 4ED84140

Sep 13 12:18:04.752: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Sep 13 12:18:04.752:  vsacount in free is 0

dgfpel-2821-r1#

Here is the dial peer config

!

dial-peer voice 2000 voip

preference 1

destination-pattern 2...

progress_ind setup enable 3

modem passthrough nse codec g711alaw

session target ipv4:2.153.55.10  PUB

voice-class codec 4500 

voice-class h323 1

dtmf-relay h245-alphanumeric

fax rate disable

ip qos dscp cs5 media

ip qos dscp cs5 signaling

no vad

!

dial-peer voice 2010 voip

preference 2

destination-pattern 2...

progress_ind setup enable 3

modem passthrough nse codec g711alaw

session target ipv4:2.153.56.10 SUB

voice-class codec 4500 

voice-class h323 1

dtmf-relay h245-alphanumeric

fax rate disable

ip qos dscp cs5 media

ip qos dscp cs5 signaling

no vad

!

1 Reply 1

Nishant Savalia
Level 4
Level 4

Hi oleg,

Please do send full router configuration along with "debug h225 asn1" & "debug isdn q931" and detailed trace of RTMT of successful & failure call.

Also make 3 to 4 calls from '8075380' and check Transfer Capability = ??? received each time in debug isdn q931 set up message.

Also try to make successfull calls and check for the Transfer Capability =??? again.

Thanks & Regards,

Nishant Savalia

Regards, Nishant Savalia