[c-nsp] Cisco Juniper PPPoE forwarding via L2TP

[Junaid]

Hi,

Can anyone guide me to some resource for troubleshooting cisco/juniper
interoperability issues. Specifically, I am trying to forward my PPPoE
requests from a Cisco BRAS to Juniper BRAS (ERX with Juneos 7.2.1) using
L2TP. L2TP tunnel comes up but it seems that LCP negotiation fails. I am
using local authentication and authorization - no RADIUS server involved. I
will highly appreciate any help. Debug logs from both routers are as
follows:



Cisco (acting as LAC)
Aug 26 14:25:46: [230]PPPoE 230: Connected Forwarded
Aug 26 14:25:46: ppp230 PPP: Process pending ncp packets
Aug 26 14:25:46: uid:230 Tnl/Sn 49513/123 L2TP: Result code(4): 4: Call
failed, not enough resources (temporary)
Aug 26 14:25:46:      Error code(4): Insufficient resources
Aug 26 14:25:46:      Optional msg: session no resources server port
Aug 26 14:25:46: uid:230 Tnl/Sn 49513/123 L2TP: I CDN from ERX-42-48-33 tnl
2254, cl 32946
Aug 26 14:25:46: uid:230 Tnl/Sn 49513/123 L2TP: disconnect (L2X) IETF:
9/nas-error Ascend: 62/VPDN No Resources
Aug 26 14:25:46: uid:230 Tnl/Sn 49513/123 L2TP: Destroying session
Aug 26 14:25:46: uid:230 Tnl/Sn 49513/123 L2TP: Session state change from
established to idle
Aug 26 14:25:46: AAA/ACCT/EVENT/(00000124): NET DOWN
Aug 26 14:25:46:  Tnl 49513 L2TP: Tunnel state change from established to
no-sessions-left
Aug 26 14:25:46:  Tnl 49513 L2TP: No more sessions in tunnel, shutdown
(likely) in 15 seconds
Aug 26 14:25:46: [230]PPPoE 230: State CNCT_FWDED    Event SSS_DISCNCT

Juniper (acting as LNS)
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = message, length = 8, flags = M ~H
NOTICE 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64/65): Changing
ifOperStatus from LowerLayerDown to Down
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = closeDown, event = up, next state = closed
NOTICE 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64/65): Changing
effective adminState from disabled to enabled
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = closed, event = open, next state = idle
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = assignedSessionId, length = 8, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = callSerialNumber, length = 10, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = bearerType, length = 10, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = vendor (0x0009) type (0x0064), length = 15, flags = ~M ~H
NOTICE 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64/65): Error in
incoming icrq from vr default, remote address 172.16.40.39 - invalid
non-mandatory AVP (l2tp session receive icrq avp bad value cisco nas port)
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = idle, event = icrq, next state = txIcrp
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = message, length = 8, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = assignedSessionId, length = 8, flags = M ~H
NOTICE 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64/65): Changing
mibState from idle to connecting
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = txIcrp, event = txStarted, next state =
waitConnected
INFO 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): Processing
incoming in-sequence iccn from vr default, remote address 172.16.40.39 -
controlHeader.Ns = 3
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = message, length = 8, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = connectSpeed, length = 10, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = rxConnectSpeed, length = 10, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = framingType, length = 10, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = lastSentLcpConfReq, length = 20, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = lastReceivedLcpConfReq, length = 16, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = proxyAuthenId, length = 8, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = proxyAuthenName, length = 19, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = proxyAuthenResponse, length = 12, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = proxyAuthenType, length = 8, flags = ~M ~H
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = waitConnected, event = iccn, next state =
waitUpper
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = waitUpper, event = terminate, next state =
txCdnOpen
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = message, length = 8, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = assignedSessionId, length = 8, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = resultCode, length = 42, flags = M ~H
DEBUG 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64): AVP Header:
type = disconnectCause, length = 11, flags = ~M ~H
NOTICE 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64/65): Changing
mibState from connecting to disconnecting
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = txCdnOpen, event = reset, next state = txCdnOpen
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = txCdnOpen, event = txComplete, next state =
resetIdle
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = resetIdle, event = reset, next state = idle
NOTICE 08/26/2007 03:47:37 l2tp (interface TUNNEL l2tp:2/64/65): Changing
mibState from disconnecting to idle
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = idle, event = dying, next state = dying
DEBUG 08/26/2007 03:47:37 l2tpStateMachine (interface TUNNEL l2tp:2/64/65):
lnsIncomingSession: state = dying, event = dead, next state = dead


Regards,
Junaid.