[cisco-voip] Cisco IAD 243X releases NI2 call when receiving
minor ISDN messages from PBX
Wes Sisk
wsisk at cisco.com
Thu Aug 4 17:15:02 EDT 2005
So iad sends out an in ISDN setup with 'original called number'
Information Element (IE) populated:
ISDN Se1/1:23 Q931: TX -> SETUP
The far end Nortel sends back a status message complaining about the IE:
*Mar 9 16:27:44.408: ISDN Se1/1:23 Q931: RX <- STATUS pd = 8 callref =
0x8014
Cause i = 0x81E3 - Information element not implemented
Call State i = 0x06
At this point the IAD believes the call is in state 0x01: call initiated
(U1):
The PBX reports the call is in state 0x06: call present (U6) (or if
network side call present (N6):)
this represents a call state mismatch so we promptly disconnect the
call. We will need to either have the Nortel accept the IE or we can
have callmanager suppress the IE.
Looks like 'original called number' is a nortel specific implementation.
Under National ISDN (or primary-ni) this information is conveyed by
redirecting number IE. Are both Cisco and Nortel configured to use the
same trunk type/isdn protocol? Not sure what setting is available on
Nortel to have it accept this IE, but you may try National ISDN instead.
/Wes
/Wes
Hodgeman, Samuel wrote:
>Hi all,
>I'm hoping for an avalanche of suggestions, here, so please don't hold
>back!
>
>We're testing an interface between a Nortel Meridian 1 PBX and the Cisco
>IAD243X series of access devices.
>
>'Normal' calls complete in both directions. Yippee!
>
>However, calls that include redirection info, ie Originally Called
>Number and Redirecting Number, Fail.
>
>The PBX sends one of two messages back to the IAD after the SETUP
>message:
>'setup message contains unimplimented IE;' and/or 'in-band info or
>pattern available.'
>
>In either case, as soon as the IAD receives this message, it releases
>the call.
>
>Now, I see both of these 'error' messages QUITE frequently on one or
>another of our many PBXs across the country, and this NEVER causes a
>call to fail.
>
>Here is the Debug output. It certainly seems that, as soon as the IAD
>receives the message from the PBX, it kills the call. Check out the
>lines that include the text **error**
>
>Any ideas would be greatly appreciated.
>
> - Sam Hodgeman
>
>*Mar 9 16:27:44.264: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Received:
>INVITE sip:4435780463 at 172.27.13.102:5060 SIP/2.0
>
>Via:SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143706-1687763104-1123164235314
>
>From:"Ring
>Splash"<sip:RingSplash at 205.158.241.245>;tag=1687763104-1123164235314
>
>To:"4435780463"<sip:4435780463 at 172.27.13.102:5060>
>
>Call-ID:BW100355314040805-1349256735 at 205.158.241.245
>
>CSeq:15143706 INVITE
>
>Contact:<sip:205.158.241.245:5060>
>
>Alert-Info:<http://127.0.0.1/Bellcore-dr5>
>
>Allow:ACK,BYE,CANCEL,INFO,INVITE,OPTIONS,PRACK,REFER,UPDATE,NOTIFY
>
>Supported:100rel,timer
>
>Min-SE:60
>
>Accept:multipart/mixed,application/sdp
>
>Max-Forwards:10
>
>Content-Type:application/sdp
>
>Content-Length:113
>
>
>
>v=0
>
>o=BroadWorks 115330 0 IN IP4 205.158.241.245
>
>s=-
>
>c=IN IP4 205.158.241.245
>
>t=0 0
>
>m=audio 5000 RTP/AVP 0
>
>
>*Mar 9 16:27:44.276: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Sent:
>SIP/2.0 100 Trying
>
>Via: SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143706-1687763104-1123164235314
>
>From: "Ring
>Splash"<sip:RingSplash at 205.158.241.245>;tag=1687763104-1123164235314
>
>To: "4435780463"<sip:4435780463 at 172.27.13.102:5060>;tag=2CBB2D3C-1341
>
>Date: Sat, 09 Mar 2002 16:27:44 GMT
>
>Call-ID: BW100355314040805-1349256735 at 205.158.241.245
>
>Server: Cisco-SIPGateway/IOS-12.x
>
>CSeq: 15143706 INVITE
>
>Allow-Events: telephone-event
>
>Content-Length: 0
>
>
>
>
>
>*Mar 9 16:27:44.284: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Received:
>INVITE sip:2028210347 at 172.27.13.102:5060 SIP/2.0
>
>Via:SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143708-87566713-1123164235319
>
>From:<sip:7035472147 at 205.158.241.245;user=phone>;tag=87566713-1123164235
>319
>
>To:"0347 BT-1"<sip:2028210347 at 172.27.13.102:5060>
>
>Call-ID:BW100355319040805-932787069 at 205.158.241.245
>
>CSeq:15143708 INVITE
>
>Contact:<sip:205.158.241.245:5060>
>
>Diversion:"0463
>BT-1-FXS"<sip:4435780463 at 205.158.241.245>;reason=time-of-day;counter=1;p
>rivacy=off
>
>Allow:ACK,BYE,CANCEL,INFO,INVITE,OPTIONS,PRACK,REFER,UPDATE,NOTIFY
>
>Supported:100rel,timer
>
>Min-SE:60
>
>Accept:multipart/mixed,application/sdp
>
>Max-Forwards:10
>
>Content-Type:application/sdp
>
>Content-Length:148
>
>
>
>v=0
>
>o=BroadWorks 115328 1 IN IP4 205.158.241.235
>
>s=-
>
>c=IN IP4 205.158.241.161
>
>t=0 0
>
>m=audio 14656 RTP/AVP 0
>
>a=rtpmap:0 PCMU/8000
>
>a=sendrecv
>
>
>*Mar 9 16:27:44.296: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Sent:
>SIP/2.0 100 Trying
>
>Via: SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143708-87566713-1123164235319
>
>From:
><sip:7035472147 at 205.158.241.245;user=phone>;tag=87566713-1123164235319
>
>To: "0347 BT-1"<sip:2028210347 at 172.27.13.102:5060>;tag=2CBB2D50-9C7
>
>Date: Sat, 09 Mar 2002 16:27:44 GMT
>
>Call-ID: BW100355319040805-932787069 at 205.158.241.245
>
>Server: Cisco-SIPGateway/IOS-12.x
>
>CSeq: 15143708 INVITE
>
>Allow-Events: telephone-event
>
>Content-Length: 0
>
>
>
>
>
>*Mar 9 16:27:44.304: ISDN Se1/1:23 EVENTd: isdn_get_guid: Got Guid
>6B2EDFC581AE
>*Mar 9 16:27:44.304: ISDN Se1/1:23 EVENT: process_pri_call: call id
>0x8026, number 2028210347, Guid 6B2EDFC581AE, speed 0, call type VOICE,
>redial No, CSM call No, pdata YesReceived pdata len 0x3B data:1C 39 9E 1
>0 3 67 74 64 0 0 0 2E 49 41 4D 2C D A 47 43 49 2C 36 62 32 65 64 66 63
>35 33 32 62 31 31 31 64 36 38 31 61 65 66 34 64 66 33 38 65 63 64 64 32
>31 D A D A
>*Mar 9 16:27:44.304: ISDN Se1/1:23 EVENTd: process_pri_call: No name in
>GTD
>*Mar 9 16:27:44.304: ISDN Se1/1:23 Q931: Applying typeplan for sw-type
>0x5 is 0x2 0x1, Calling num 7035472147
>*Mar 9 16:27:44.308: ISDN Se1/1:23 EVENTd: : Mapping RDN IE to OCN IE -
>counter 0 cfnr ind 1696755256
>*Mar 9 16:27:44.308: ISDN Se1/1:23 EVENTd: process_pri_call: Packet to
>CC Data: 4D 0 1 80 26 29 4 4 80 0 10 A2 18 4 0 3 0 FF 6C D 2
>81 80 37 30 33 35 34 37 32 31 34 37 70 C 2 1 32 30 32 38 32 31 30 33
>34 37 4 3 8 0 10 18 3 0 3 0 6C C 21 80 37 30 33 35 34 37 32 31
>34 37 73 E 0 0 F 81 34 34 33 35 37 38 30 34 36 33
>*Mar 9 16:27:44.312: ISDN Se1/1:23 EVENTd: calltrkr_setup_received:
>isdn_info=1695181852l, call_id=0x8026 ORIGINATE
>*Mar 9 16:27:44.312: ISDN Se1/1:23 EVENTd: calltrkr_setup_received:
>calltracker disabled
>*Mar 9 16:27:44.312: ISDN Se1/1:23 Q931: TX -> SETUP pd = 8 callref =
>0x0014
> Bearer Capability i = 0x8090A2
> Standard = CCITT
> Transfer Capability = Speech
> Transfer Mode = Circuit
> Transfer Rate = 64 kbit/s
> Channel ID i = 0xA98381
> Exclusive, Channel 1
> Calling Party Number i = 0x2180, '7035472147'
> Plan:ISDN, Type:National
> Called Party Number i = 0xA1, '2028210347'
> Plan:ISDN, Type:National
> Original Called Number i = 0x00000F81, '4435780463'
> Plan:Unknown, Type:Unknown
>*Mar 9 16:27:44.408: ISDN Se1/1:23 Q931: RX <- STATUS pd = 8 callref =
>0x8014
> Cause i = 0x81E3 - Information element not implemented
> Call State i = 0x06
>*Mar 9 16:27:44.412: ISDN Se1/1:23 **ERROR**: Ux_Status: STATUS call
>state mismatch with invalid cause: cause 0x63, state 0x1, peer state 0x6
>*Mar 9 16:27:44.412: ISDN Se1/1:23 Q931: TX -> RELEASE pd = 8 callref
>= 0x0014
> Cause i = 0x82EF - Protocol error; unspecified
>*Mar 9 16:27:44.452: ISDN Se1/1:23 Q931: RX <- CALL_PROC pd = 8
>callref = 0x8014
> Channel ID i = 0xA98381
> Exclusive, Channel 1
>*Mar 9 16:27:44.452: ISDN Se1/1:23 **ERROR**: L3_ProcessEvent:
>UNEXPECTED event - 0x2 state 19
>*Mar 9 16:27:44.456: ISDN Se1/1:23 Q931: RX <- ALERTING pd = 8 callref
>= 0x8014
> Progress Ind i = 0x8188 - In-band info or appropriate now
>available
>*Mar 9 16:27:44.456: ISDN Se1/1:23 **ERROR**: L3_ProcessEvent:
>UNEXPECTED event - 0x1 state 19
>*Mar 9 16:27:44.764: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Received:
>CANCEL sip:4435780463 at 172.27.13.102:5060 SIP/2.0
>
>Via:SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143706-1687763104-1123164235314
>
>From:"Ring
>Splash"<sip:RingSplash at 205.158.241.245>;tag=1687763104-1123164235314
>
>To:"4435780463"<sip:4435780463 at 172.27.13.102:5060>
>
>Call-ID:BW100355314040805-1349256735 at 205.158.241.245
>
>CSeq:15143706 CANCEL
>
>Max-Forwards:10
>
>Content-Length:0
>
>
>
>
>
>*Mar 9 16:27:44.768: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Sent:
>SIP/2.0 200 OK
>
>Via: SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143706-1687763104-1123164235314
>
>From: "Ring
>Splash"<sip:RingSplash at 205.158.241.245>;tag=1687763104-1123164235314
>
>To: "4435780463"<sip:4435780463 at 172.27.13.102:5060>
>
>Date: Sat, 09 Mar 2002 16:27:44 GMT
>
>Call-ID: BW100355314040805-1349256735 at 205.158.241.245
>
>Content-Length: 0
>
>CSeq: 15143706 CANCEL
>
>
>
>
>
>*Mar 9 16:27:44.772: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Sent:
>SIP/2.0 487 Request Cancelled
>
>Via: SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143706-1687763104-1123164235314
>
>From: "Ring
>Splash"<sip:RingSplash at 205.158.241.245>;tag=1687763104-1123164235314
>
>To: "4435780463"<sip:4435780463 at 172.27.13.102:5060>;tag=2CBB2D3C-1341
>
>Date: Sat, 09 Mar 2002 16:27:44 GMT
>
>Call-ID: BW100355314040805-1349256735 at 205.158.241.245
>
>Server: Cisco-SIPGateway/IOS-12.x
>
>CSeq: 15143706 INVITE
>
>Allow-Events: telephone-event
>
>Content-Length: 0
>
>
>
>
>*Mar 9 16:27:44.792: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Received:
>ACK sip:4435780463 at 172.27.13.102:5060 SIP/2.0
>
>Via:SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143706-1687763104-1123164235314
>
>From:"Ring
>Splash"<sip:RingSplash at 205.158.241.245>;tag=1687763104-1123164235314
>
>To:"4435780463"<sip:4435780463 at 172.27.13.102:5060>;tag=2CBB2D3C-1341
>
>Call-ID:BW100355314040805-1349256735 at 205.158.241.245
>
>CSeq:15143706 ACK
>
>Max-Forwards:10
>
>Content-Length:0
>
>
>
>
>
>*Mar 9 16:27:44.792: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2,
>ConnectionId 6B2BD265 32B111D6 81ACF4DF 38ECDD21, SetupTime
>*11:27:44.272 EST Sat Mar 9 2002, PeerAddress RingSplash, PeerSubAddress
>, DisconnectCause 10 , DisconnectText normal call clearing (16),
>ConnectTime *11:27:44.792 EST Sat Mar 9 2002, DisconnectTime
>*11:27:44.792 EST Sat Mar 9 2002, CallOrigin 2, ChargedUnits 0, InfoType
>2, TransmitPackets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
>*Mar 9 16:27:47.996: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1,
>ConnectionId 6B2BD265 32B111D6 81ACF4DF 38ECDD21, SetupTime
>*11:27:44.296 EST Sat Mar 9 2002, PeerAddress 4435780463, PeerSubAddress
>, DisconnectCause 10 , DisconnectText normal call clearing (16),
>ConnectTime *11:27:47.996 EST Sat Mar 9 2002, DisconnectTime
>*11:27:47.996 EST Sat Mar 9 2002, CallOrigin 1, ChargedUnits 0, InfoType
>2, TransmitPackets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
>*Mar 9 16:27:48.312: ISDN Se1/1:23 **ERROR**: L3_ProcessEvent:
>UNEXPECTED event - 0x1313 state 19
>*Mar 9 16:27:48.312: ISDN **ERROR**: Module-l3_sdl_u
>Function-U19_BadMsg Error-Bad message received.
>*Mar 9 16:27:48.412: ISDN Se1/1:23 Q931: TX -> RELEASE pd = 8 callref
>= 0x0014
> Cause i = 0x82EF - Protocol error; unspecified
>*Mar 9 16:27:48.428: ISDN Se1/1:23 Q931: RX <- RELEASE_COMP pd = 8
>callref = 0x8014
> Cause i = 0x81D1 - Invalid call reference value
>*Mar 9 16:27:48.428: ISDN EVENTd: cc_clear_free_list freed 0x653F5F68
>*Mar 9 16:27:48.428: ISDN Se1/1:23 EVENT: process_rxstate: ces/callid
>1/0x8026 calltype 2 CALL_REJECTION
>*Mar 9 16:27:48.428: ISDN Se1/1:23 EVENTd: process_rxstate: cause=0x51
>(81), cause_present=1
>*Mar 9 16:27:48.432: ISDN CDAPI: cdapi_find_tsm found a GTD message
>RLC,
>
>PRN,isdn*,,NT100,
>
>
>
>:
> end of gtd length is 27
>*Mar 9 16:27:48.432: ISDN Se1/1:23 EVENT: process_rxstate: ces/callid
>1/0x8026 calltype 2 CALL_CLEARED
>*Mar 9 16:27:48.432: ISDN Se1/1:23 EVENTd: process_rxstate: cause=0x51
>(81), cause_present=1
>*Mar 9 16:27:48.432: ISDN Se1/1:23 EVENTd: calltrkr_call_cleared:
>isdn_info=0x650A6C1C, call_id=0x8026
>*Mar 9 16:27:48.432: ISDN Se1/1:23 EVENTd: calltrkr_call_cleared:
>isdn_info=0x64FA7ABC, call_id=0x8026
>*Mar 9 16:27:48.432: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1,
>ConnectionId 6B2EDFC5 32B111D6 81AEF4DF 38ECDD21, SetupTime
>*11:27:48.432 EST Sat Mar 9 2002, PeerAddress 2028210347, PeerSubAddress
>, DisconnectCause 51 , DisconnectText invalid call ref value (81),
>ConnectTime *11:27:48.432 EST Sat Mar 9 2002, DisconnectTime
>*11:27:48.432 EST Sat Mar 9 2002, CallOrigin 1, ChargedUnits 0, InfoType
>2, TransmitPackets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
>*Mar 9 16:27:48.440: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Sent:
>SIP/2.0 500 Internal Server Error
>
>Via: SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143708-87566713-1123164235319
>
>From:
><sip:7035472147 at 205.158.241.245;user=phone>;tag=87566713-1123164235319
>
>To: "0347 BT-1"<sip:2028210347 at 172.27.13.102:5060>;tag=2CBB2D50-9C7
>
>Date: Sat, 09 Mar 2002 16:27:44 GMT
>
>Call-ID: BW100355319040805-932787069 at 205.158.241.245
>
>Server: Cisco-SIPGateway/IOS-12.x
>
>CSeq: 15143708 INVITE
>
>Allow-Events: telephone-event
>
>Reason: Q.850;cause=81
>
>Content-Length: 0
>
>
>
>
>*Mar 9 16:27:48.456: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
>Received:
>ACK sip:2028210347 at 172.27.13.102:5060 SIP/2.0
>
>Via:SIP/2.0/UDP
>205.158.241.245;branch=z9hG4bK-BroadWorks.205.158.241.245-172.27.13.102V
>5060-0-15143708-87566713-1123164235319
>
>From:<sip:7035472147 at 205.158.241.245;user=phone>;tag=87566713-1123164235
>319
>
>To:"0347 BT-1"<sip:2028210347 at 172.27.13.102:5060>;tag=2CBB2D50-9C7
>
>Call-ID:BW100355319040805-932787069 at 205.158.241.245
>
>CSeq:15143708 ACK
>
>Max-Forwards:10
>
>Content-Length:0
>
>
>
>
>
>*Mar 9 16:27:48.460: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2,
>ConnectionId 6B2EDFC5 32B111D6 81AEF4DF 38ECDD21, SetupTime
>*11:27:44.290 EST Sat Mar 9 2002, PeerAddress 7035472147, PeerSubAddress
>, DisconnectCause 51 , DisconnectText invalid call ref value (81),
>ConnectTime *11:27:48.460 EST Sat Mar 9 2002, DisconnectTime
>*11:27:48.460 EST Sat Mar 9 2002, CallOrigin 2, ChargedUnits 0, InfoType
>2, TransmitPackets 0, TransmitBytes 0, ReceivePackets 0, ReceiveBytes 0
>
>_______________________________________________
>cisco-voip mailing list
>cisco-voip at puck.nether.net
>https://puck.nether.net/mailman/listinfo/cisco-voip
>
>
More information about the cisco-voip
mailing list