Solved: Re: E1 PRI Incoming Call Never reaches Call Control (AVAYA) - Page 2

Mustain · ‎02-04-2022

Hi Good People,

Please help me to find out what exactly is the problem with my VG E1 PRI, incoming calls never reach call control. Call Control Team (Avaya) says, they never receive any logs coming from my router. However, if I check the debug output, the translation rules are correct and the ISDN status is Active as expected. Here is the debug result I mean,

VOICE-ROUTER#
002097: .Feb 4 17:37:58.614 WIB: ISDN Se3/0/0:15 Q931: RX <- SETUP pd = 8 callref = 0x004F
Sending Complete
Bearer Capability i = 0x8090A3
Standard = CCITT
Transfer Capability = Speech
Transfer Mode = Circuit
Transfer Rate = 64 kbit/s
Channel ID i = 0xA98381
Exclusive, Channel 1
Calling Party Number i = 0x2183, '02139500555'
Plan:ISDN, Type:National
Called Party Number i = 0x80, '031298053232'
Plan:Unknown, Type:Unknown
002098: .Feb 4 17:37:58.614 WIB: //-1/5AB5BD39802F/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=02139500555
cisco-anitype=2
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=3
dest=6761124
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-rdntype=-1
cisco-rdnplan=-1
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1
002099: .Feb 4 17:37:58.618 WIB: //-1/5AB5BD39802F/CCAPI/cc_api_call_setup_ind_common:
Interface=0x67148F04, Call Info(
Calling Number=02139500555(TON=National, NPI=ISDN, Screening=Network, Presentation=Allowed),
Called Number=6761124(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
002100: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=02139500555(TON=National, NPI=ISDN, Screening=Network, Presentation=Allowed),
Called Number=6761124(TON=Unknown, NPI=Unknown))
002101: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/cc_process_call_setup_ind:
Event=0x66B74A58
002102: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/ccCallSetContext:
Context=0x67BE4D14
002103: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 46 with tag 0 to app "_ManagedAppProcess_Default"
002104: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/ccCallSetupAck:
Call Id=46
002105: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_set_transfer_info:
Transfer Number=, Transfer Reason=0x0
002106: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=TRUE, Tone=Dial Tone,
Tone Direction=Network, Params=0x0, Call Id=46
002107: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/ccSetDigitTimeouts:
Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
002108: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/ccSetDigitTimeouts:
Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
002109: .Feb 4 17:37:58.618 WIB: //46/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
(callID=0x2E, digit_event=0x1, enable=TRUE, consume=FALSE)
002110: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=46
002111: .Feb 4 17:37:58.618 WIB: //46/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
(vdbPtr=0x67148F04, callID=0x2E, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
002112: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x67148F04, Call Id=46
002113: .Feb 4 17:37:58.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms))
002114: .Feb 4 17:37:58.618 WIB: ISDN Se3/0/0:15 Q931: TX -> CALL_PROC pd = 8 callref = 0x804F
Channel ID i = 0xA98381
Exclusive, Channel 1
002115: .Feb 4 17:37:58.618 WIB: ISDN Se3/0/0:15 Q931: TX -> CONNECT pd = 8 callref = 0x804F
002116: .Feb 4 17:37:58.646 WIB: ISDN Se3/0/0:15 Q931: RX <- CONNECT_ACK pd = 8 callref = 0x004F
002117: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/cc_handle_inter_digit_timer:
Generate inter-digit timeout CC_EV_CALL_DIGIT_END event
002118: .Feb 4 17:38:08.618 WIB: //46/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
(callID=0x2E, digit_event=0x0, enable=FALSE, consume=FALSE)
002119: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=46
002120: .Feb 4 17:38:08.618 WIB: //46/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
(vdbPtr=0x67148F04, callID=0x2E, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
002121: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x67148F04, Call Id=46
002122: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms))
002123: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/ccCallDisconnect:
Cause Value=28, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
002124: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/ccCallDisconnect:
Cause Value=28, Call Entry(Responsed=TRUE, Cause Value=28)
002125: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
002126: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_disc_cause_update:
Cause Value=16
002127: .Feb 4 17:38:08.618 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_disc_cause_update:
Call Entry(Disconnect Cause=16)
002128: .Feb 4 17:38:34.078 WIB: ISDN Se3/0/0:15 Q931: RX <- DISCONNECT pd = 8 callref = 0x004F
Cause i = 0x8090 - Normal call clearing
002129: .Feb 4 17:38:34.082 WIB: ISDN Se3/0/0:15 Q931: TX -> RELEASE pd = 8 callref = 0x804F
002130: .Feb 4 17:38:34.110 WIB: ISDN Se3/0/0:15 Q931: RX <- RELEASE_COMP pd = 8 callref = 0x004F
002131: .Feb 4 17:38:34.110 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x67148F04, Tag=0x0, Call Id=46,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
002132: .Feb 4 17:38:34.110 WIB: //46/5AB5BD39802F/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent

Please let me know if there is anything else you need to help me solve this problem.

Thanks in advance.

Regards,

Mustain

Roger Kallberg · ‎02-04-2022

As @TONY SMITH wrote the call seems to be using dial-peer 0, in your case inbound. That's a very bad thing to have happening and should be dealt with by having the proper configuration for dial peers in-place. It also does seem like there is no outbound dial peer matched and that would explain why the Avaya folks says that they don't see the call on their end.

Have a look at this excellent document on the topic for dial peer matching. https://www.cisco.com/c/en/us/support/docs/voice/ip-telephony-voice-over-ip-voip/211306-In-Depth-Explanation-of-Cisco-IOS-and-IO.html

Looking at your shared configuration does not give a clear idea on what the expected dial peers for the call should be, so please describe that in as much details as you can and also please give the calling and called numbers for reference to make it easier to see the flow through your gateway. Also please include where is the call made from and to what.

TONY SMITH · ‎02-08-2022

So the solution is to use CUCM and ditch the Avaya? I'm sure I'm not the only one here who likes that in principle, but I'm surprised it suits your business given the initial question. Can you now route all your numbers via CUCM? Your initial configuration seemed to translate any incoming calls onto a single internal DN.

Mustain · ‎02-08-2022

I'm using CUCM only for testing purposes, to make sure the signaling is working properly as I can't verify anything on Avaya's side due to Avaya's maintenance by another team. After that, I redirected the DP to Avaya and now incoming calls are working fine.