[c-nsp] Cause i = 0x80BA - Bearer capability not available

Josh Duffek consultantjd16 at ridemetro.org
Tue Mar 8 16:42:40 EST 2005


What does your config look like?  The error:
> Mar  8 21:17:53.141: ISDN Se0:23 **ERROR**: call_incoming: Received a
call
> id 0x
> A with a bad bearercap from <unknown> on b channel 2

...sounds like you just don't have "isdn incoming-voice voice"
configured...but what do I know.

Also...if you re-debug get one call with JUST q931 turned on.

Thanks,

josh duffek    network engineer
consultantjd16 at ridemetro.org

> -----Original Message-----
> From: cisco-nsp-bounces at puck.nether.net [mailto:cisco-nsp-
> bounces at puck.nether.net] On Behalf Of list at ipmotel.net
> Sent: Tuesday, March 08, 2005 3:29 PM
> To: cisco-nsp at puck.nether.net
> Subject: [c-nsp] Cause i = 0x80BA - Bearer capability not available
> 
> All,
> 
> I am trying to send calls via the T-1 Interface on a Cisco AS5300.
The
> call
> originates from my switch and send the call to the cisco t-1 via ISDN.
> For
> some reason the calls keep failing.  When I do a ISDN Debug in my
AS5300 I
> get the following output during the failed call. I am using System
image
> file is "flash:c5300-is-mz.123-13.bin" The output is below.
> 
> Any help is greately appreciated,
> 
> Thank you,
> Jon
> 
> Mar  8 21:17:53.121: ISDN  Q921d: isdn_from_driver_process:
QUEUE_EVENT
> Mar  8 21:17:53.121: ISDN Se0:23 Q921f: User RX <-
> 0x020112120802000A05A10403809
> 0A218
> Mar  8 21:17:53.121:    03A983821E0283816C0200C370118130
> Mar  8 21:17:53.121:    313138363539313238383033373336
> Mar  8 21:17:53.121: ISDN Se0:23 Q921: User RX <- INFO sapi=0 tei=0,
ns=9
> nr=9
> Mar  8 21:17:53.121: ISDN Se0:23 Q931: SETUP pd = 8  callref = 0x000A
>         Sending Complete
>         Bearer Capability i = 0x8090A2
>                 Standard = CCITT
>                 Transfer Capability = Speech
>                 Transfer Mode = Circuit
>                 Transfer Rate = 64 kbit/s
>         Channel ID i = 0xA98382
>                 Exclusive, Channel 2
>         Progress Ind i = 0x8381 - Call not end-to-end ISDN, may have
in-
> band
> inf
> o
>         Calling Party Number i = 0x00C3, N/A
>                 Plan:Unknown, Type:Unknown
>         Called Party Number i = 0x81, '0118659128803736'
>                 Plan:ISDN, Type:Unknown
> Mar  8 21:17:53.121: ISDN Se0:23 Q921d: process_rxdata: Frame sent to
L2
> Mar  8 21:17:53.121: ISDN Se0:23 PACKET: L2IF_SendPkt:
>         source_id (0x200), state (0x0),
>         dest_id (0x20A), event (0x141),
>         sapi (0x0), ces (0x0), call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_pkt (0x1),
>         pkt (0x6249B958), msecs (0x0), priority (0xA)
> Mar  8 21:17:53.121: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(402B5358),
>  size (47) 0x020112120802000A05A104038090A218
> Mar  8 21:17:53.121:    03A983821E0283816C0200C370118130
> Mar  8 21:17:53.125:    313138363539313238383033373336
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: L2IF_SendPkt: Sending from L2
>         dest_id = 0, source_id = 512, prim = 141
>         priv_ln = 4, int_id = 1654303148
>   datastart = 402B5348, netstart = 402B5358, datasize = 63
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(402B5348),
>  size (63) 0x629AA9AC000002000141040000000800
> Mar  8 21:17:53.125:    020112120802000A05A104038090A218
> Mar  8 21:17:53.125:    03A983821E0283816C0200C370118130
> Mar  8 21:17:53.125:    313138363539313238383033373336
> Mar  8 21:17:53.125: ISDN  Q921d: isdn_from_driver_process:
event_count 1
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: handle_mail: received:
>         dest_id = 0, source_id = 512, prim = 141
>         priv_ln = 4, int_id = 1654303148, datasize = 63
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(402B5358),
>  size (63) 0x020112120802000A05A104038090A218
> Mar  8 21:17:53.125:    03A983821E0283816C0200C370118130
> Mar  8 21:17:53.125:    31313836353931323838303337333631
> Mar  8 21:17:53.125:    000000000000000000000000000000
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: handle_mail: received data =
> 0x0201121
> 20802000A05A104038090A218
> Mar  8 21:17:53.125:    03A983821E0283816C0200C370118130
> Mar  8 21:17:53.125:    313138363539313238383033373336
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: L2IF_SendprimPkt:
>         source_id (0x20A), state (0x7), dest_id (0x300), event
(0x241),
>         sapi (0x0), ces (0x1),  call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_p (0x1), pkt
> (0x634538B8),
> msec
> s (0x0), priority (0xA)
> Mar  8 21:17:53.125: ISDN Se0:23 PACKET: L2IF_SendPkt:
>         source_id (0x20A), state (0x7),
>         dest_id (0x300), event (0x241),
>         sapi (0x0), ces (0x1), call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_pkt (0x1),
>         pkt (0x626F6F4C), msecs (0x0), priority (0xA)
> Mar  8 21:17:53.129: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40543FA4),
>  size (43) 0x0802000A05A104038090A21803A98382
> Mar  8 21:17:53.129:    1E0283816C0200C37011813031313836
> Mar  8 21:17:53.129:    3539313238383033373336
> Mar  8 21:17:53.129: ISDN Se0:23 PACKET: L2IF_SendPkt: Sending from L2
>         dest_id = 0, source_id = 522, prim = 241
>         priv_ln = 4, int_id = 1654303148
>   datastart = 40543F94, netstart = 40543FA4, datasize = 59
> Mar  8 21:17:53.129: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40543F94),
>  size (59) 0x629AA9AC0000020A024104EF00010800
> Mar  8 21:17:53.129:    0802000A05A104038090A21803A98382
> Mar  8 21:17:53.129:    1E0283816C0200C37011813031313836
> Mar  8 21:17:53.129:    3539313238383033373336
> Mar  8 21:17:53.129: ISDN Se0:23 Q921d: srl_send_l2_pak:
>         source_id = Q.921, dest_id = Q.931, prim = DL_DATA_IND
>         priv_len = 4 int_id = 0x629AA9AC datasize = 59
> Mar  8 21:17:53.129: ISDN Se0:23 Q921d: data =
> 0x629AA9AC00000000024104EF000108
> 00
> Mar  8 21:17:53.129:    0802000A05A104038090A21803A98382
> Mar  8 21:17:53.129:    1E0283816C0200C37011813031313836
> Mar  8 21:17:53.129:    3539313238383033373336
> Mar  8 21:17:53.129: ISDN Se0:23 BACKHAUL: L3IF_rx_L2_pak: received
data
> 0x08020
> 00A05A104038090A21803A98382
> Mar  8 21:17:53.129:    1E0283816C0200C37011813031313836
> Mar  8 21:17:53.129:    3539313238383033373336
> Mar  8 21:17:53.129: ISDN Se0:23 LIFd: LIF_StartTimer: timer
(0x62A7E468),
> ticks
>  (30000), event (0x1250)
> Mar  8 21:17:53.129: ISDN Se0:23 PACKET: L2IF_SendprimPkt:
>         source_id (0x20A), state (0x7), dest_id (0x200), event
(0x140),
>         sapi (0x0), ces (0x1),  call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_p (0x1), pkt
> (0x628EB928),
> msec
> s (0x0), priority (0xA)
> Mar  8 21:17:53.133: ISDN Se0:23 PACKET: L2IF_SendPkt:
>         source_id (0x20A), state (0x7),
>         dest_id (0x200), event (0x140),
>         sapi (0x0), ces (0x1), call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_pkt (0x1),
>         pkt (0x626F6658), msecs (0x0), priority (0xA)
> Mar  8 21:17:53.133: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40543C14),
>  size (4) 0x02010114
> Mar  8 21:17:53.133: ISDN Se0:23 PACKET: L2IF_SendPkt: Sending from L2
>         dest_id = 0, source_id = 522, prim = 140
>         priv_ln = 4, int_id = 1654303148
>   datastart = 40543C04, netstart = 40543C14, datasize = 20
> Mar  8 21:17:53.133: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40543C04),
>  size (20) 0x629AA9AC0000020A014004EF00010800
> Mar  8 21:17:53.133:    02010114
> Mar  8 21:17:53.133: ISDN  Q921d: isdn_l2d_srq_process: QUEUE_EVENT
> Mar  8 21:17:53.133: ISDN Se0:23 PACKET: handle_l2d_srq_mail:
received:
>         dest_id = 0, source_id = 522, prim = 140
>         priv_ln = 4, int_id = 1654303148, datasize = 4
>         line_status[0] = IF_ACTIVE
> Mar  8 21:17:53.133: ISDN Se0:23 Q921f: User TX -> 0x02010114
> Mar  8 21:17:53.133: ISDN Se0:23 Q921: User TX -> RR sapi=0 tei=0
nr=10
> Mar  8 21:17:53.133: ISDN  Q921d: isdn_l2d_srq_process: event_count 1
> Mar  8 21:17:53.133: ISDN Se0:23 Q931d: L3_Go: source = 0x20A, event =
> 0x241, ca
> ll id = 0x0, int id = 0x0
> Mar  8 21:17:53.133: ISDN Se0:23 Q931d: L3_Go: call_id 0xA cr 0x800A
state
> 0
> eve
> nt 0x5 ces 1
> Mar  8 21:17:53.133: ISDN Se0:23 Q931d: L3_ProcessEvent: callref =
0x800A
> SETUP:
> U0_Setup(nlcb)
> Mar  8 21:17:53.133: ISDN Se0:23 Q931d: L3_state_change: callref
0x800A
> old
> NULL
> _STATE, new CALL_PRESENT
> Mar  8 21:17:53.137: ISDN Se0:23 CC: CCPRI_Go: source id 0x300, call
id
> 0xA,
> eve
> nt 0x341 (pre-ccb recovery)
> Mar  8 21:17:53.137: ISDN Se0:23 CC: CCPRI_Go: call id 0x0 cref 0xA
event
> 0x800A
>  Source->L3
> Mar  8 21:17:53.137: ISDN Se0:23 CC: CCPCC_CallIdle: event 0x90 b
channel
> 0
> nfas
>  int_id 0 call_id 0xA
> Mar  8 21:17:53.137: ISDN Se0:23 CC: CCPRI_AcceptChanId: Negotiated
int_id
> 0
> bch
> an 0 cref 0x800A call_id 0x000A lo_chan 2 final int_id/bchan 0/2 cause
0
> Mar  8 21:17:53.137: ISDN Se0:23 TGRM: get_tgrm_avail_state: idb
> 0x629AA9AC
> bcha
> n 2 service_state 0 call_state 2 false busy 0x0 dsl 0
> Mar  8 21:17:53.137: ISDN Se0:23 TGRM: update_tgrm_call_status: idb
> 0x629AA9AC b
> chan 2 availability state 1 call state(prev,new) (0,2), dsl 0
> Mar  8 21:17:53.137: ISDN Se0:23 TGRM: update_tgrm_call_status:
Calling
> TGRM
> wit
> h tgrm_call_isdn_update: idb 0x629AA9AC bchan 2 call state 1 call type
2
> call di
> r 1
> Mar  8 21:17:53.137: ISDN Se0:23 EVENT: process_rxstate: ces/callid
1/0xA
> callty
> pe 2 CALL_INCOMING
> Mar  8 21:17:53.137: ISDN Se0:23 PACKET: process_rxstate:
> 0x4C0001000A200404000
> 0100218042103
> Mar  8 21:17:53.137:    02007012000130313138363539313238
> Mar  8 21:17:53.137:    383033373336A104038090A21803A983
> Mar  8 21:17:53.137:    821E0283816C0200C370118130313138
> Mar  8 21:17:53.137:    363539313238383033373336
> Mar  8 21:17:53.137: ISDN Se0:23 EVENTd: calltrkr_incoming_call:
> call_id=0xA
> Mar  8 21:17:53.141: ISDN Se0:23 EVENTd: calltrkr_setup_received:
> isdn_info=1654
> 336212l, call_id=0xA ANSWER
> Mar  8 21:17:53.141: ISDN Se0:23 EVENTd: calltrkr_setup_received:
> calltracker di
> sabled
> Mar  8 21:17:53.141: ISDN Se0:23 EVENTd: calltrkr_setup_received:
> isdn_info=1653
> 301952l, call_id=0xA ANSWER
> Mar  8 21:17:53.141: ISDN Se0:23 EVENTd: call_incoming: b channel 1,
call
> type i
> s VOICE ULAW
> Mar  8 21:17:53.141: ISDN Se0:23 **ERROR**: call_incoming: Received a
call
> id 0x
> A with a bad bearercap from <unknown> on b channel 2
> Mar  8 21:17:53.141: ISDN Se0:23 CC: process_rejectcall: call_id
0x000A,
> cause 0
> x3A, call_type 0x2
> Mar  8 21:17:53.141: ISDN Se0:23 EVENTd: calltrkr_call_cleared:
> isdn_info=0x628B
> 62C0, call_id=0xA
> Mar  8 21:17:53.141: ISDN Se0:23 EVENTd: calltrkr_call_cleared:
> isdn_info=0x629B
> 2AD4, call_id=0xA
> Mar  8 21:17:53.141: ISDN Se0:23 CC: CCPRI_Go: source id 0x500, call
id
> 0x0,
> eve
> nt 0x4F (pre-ccb recovery)
> Mar  8 21:17:53.141: ISDN Se0:23 CC: CCPRI_Go: call_id 0xA cref 0x800A
> event
> 0x4
> F Source->HOST
> Mar  8 21:17:53.141: ISDN Se0:23 CC: CCPCC_CallOffered: event = 0x4F b
> channel 2
>  nfas int_id 0 call_id 0xA
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: CC_CHAN_GetUserpri: using
call_id
> =
> 0xA
> Mar  8 21:17:53.145: ISDN Se0:23 CCd: CC_CHAN_ReleaseChanpri: channel
2
> Mar  8 21:17:53.145: ISDN Se0:23 TGRM: get_tgrm_avail_state: idb
> 0x629AA9AC
> bcha
> n 2 service_state 0 call_state 0 false busy 0x0 dsl 0
> Mar  8 21:17:53.145: ISDN Se0:23 TGRM: update_tgrm_call_status: idb
> 0x629AA9AC b
> chan 2 availability state 1 call state(prev,new) (2,0), dsl 0
> Mar  8 21:17:53.145: ISDN Se0:23 TGRM: update_tgrm_call_status:
Calling
> TGRM
> wit
> h tgrm_call_isdn_update: idb 0x629AA9AC bchan 2 call state 0 call type
0
> call di
> r 1
> Mar  8 21:17:53.145: ISDN  EVENTd: cc_clear_free_list freed 0x63445548
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: L3_Go: source = 0x400, event =
> 0x340, ca
> ll id = 0xA, int id = 0x0
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: L3_Go: call_id 0xA cr 0x800A
state
> 6
> eve
> nt 0x82 ces 1
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: L3_ProcessEvent: callref =
0x800A
> CC_SET
> UP_REJ_REQ:U6_SetupRejReq(nlcb)
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: srl_send_l3_pak:
>         source_id = Q.931, dest_id = Q.921, prim = DL_DATA_REQ
>         priv_len = 4 int_id = 0x629AA9AC datasize = 25
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: data =
> 0x629AA9AC00000300024004EF000108
> 00
> Mar  8 21:17:53.145:    0802800A5A080280BA
> Mar  8 21:17:53.145: ISDN Se0:23 Q931d: L3_state_change: callref
0x800A
> old
> CALL
> _PRESENT, new NULL_STATE
> Mar  8 21:17:53.145: ISDN Se0:23 EVENT: process_rxstate: ces/callid
1/0xA
> callty
> pe 2 CALL_CLEARED
> Mar  8 21:17:53.145: ISDN Se0:23 PACKET: process_rxstate:
0x570001000A00
> Mar  8 21:17:53.149: ISDN Se0:23 EVENTd: calltrkr_call_cleared:
> isdn_info=0x629B
> 2AD4, call_id=0xA
> Mar  8 21:17:53.149: ISDN Se0:23 EVENTd: calltrkr_call_cleared:
> isdn_info=0x628B
> 62C0, call_id=0xA
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: handle_mail: received:
>         dest_id = 0, source_id = 768, prim = 240
>         priv_ln = 4, int_id = 1654303148, datasize = 25
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40544204),
>  size (25) 0x0802800A5A080280BA11F66840806A02
> Mar  8 21:17:53.149:    E0000129D19806B600
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: handle_mail: received data =
> 0x0802800
> A5A080280BA
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: L2IF_SendprimPkt:
>         source_id (0x20A), state (0x7), dest_id (0x200), event
(0x140),
>         sapi (0x0), ces (0x1),  call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_p (0x0), pkt
> (0x628EB9AC),
> msec
> s (0x0), priority (0xA)
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: L2IF_SendPkt:
>         source_id (0x20A), state (0x7),
>         dest_id (0x200), event (0x140),
>         sapi (0x0), ces (0x1), call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_pkt (0x0),
>         pkt (0x626F931C), msecs (0x0), priority (0xA)
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40544DE4),
>  size (13) 0x000112140802800A5A080280BA
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: L2IF_SendPkt: Sending from L2
>         dest_id = 0, source_id = 522, prim = 140
>         priv_ln = 4, int_id = 1654303148
>   datastart = 40544DD4, netstart = 40544DE4, datasize = 29
> Mar  8 21:17:53.149: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(40544DD4),
>  size (29) 0x629AA9AC0000020A014004EF00010800
> Mar  8 21:17:53.149:    000112140802800A5A080280BA
> Mar  8 21:17:53.149: ISDN Se0:23 LIFd: LIF_StartTimer: timer
(0x6290BB1C),
> ticks
>  (1000), event (0x1240)
> Mar  8 21:17:53.149: ISDN  Q921d: isdn_l2d_srq_process: QUEUE_EVENT
> Mar  8 21:17:53.153: ISDN Se0:23 PACKET: handle_l2d_srq_mail:
received:
>         dest_id = 0, source_id = 522, prim = 140
>         priv_ln = 4, int_id = 1654303148, datasize = 13
>         line_status[0] = IF_ACTIVE
> Mar  8 21:17:53.153: ISDN Se0:23 Q921f: User TX ->
> 0x000112140802800A5A080280BA
> Mar  8 21:17:53.153: ISDN Se0:23 Q921: User TX -> INFO sapi=0 tei=0,
ns=9
> nr=10
> Mar  8 21:17:53.153: ISDN Se0:23 Q931: RELEASE_COMP pd = 8  callref =
> 0x800A
>         Cause i = 0x80BA - Bearer capability not available
> Mar  8 21:17:53.153: ISDN  Q921d: isdn_l2d_srq_process: event_count 1
> Mar  8 21:17:53.161: ISDN  Q921d: isdn_from_driver_process:
QUEUE_EVENT
> Mar  8 21:17:53.161: ISDN Se0:23 Q921f: User RX <- 0x00010114
> Mar  8 21:17:53.161: ISDN Se0:23 Q921: User RX <- RR sapi=0 tei=0
nr=10
> Mar  8 21:17:53.161: ISDN Se0:23 Q921d: process_rxdata: Frame sent to
L2
> Mar  8 21:17:53.161: ISDN Se0:23 PACKET: L2IF_SendPkt:
>         source_id (0x200), state (0x0),
>         dest_id (0x20A), event (0x141),
>         sapi (0x0), ces (0x0), call_id (0x0),
>         chan_id (0x0), int_id (0x629AA9AC), free_pkt (0x1),
>         pkt (0x6249B65C), msecs (0x0), priority (0xA)
> Mar  8 21:17:53.161: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(402B4C90),
>  size (4) 0x00010114
> Mar  8 21:17:53.161: ISDN Se0:23 PACKET: L2IF_SendPkt: Sending from L2
>         dest_id = 0, source_id = 512, prim = 141
>         priv_ln = 4, int_id = 1654303148
>   datastart = 402B4C80, netstart = 402B4C90, datasize = 20
> Mar  8 21:17:53.161: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(402B4C80),
>  size (20) 0x629AA9AC000002000141040000000800
> Mar  8 21:17:53.161:    00010114
> Mar  8 21:17:53.161: ISDN  Q921d: isdn_from_driver_process:
event_count 1
> Mar  8 21:17:53.161: ISDN Se0:23 PACKET: handle_mail: received:
>         dest_id = 0, source_id = 512, prim = 141
>         priv_ln = 4, int_id = 1654303148, datasize = 20
> Mar  8 21:17:53.161: ISDN Se0:23 PACKET: L2IF_DispPak: packet -
> start(402B4C90),
>  size (20) 0x00010114000000000000000000000000
> Mar  8 21:17:53.161:    00000000
> Mar  8 21:17:53.165: ISDN Se0:23 PACKET: handle_mail: received data =
> 0x0001011
> 4
> Mar  8 21:17:53.165: ISDN Se0:23 LIFd: LIF_StartTimer: timer
(0x62A7E468),
> ticks
>  (30000), event (0x1250)
> 
> ---
> [This E-mail scanned for viruses by Declude Virus]
> 
> _______________________________________________
> cisco-nsp mailing list  cisco-nsp at puck.nether.net
> https://puck.nether.net/mailman/listinfo/cisco-nsp
> archive at http://puck.nether.net/pipermail/cisco-nsp/



More information about the cisco-nsp mailing list