[c-nsp] Multilink problems

james edwards hackerwacker at cybermesa.com
Tue Dec 13 17:41:27 EST 2005


I'm turning up a mlppp link to Payadyne IP DSLAM at very remote field
connection point, starting with one T-1, but I have configed mlppp so it
will be hitless to add another T-1. The T-1 controller 2/0 and  Serial2/0:0
are up but Multilink1 will not come up. T-1 passes BERT 0's, 1's, and quasi
tests, from the router's PA-8T1 card to the NIU. I suspect the problem is on
the DSLAM config; could y'all take a look at the config and debug and give
me so ideas ?
Paradyne suggested the MTU 1600.



!
interface Multilink1
 mtu 1600
 no ip address
 no cdp enable
 ppp bridge ip
 ppp multilink
 ppp multilink links minimum 1
 no ppp multilink fragmentation
 multilink-group 1
 bridge-group 10
!
!
interface Serial2/0:0
 mtu 1524
 no ip address
 encapsulation ppp
 tx-ring-limit 16384
 no fair-queue
 no cdp enable
 ppp multilink
 multilink-group 1
!
!
interface BVI10
 mtu 1600
 ip address 10.0.0.1 255.255.255.0
 ip helper-address 10.0.1.1
!
bridge 10 protocol ieee
bridge 10 route ip
!

Debug of ppp/multilink events & errors:

Dec 13 14:58:42 65.19.28.1 609: Dec 13 14:58:42.266 MST: Se2/0:0 LCP: I
CONFREQ [Open] id 31 len 18
Dec 13 14:58:42 65.19.28.1 610: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
ACFC (0x0802)
Dec 13 14:58:42 65.19.28.1 611: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:    PFC
(0x0702)
Dec 13 14:58:42 65.19.28.1 612: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:42 65.19.28.1 613: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
MagicNumber 0x745CDE00 (0x0506745CDE00)
Dec 13 14:58:42 65.19.28.1 614: Dec 13 14:58:42.266 MST: Se2/0:0 BNCP: State
is Closed
Dec 13 14:58:42 65.19.28.1 615: Dec 13 14:58:42.266 MST: Se2/0:0 BACP: State
is Closed
Dec 13 14:58:42 65.19.28.1 616: Dec 13 14:58:42.266 MST: Se2/0:0 MLP: BAP
down, link not multilink capable
Dec 13 14:58:42 65.19.28.1 617: Dec 13 14:58:42.266 MST: Se2/0:0 PPP: Phase
is TERMINATING
Dec 13 14:58:42 65.19.28.1 618: Dec 13 14:58:42.266 MST: Se2/0:0 PPP: Phase
is ESTABLISHING
Dec 13 14:58:42 65.19.28.1 619: Dec 13 14:58:42.266 MST: Se2/0:0 LCP: O
CONFREQ [Open] id 129 len 31
Dec 13 14:58:42 65.19.28.1 620: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:42 65.19.28.1 621: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
MagicNumber 0x39CEB0DC (0x050639CEB0DC)
Dec 13 14:58:42 65.19.28.1 622: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
MRRU 1524 (0x110405F4)
Dec 13 14:58:42 65.19.28.1 623: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
EndpointDisc 1 SFcolo-dsl (0x130D015346636F6C6F2D64736C)
Dec 13 14:58:42 65.19.28.1 624: Dec 13 14:58:42.266 MST: Se2/0:0 LCP: O
CONFACK [Open] id 31 len 18
Dec 13 14:58:42 65.19.28.1 625: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
ACFC (0x0802)
Dec 13 14:58:42 65.19.28.1 626: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:    PFC
(0x0702)
Dec 13 14:58:42 65.19.28.1 627: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:42 65.19.28.1 628: Dec 13 14:58:42.266 MST: Se2/0:0 LCP:
MagicNumber 0x745CDE00 (0x0506745CDE00)
Dec 13 14:58:42 65.19.28.1 629: Dec 13 14:58:42.270 MST: Se2/0:0 LCP: I
CONFREJ [ACKsent] id 129 len 8
Dec 13 14:58:42 65.19.28.1 630: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:
MRRU 1524 (0x110405F4)
Dec 13 14:58:42 65.19.28.1 631: Dec 13 14:58:42.270 MST: Se2/0:0 LCP: O
CONFREQ [ACKsent] id 130 len 27
Dec 13 14:58:42 65.19.28.1 632: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:42 65.19.28.1 633: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:
MagicNumber 0x39CEB0DC (0x050639CEB0DC)
Dec 13 14:58:42 65.19.28.1 634: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:
EndpointDisc 1 SFcolo-dsl (0x130D015346636F6C6F2D64736C)
Dec 13 14:58:42 65.19.28.1 635: Dec 13 14:58:42.270 MST: Se2/0:0 LCP: I
CONFACK [ACKsent] id 130 len 27
Dec 13 14:58:42 65.19.28.1 636: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:42 65.19.28.1 637: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:
MagicNumber 0x39CEB0DC (0x050639CEB0DC)
Dec 13 14:58:42 65.19.28.1 638: Dec 13 14:58:42.270 MST: Se2/0:0 LCP:
EndpointDisc 1 SFcolo-dsl (0x130D015346636F6C6F2D64736C)
Dec 13 14:58:42 65.19.28.1 639: Dec 13 14:58:42.270 MST: Se2/0:0 LCP: State
is Open
Dec 13 14:58:42 65.19.28.1 640: Dec 13 14:58:42.270 MST: Se2/0:0 PPP: Phase
is FORWARDING, Attempting Forward
Dec 13 14:58:42 65.19.28.1 641: Dec 13 14:58:42.270 MST: Se2/0:0 PPP: Queue
BNCP code[1] id[140]
Dec 13 14:58:42 65.19.28.1 642: Dec 13 14:58:42.274 MST: Se2/0:0 PPP: Phase
is ESTABLISHING, Finish LCP
Dec 13 14:58:42 65.19.28.1 643: Dec 13 14:58:42.274 MST: Se2/0:0 PPP: Phase
is UP
Dec 13 14:58:42 65.19.28.1 644: Dec 13 14:58:42.274 MST: Se2/0:0 PPP:
Process pending packets
Dec 13 14:58:42 65.19.28.1 645: Dec 13 14:58:42.274 MST: Se2/0:0 BNCP:
Redirect packet to Se2/0:0
Dec 13 14:58:43 65.19.28.1 646: Dec 13 14:58:42.274 MST: Se2/0:0 BNCP: I
CONFREQ [Not negotiated] id 140 len 7
Dec 13 14:58:43 65.19.28.1 647: Dec 13 14:58:42.274 MST: Se2/0:0 BNCP:
Type8 (0x080301)
Dec 13 14:58:43 65.19.28.1 648: Dec 13 14:58:42.274 MST: Se2/0:0 LCP: O
PROTREJ [Open] id 131 len 13 protocol BNCP (0x8031018C0007080
301)
Dec 13 14:58:48 65.19.28.1 649: Dec 13 14:58:48.278 MST: Se2/0:0 LCP: I
CONFREQ [Open] id 32 len 18
Dec 13 14:58:48 65.19.28.1 650: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
ACFC (0x0802)
Dec 13 14:58:48 65.19.28.1 651: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:    PFC
(0x0702)
Dec 13 14:58:48 65.19.28.1 652: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:48 65.19.28.1 653: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
MagicNumber 0xAB1C2A00 (0x0506AB1C2A00)
Dec 13 14:58:48 65.19.28.1 654: Dec 13 14:58:48.278 MST: Se2/0:0 BNCP: State
is Closed
Dec 13 14:58:48 65.19.28.1 655: Dec 13 14:58:48.278 MST: Se2/0:0 BACP: State
is Closed
Dec 13 14:58:48 65.19.28.1 656: Dec 13 14:58:48.278 MST: Se2/0:0 MLP: BAP
down, link not multilink capable
Dec 13 14:58:48 65.19.28.1 657: Dec 13 14:58:48.278 MST: Se2/0:0 PPP: Phase
is TERMINATING
Dec 13 14:58:48 65.19.28.1 658: Dec 13 14:58:48.278 MST: Se2/0:0 PPP: Phase
is ESTABLISHING
Dec 13 14:58:48 65.19.28.1 659: Dec 13 14:58:48.278 MST: Se2/0:0 LCP: O
CONFREQ [Open] id 132 len 31
Dec 13 14:58:48 65.19.28.1 660: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:48 65.19.28.1 661: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
MagicNumber 0x39CEC859 (0x050639CEC859)
Dec 13 14:58:48 65.19.28.1 662: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
MRRU 1524 (0x110405F4)
Dec 13 14:58:48 65.19.28.1 663: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
EndpointDisc 1 SFcolo-dsl (0x130D015346636F6C6F2D64736C)
Dec 13 14:58:48 65.19.28.1 664: Dec 13 14:58:48.278 MST: Se2/0:0 LCP: O
CONFACK [Open] id 32 len 18
Dec 13 14:58:48 65.19.28.1 665: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
ACFC (0x0802)
Dec 13 14:58:48 65.19.28.1 666: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:    PFC
(0x0702)
Dec 13 14:58:48 65.19.28.1 667: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:48 65.19.28.1 668: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
MagicNumber 0xAB1C2A00 (0x0506AB1C2A00)
Dec 13 14:58:48 65.19.28.1 669: Dec 13 14:58:48.278 MST: Se2/0:0 LCP: I
CONFREJ [ACKsent] id 132 len 8
Dec 13 14:58:48 65.19.28.1 670: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
MRRU 1524 (0x110405F4)
Dec 13 14:58:48 65.19.28.1 671: Dec 13 14:58:48.278 MST: Se2/0:0 LCP: O
CONFREQ [ACKsent] id 133 len 27
Dec 13 14:58:48 65.19.28.1 672: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:48 65.19.28.1 673: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
MagicNumber 0x39CEC859 (0x050639CEC859)
Dec 13 14:58:48 65.19.28.1 674: Dec 13 14:58:48.278 MST: Se2/0:0 LCP:
EndpointDisc 1 SFcolo-dsl (0x130D015346636F6C6F2D64736C)
Dec 13 14:58:48 65.19.28.1 675: Dec 13 14:58:48.282 MST: Se2/0:0 LCP: I
CONFACK [ACKsent] id 133 len 27
Dec 13 14:58:48 65.19.28.1 676: Dec 13 14:58:48.282 MST: Se2/0:0 LCP:    MRU
1524 (0x010405F4)
Dec 13 14:58:48 65.19.28.1 677: Dec 13 14:58:48.282 MST: Se2/0:0 LCP:
MagicNumber 0x39CEC859 (0x050639CEC859)
Dec 13 14:58:48 65.19.28.1 678: Dec 13 14:58:48.282 MST: Se2/0:0 LCP:
EndpointDisc 1 SFcolo-dsl (0x130D015346636F6C6F2D64736C)
Dec 13 14:58:48 65.19.28.1 679: Dec 13 14:58:48.282 MST: Se2/0:0 LCP: State
is Open
Dec 13 14:58:48 65.19.28.1 680: Dec 13 14:58:48.282 MST: Se2/0:0 PPP: Phase
is FORWARDING, Attempting Forward
Dec 13 14:58:48 65.19.28.1 681: Dec 13 14:58:48.282 MST: Se2/0:0 PPP: Queue
BNCP code[1] id[141]
Dec 13 14:58:48 65.19.28.1 682: Dec 13 14:58:48.282 MST: Se2/0:0 PPP: Phase
is ESTABLISHING, Finish LCP
Dec 13 14:58:48 65.19.28.1 683: Dec 13 14:58:48.282 MST: Se2/0:0 PPP: Phase
is UP
Dec 13 14:58:48 65.19.28.1 684: Dec 13 14:58:48.282 MST: Se2/0:0 PPP:
Process pending packets
Dec 13 14:58:48 65.19.28.1 685: Dec 13 14:58:48.282 MST: Se2/0:0 BNCP:
Redirect packet to Se2/0:0
Dec 13 14:58:49 65.19.28.1 686: Dec 13 14:58:48.282 MST: Se2/0:0 BNCP: I
CONFREQ [Not negotiated] id 141 len 7
Dec 13 14:58:49 65.19.28.1 687: Dec 13 14:58:48.282 MST: Se2/0:0 BNCP:
Type8 (0x080301)
Dec 13 14:58:49 65.19.28.1 688: Dec 13 14:58:48.282 MST: Se2/0:0 LCP: O
PROTREJ [Open] id 134 len 13 protocol BNCP (0x8031018D0007080
301)



James
Routing and Security Administrator
At the Santa Fe Office: Cyber Mesa Telecom
jamesh at cybermesa.com  noc at cybermesa.com





More information about the cisco-nsp mailing list