[nsp] 56k/112K BRI through Cisco 1004? (edited)

Greg Goodknight good at nccn.net
Sun Jan 11 20:01:36 EST 2004


I've been having a devil of a time getting a BRI ISDN service established using an available Cisco 1004 router. It's running a 12.1(16) image. I hope this is an appropriate list to request this help. Another less edited message may still be awaiting the moderator's blessing due to size, I've redited it and request he trash the old one.
 
After screwing around for a couple of days after the initial line install, an SBC tech informed me on Friday that the layer 2 had been activated but it would be 56K/112K service, not a full BRI data rate. The tech knew no details; I assume the LSB is either hosed or lost in translation. There is a fiber optic termination about one mile away; it is unclear to me whether the 56K limitation is due to that terminal or the switch it is associated with. I can demand 128K service but it will take a bit longer for them to provision a copper pair from the CO. 

It is unclear to me whether my failure to connect is due to this issue or not. I've set bandwidth to 56 but that does not seem to change the connect type. In the good old days I'd just pull a task branch and look at the code before asking....

The ISDN status, a section of debug all output and some of the config follow. The call is precipitated by a ping to cisco.com, 198.133.219.25, from the local address 192.168.0.132. The 1004 is at 192.168.0.134. 
 
Thanks in advance for any and all help!
-Greg in Nevada City, California

PS Yes, the router thinks it's March 1st


good_router#sho is st
Global ISDN Switchtype = basic-ni
ISDN BRI0 interface
        dsl 0, interface ISDN Switchtype = basic-ni
    Layer 1 Status:
        ACTIVE
    Layer 2 Status:
        TEI = 86, Ces = 1, SAPI = 0, State = MULTIPLE_FRAME_ESTABLISHED
        TEI = 87, Ces = 2, SAPI = 0, State = MULTIPLE_FRAME_ESTABLISHED
        TEI 86, ces = 1, state = 5(init)
            spid1 configured, spid1 sent, spid1 valid
            Endpoint ID Info: epsf = 0, usid = 70, tid = 1
        TEI 87, ces = 2, state = 5(init)
            spid2 configured, spid2 sent, spid2 valid
            Endpoint ID Info: epsf = 0, usid = 71, tid = 1
    Layer 3 Status:
        0 Active Layer 3 Call(s)
    Active dsl 0 CCBs = 0
    The Free Channel Mask:  0x80000003
    Number of L2 Discards = 0, L2 Session ID = 15
    Total Allocated ISDN CCBs = 0
good_router#
*Mar  1 15:12:42.048: IP: NAT enab = 1 trans = 0 flags = 80
*Mar  1 15:12:42.052: NAT: dialer not up for BRI0, no translation, dial and drop

*Mar  1 15:12:42.060: BR0 DDR: ip (s=192.168.0.132, d=198.133.219.25), 60 bytes,
 outgoing interesting (ip PERMIT)
*Mar  1 15:12:42.064: DDR: 4500003C 7AE00000 7F015E15 C0A80084 C685DB19 0800EE5B

*Mar  1 15:12:42.088: DDR: 02005D00 61626364 65666768 696A6B6C 6D6E6F70 71727374

*Mar  1 15:12:42.119: BR0 DDR: Dialing cause ip (s=192.168.0.132, d=198.133.219.
25)
*Mar  1 15:12:42.123: BRI0:  2 total links, 0 active links
*Mar  1 15:12:42.123: BR0 DDR: Creating holdq 25AE9F8
*Mar  1 15:12:42.127: BR0 DDR: Attempting to dial 2721037
*Mar  1 15:12:42.131: ISDN BR0: Outgoing call id = 0x803A, dsl 0
*Mar  1 15:12:42.135: BR0 BAP: Get connect id 0
*Mar  1 15:12:42.135: DDR: Assigning holdq 25AE9F8 to 25AEAE0
*Mar  1 15:12:42.139: BR0 DDR: Increment call, 0
*Mar  1 15:12:42.143: IP: s=192.168.0.132 (Ethernet0), d=198.133.219.25 (BRI0),
len 60, encapsulation failed

XXX Greg> IP encapsulation failed?

*Mar  1 15:12:42.151: ISDN BR0: Event: Call to 2721037 at 64 Kb/s
*Mar  1 15:12:42.155: ISDN BR0: process_bri_call(): call id 0x803A, called_numbe
r 2721037, speed 64, call type DATA

XXX Greg> speed 64, anyone know if this is a problem?


*Mar  1 15:12:42.159: ISDN BR0: CCBRI_Go: source id 0x500, state 0, call id 0x0,
 event 0x1
*Mar  1 15:12:42.163: CC_CHAN_GetIdleChanbri: dsl 0
*Mar  1 15:12:42.167:     Found idle channel B1
*Mar  1 15:12:42.171: in L3_Go: source = 0x400, event = 0x340, dsl = 0, call id
= 0x803A, int id = 0x0
*Mar  1 15:12:42.175: Entering L3_GetInfo
*Mar  1 15:12:42.179: L3_Go default, the event = 80
*Mar  1 15:12:42.183:  L3_GetUser_NLCB nlcb 270C3B8 ces 0 state 31 callid 0
*Mar  1 15:12:42.183:  L3_GetUser_NLCB nlcb 26C8F48 ces 1 state 0 callid 0
*Mar  1 15:12:42.187:  L3_GetUser_NLCB nlcb 2603F78 ces 2 state 0 callid 0
*Mar  1 15:12:42.191: L3_GetUser_NLCB dsl 0 nlcb 0
*Mar  1 15:12:42.195: L3_Go NLCB is 26C8F48 ignore_msg is 0
*Mar  1 15:12:42.195: entering valid_ie_contents in l3_sdl_u
*Mar  1 15:12:42.199: valid_ie_contents cur is 26036B4 end is 26036C4
*Mar  1 15:12:42.203:  var ie cur is 80....
*Mar  1 15:12:42.203:  var ie bear cap num....
*Mar  1 15:12:42.207:  var ie cur is 80....
*Mar  1 15:12:42.211:  var ie cur is 80....
*Mar  1 15:12:42.211:  var ie bunch of others and then some...
*Mar  1 15:12:42.215: exiting valid_ie_contents with TRUE.
*Mar  1 15:12:42.219: L3_Go FREE Incoming Packet
*Mar  1 15:12:42.223:  L2_Go(): DSL_Id=0, SAPI=0, CES=1, Event=240
*Mar  1 15:12:42.227:  in L2_Go source_id is 300
*Mar  1 15:12:42.231:  in L2_Go at bailout DLCB is  25FC800
*Mar  1 15:12:42.231:  in L2_Go going to process event
*Mar  1 15:12:42.234:  in L2_FindEventIndex
*Mar  1 15:12:42.238:  in L2_ProcessEvent
*Mar  1 15:12:42.238:  in S78_DL_DATA_REQ
*Mar  1 15:12:42.242:  in L2_Queue
*Mar  1 15:12:42.242:  in L2_FindEventIndex
*Mar  1 15:12:42.246:  in L2_ProcessEvent
*Mar  1 15:12:42.250:  in S7_I_FRAME_QUEUED_UP
*Mar  1 15:12:42.250:  Sending data on BRI/PRI 0 to 200
*Mar  1 15:12:42.254: Recvd from L2 ISDN BR0: state 1
*Mar  1 15:12:42.258: ISDN BR0: trigger_calling_called_debug, dsl 0, callref 0x3
A,  outgoing TRUEBRI: tp3420_write_sid: command = 0xE

XXX SNIPped some lines, host connects

*Mar  1 15:12:43.040: ISDN BR0: CCBRI_Go: source id 0x300, state 3, call id 0x80
3A, event 0x341
*Mar  1 15:12:43.048:   entering process_rxstate, dsl 0 call_id 0x803A
*Mar  1 15:12:43.052:    info [0-60]= 0x4 0x0 0x1 0x80 0x3A 0x4 0x18 0x2 0x1 0x1
 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
*Mar  1 15:12:43.119: ISDN BR0: received HOST_CONNECT call_id 0x803A
*Mar  1 15:12:43.119: ISDN BR0: isdn report  callid 0x803ABRI: enable channel B1

BRI: tp3420_write_sid: command = 0x14

15:20:04: %LINK-3-UPDOWN: Interface BRI0:1, changed state to up
*Mar  1 15:12:43.147: DDR: Assigning holdq 25AE9F8 to 25F9BCE
*Mar  1 15:12:43.147: DDR: starting dialer holdq timer
*Mar  1 15:12:43.167: BRI 0 B1: Set bandwidth to 64Kb

*Mar  1 15:12:43.167: ISDN BR0: Event: Connected to 2721037 on B1 at 64 Kb/s
*Mar  1 15:12:43.175: ISDN BR0:  Frame sent to L2
*Mar  1 15:12:43.179:  L2_Go(): DSL_Id=0, SAPI=0, CES=0, Event=141
*Mar  1 15:12:43.179:  in L2_Go source_id is 200
*Mar  1 15:12:43.183:  in L2_Go at bailout DLCB is  25FC800
*Mar  1 15:12:43.187:  in L2_Go going to process event
*Mar  1 15:12:43.187:  in L2_FindEventIndex
*Mar  1 15:12:43.191:  in L2_ProcllessEvent
*Mar  1 15:12:43.195:  in S7_REJ_RNR_RR
*Mar  1 15:12:43.195:  in L2_ValidNR
*Mar  1 15:12:43.199:  in L2_AdvanceVA(discard=0)
*Mar  1 15:12:43.199:  in S7_REJ_RNR_RR stop 200 start 203
*Mar  1 15:12:43.290: IP: NAT enab = 1 trans = 0 flags = 80
*Mar  1 15:12:43.298: IP: s=192.168.0.1 (Ethernet0), d=192.168.0.255, len 78, di
spose udp.noport
*Mar  1 15:12:43.413: IP: NAT enab = 1 trans = 0 flags = 80
*Mar  1 15:12:43.417: NAT: dialer not up for BRI0, no translation, dial and drop

*Mar  1 15:12:43.421: BR0 DDR: ip (s=192.168.0.132, d=198.133.219.25), 60 bytes,
 outgoing interesting (ip PERMIT)

XXX what might be a ping gets sent:
*Mar  1 15:12:43.425: DDR: 4500003C 7AE90000 7F015E0C C0A80084 C685DB19 0800ED5B

*Mar  1 15:12:43.453: DDR: 02005E00 61626364 65666768 696A6B6C 6D6E6F70 71727374

*Mar  1 15:12:43.476: IP: s=192.168.0.132 (Ethernet0), d=198.133.219.25 (BRI0),
len 60, encapsulation failed

XXX another encapsulation failed?

*Mar  1 15:12:44.413: IP: NAT enab = 1 trans = 0 flags = 80
*Mar  1 15:12:44.417: NAT: dialer not up for BRI0, no translation, dial and drop

*Mar  1 15:12:44.425: BR0 DDR: ip (s=192.168.0.132, d=198.133.219.25), 60 bytes,
 outgoing interesting (ip PERMIT)
*Mar  1 15:12:44.429: DDR: 4500003C 7AEA0000 7F015E0B C0A80084 C685DB19 0800EC5B

*Mar  1 15:12:44.453: DDR: 02005F00 61626364 65666768 696A6B6C 6D6E6F70 71727374

*Mar  1 15:12:44.480: IP: s=192.168.0.132 (Ethernet0), d=198.133.219.25 (BRI0),
len 60, encapsulation failed
*Mar  1 15:12:45.413: IP: NAT enab = 1 trans = 0 flags = 80
*Mar  1 15:12:45.417: NAT: dialer not up for BRI0, no translation, dial and drop

*Mar  1 15:12:45.425: BR0 DDR: ip (s=192.168.0.132, d=198.133.219.25), 60 bytes,
 outgoing interesting (ip PERMIT)
*Mar  1 15:12:45.429: DDR: 4500003C 7AEB0000 7F015E0A C0A80084 C685DB19 0800EB5B

*Mar  1 15:12:45.453: DDR: 02006000 61626364 65666768 696A6B6C 6D6E6F70 71727374

*Mar  1 15:12:45.480: IP: s=192.168.0.132 (Ethernet0), d=198.133.219.25 (BRI0),
len 60, encapsulation failed
*Mar  1 15:12:48.218: ISDN BR0:  Fra
All possible debugging has been turned off
good_router#

XXX more got snipped by me

15:20:24: %ISDN-6-DISCONNECT: Interface BRI0:1  disconnected from 2721037 , cal


!
isdn switch-type basic-ni
!
!
!
interface Ethernet0
 ip address 192.168.0.134 255.255.255.0
 ip nat inside
!
interface BRI0
 bandwidth 56
 ip address negotiated
 ip nat outside
 encapsulation ppp
 no keepalive
 dialer idle-timeout 720
 dialer string 2721037
 dialer hold-queue 20
 dialer load-threshold 1 either
 dialer-group 1
 isdn switch-type basic-ni
 isdn spid1 AAABBBBBBB0101 BBBBBBB
 isdn spid2 AAACCCCCCC0101 CCCCCCC
 no peer default ip address
 no fair-queue
 no cdp enable
 ppp authentication chap
 ppp chap hostname myLogin
 ppp chap password myPassword
 ppp multilink
!


More information about the cisco-nsp mailing list