Re: ISDN link stays up, but only at one end

vcjones · ‎06-20-2003

Wondering if anyone else has run into the situation where a router (2610) places an ISDN call (DDR) to a 3640. Everything works fine while the link is up, but when the 2610 takes down the link, it only disconnects at the 2610 end. Show ISDN status on the 2610 shows no link in use, but the 3640 (and Verizon) still see the link as up. Placing another call from the 2610 causes the call to be placed on the other B channel, placing a third call fails (even though the 2610 claims no ISDN is in use).

A check for bugs did not find anything using any keywords I can think of... 2610 is using 12.1.1 (a mistake that may or may not be relevant). 200 other 2610's which use the same configuration to call the same 3640 have no such problems, so it would appear to be either an IOS bug, Verizon bug, or hardware defect on the 2610. The $6,400 question is which... (FYI Verizon charges by the B channel by the minute).

Vincent C Jones

thisisshanky · ‎06-20-2003

Vincent,

On a debug isdn q931, is the 2610 receiving a proper disconnect cause code ? What abt the same on the 3600 (though running the debug on the 3600 can be hazardous)...

Sankar Nair
UC Solutions Architect
Pacific Northwest | CDW
CCIE Collaboration #17135 Emeritus

vcjones · ‎06-22-2003

A few clarifications:

- The IOS is 12.1.1T, not 12.1.1

- Same IOS, different router, different BRI line = no problem

(disclaimer: tested by the same tech who ignored the "T")

- No problem during normal call clearing (idle timeout)

- Big problem when call is terminated by "clear int bri0/0"

- Shut/No Shut only clears the call if shut down is long enough

And a few traces:

- Q931 of clear interface clearing on the failing router

- ISDN Events of clear interface clearing on the failing router

- Q931 of "normal call clearing" (idle timeout)

- Q931 & events of clear interface clearing on a working router

- Phone numbers have been mangled to protect the guilty

Failing Clear Interface - Q931 debug

----------------------------

DR343RTR1#clear int bri0/0

DR343RTR1#

Jun 21 13:03:19.061: %ISDN-6-DISCONNECT: Interface BRI0/0:1 disconnected from 1010

6521xxxxxx7060 DR25RTR7, call lasted 25 seconds

Jun 21 13:03:19.061: %LINK-3-UPDOWN: Interface BRI0/0:1, changed state to down

Jun 21 13:03:19.097: %ISDN-6-LAYER2UP: Layer 2 for Interface BR0/0, TEI 67 changed to up

Jun 21 13:03:19.129: %ISDN-6-LAYER2UP: Layer 2 for Interface BR0/0, TEI 65 changed to up

Jun 21 13:03:20.062: %LINEPROTO-5-UPDOWN: Line protocol on Interface BRI0/0:1, changed state to down

DR343RTR1#

Failing Clear Interface - ISDN Events debug

-----------------------------------

DR343RTR1#clear int bri0/0

DR343RTR1#

Jun 21 13:04:14.538: %ISDN-6-DISCONNECT: Interface BRI0/0:2 disconnected from 1010

6521xxxxxx7060 DR25RTR7, call lasted 33 seconds

Jun 21 13:04:14.538: %LINK-3-UPDOWN: Interface BRI0/0:2, changed state to down

Jun 21 13:04:14.554: ISDN BR0/0: Physical layer is IF_DOWN

Jun 21 13:04:14.554: ISDN BR0/0: L1 persistent Deactivated

Jun 21 13:04:14.554: ISDN BR0/0: L1 is IF_ACTIVE

Jun 21 13:04:14.554: ISDN BR0/0: Incoming call id = 0x3C, dsl 0

Jun 21 13:04:14.558: ISDN BR0/0: Shutting down ME

Jun 21 13:04:14.558: ISDN BR0/0: Shutting down ISDN Layer 3

Jun 21 13:04:14.578: %ISDN-6-LAYER2UP: Layer 2 for Interface BR0/0, TEI 67 changed to up

Jun 21 13:04:14.582: ISDN BR0/0: Incoming call id = 0x3D, dsl 0

Jun 21 13:04:14.618: %ISDN-6-LAYER2UP: Layer 2 for Interface BR0/0, TEI 65 changed to up

Jun 21 13:04:15.539: %LINEPROTO-5-UPDOWN: Line protocol on Interface BRI0/0:2, changed state to down

DR343RTR1#

Normal call clearing - DDR idle timeout

---------------------------------------

DR343RTR1#

Jun 21 11:41:13.662: ISDN BR0/0: Event: Hangup call to call id 0x800B ces = 1

Jun 21 11:41:13.662: ISDN BR0/0: process_disconnect(): call id 0x800B, call type is

DATA, b_idb 0xJun 21 11:41:13.666: %ISDN-6-DISCONNECT: Interface BRI0/0:2 disconnected from 1010

6521xxxxxx7060 DR25RTR7, call lasted 172 seconds

Jun 21 11:41:13.670: ISDN BR0/0: TX -> DISCONNECT pd = 8 callref = 0x0B

Jun 21 11:41:13.670: Cause i = 0x8090 - Normal call clearing

Jun 21 11:41:13.774: ISDN BR0/0: RX <- RELEASE pd = 8 callref = 0x8B

Jun 21 11:41:13.782: ISDN BR0/0: received HOST_DISCONNECT_ACK call_id 0x800B

Jun 21 11:41:13.782: ISDN BR0/0: HOST_DISCONNECT_ACK: call type is DATA

Jun 21 11:41:13.786: %LINK-3-UPDOWN: Interface BRI0/0:2, changed state to down

Jun 21 11:41:13.798: ISDN BR0/0: TX -> RELEASE_COMP pd = 8 callref = 0x0B

Jun 21 11:41:14.788: %LINEPROTO-5-UPDOWN: Line protocol on Interface BRI0/0:2, changed state to down

Jun 21 11:41:58.325: ISDN BR0/0: RX <- DISCONNECT pd = 8 callref = 0x8A

Jun 21 11:41:58.325: Cause i = 0x8090 - Normal call clearing

Jun 21 11:41:58.329: L3: L3_GetUser_NLCB returned NULL, message ignored cid 0x0 cr 0xA ev 0x45 ces 1 dsl 0

Jun 21 11:41:58.333: ISDN BR0/0: TX -> RELEASE_COMP pd = 8 callref = 0x0A

DR343RTR1#no deb all

Clear Interface on a working router

-----------------------------------

DR340RTR1#clear int bri0/0

DR340RTR1#

Jun 21 12:52:27.603: %ISDN-6-DISCONNECT: Interface BRI0/0:1 disconnected from 1010

6521xxxxxx7060 DR25RTR7, call lasted 21 seconds

Jun 21 12:52:27.607: isdn_Call_disconnect() 80CE7D64, ces 1, cause 0x10

Jun 21 11:41:13.666: %ISDN-6-DISCONNECT: Interface BRI0/0:2 disconnected from 1010