[cisco-bba] LCP failing - any ideas?

[Nathan Downes]

Hi,

 

This morning we started having a few clients unable to connect, I see the
MAC addresses of the modems learnt on the core switch but LCP appears to
fail.  It is across two providers so I can't blame them (issues may be
different for each of them)  Debugging PPP negotiation just repeats the
below.

 

*May 24 18:42:08.611: ppp470 LCP: Event[Timeout-] State[REQsent to Stopped]

*May 24 18:42:08.611: ppp470 LCP: Event[DOWN] State[Stopped to Starting]

*May 24 18:42:08.611: ppp470 PPP: Clearing AAA Unique Id = B70

*May 24 18:42:08.611: ppp470 PPP: Phase is DOWN

*May 24 18:42:10.307: ppp475 LCP: O CONFREQ [REQsent] id 5 len 18

*May 24 18:42:10.307: ppp475 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:10.307: ppp475 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:10.307: ppp475 LCP:    MagicNumber 0x1A8E4B9E (0x05061A8E4B9E)

*May 24 18:42:10.307: ppp475 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:10.531: ppp472 LCP: O CONFREQ [REQsent] id 6 len 18

*May 24 18:42:10.531: ppp472 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:10.531: ppp472 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:10.531: ppp472 LCP:    MagicNumber 0x1A8E449C (0x05061A8E449C)

*May 24 18:42:10.531: ppp472 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:10.531: ppp476 LCP: O CONFREQ [REQsent] id 3 len 18

*May 24 18:42:10.531: ppp476 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:10.531: ppp476 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:10.531: ppp476 LCP:    MagicNumber 0x1A8E5C44 (0x05061A8E5C44)

*May 24 18:42:10.531: ppp476 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:12.323: ppp475 LCP: O CONFREQ [REQsent] id 6 len 18

*May 24 18:42:12.323: ppp475 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:12.323: ppp475 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:12.323: ppp475 LCP:    MagicNumber 0x1A8E4B9E (0x05061A8E4B9E)

*May 24 18:42:12.323: ppp475 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:12.547: ppp472 LCP: O CONFREQ [REQsent] id 7 len 18

*May 24 18:42:12.547: ppp472 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:12.547: ppp472 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:12.547: ppp472 LCP:    MagicNumber 0x1A8E449C (0x05061A8E449C)

*May 24 18:42:12.547: ppp472 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:12.547: ppp476 LCP: O CONFREQ [REQsent] id 4 len 18

*May 24 18:42:12.547: ppp476 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:12.547: ppp476 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:12.547: ppp476 LCP:    MagicNumber 0x1A8E5C44 (0x05061A8E5C44)

*May 24 18:42:12.547: ppp476 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:14.339: ppp475 LCP: O CONFREQ [REQsent] id 7 len 18

*May 24 18:42:14.339: ppp475 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:14.339: ppp475 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:14.339: ppp475 LCP:    MagicNumber 0x1A8E4B9E (0x05061A8E4B9E)

*May 24 18:42:14.339: ppp475 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:14.563: ppp472 LCP: O CONFREQ [REQsent] id 8 len 18

*May 24 18:42:14.563: ppp472 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:14.563: ppp472 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:14.563: ppp472 LCP:    MagicNumber 0x1A8E449C (0x05061A8E449C)

*May 24 18:42:14.563: ppp472 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:14.563: ppp476 LCP: O CONFREQ [REQsent] id 5 len 18

*May 24 18:42:14.563: ppp476 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:14.563: ppp476 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:14.563: ppp476 LCP:    MagicNumber 0x1A8E5C44 (0x05061A8E5C44)

*May 24 18:42:14.563: ppp476 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:16.355: ppp475 LCP: O CONFREQ [REQsent] id 8 len 18

*May 24 18:42:16.355: ppp475 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:16.355: ppp475 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:16.355: ppp475 LCP:    MagicNumber 0x1A8E4B9E (0x05061A8E4B9E)

*May 24 18:42:16.355: ppp475 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:16.579: ppp472 LCP: O CONFREQ [REQsent] id 9 len 18

*May 24 18:42:16.579: ppp472 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:16.579: ppp472 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:16.579: ppp472 LCP:    MagicNumber 0x1A8E449C (0x05061A8E449C)

*May 24 18:42:16.579: ppp472 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:16.579: ppp476 LCP: O CONFREQ [REQsent] id 6 len 18

*May 24 18:42:16.579: ppp476 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:16.579: ppp476 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:16.579: ppp476 LCP:    MagicNumber 0x1A8E5C44 (0x05061A8E5C44)

*May 24 18:42:16.579: ppp476 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:18.371: ppp475 LCP: O CONFREQ [REQsent] id 9 len 18

*May 24 18:42:18.371: ppp475 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:18.371: ppp475 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:18.371: ppp475 LCP:    MagicNumber 0x1A8E4B9E (0x05061A8E4B9E)

*May 24 18:42:18.371: ppp475 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:18.595: ppp472 LCP: O CONFREQ [REQsent] id 10 len 18

*May 24 18:42:18.595: ppp472 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:18.595: ppp472 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:18.595: ppp472 LCP:    MagicNumber 0x1A8E449C (0x05061A8E449C)

*May 24 18:42:18.595: ppp472 LCP: Event[Timeout+] State[REQsent to REQsent]

*May 24 18:42:18.595: ppp476 LCP: O CONFREQ [REQsent] id 7 len 18

*May 24 18:42:18.595: ppp476 LCP:    MRU 1492 (0x010405D4)

*May 24 18:42:18.595: ppp476 LCP:    AuthProto PAP (0x0304C023)

*May 24 18:42:18.595: ppp476 LCP:    MagicNumber 0x1A8E5C44 (0x05061A8E5C44)

*May 24 18:42:18.595: ppp476 LCP: Event[Timeout+] State[REQsent to REQsent]

 

As we handoff to the providers from the switch this one is connected to I
have very few ways of following the traffic to the other side, I can see
requests go out but they either don't make it to CPE or the response doesn't
make it back.  Nothing has been changed networkwise in the last 3 months so
bit lost. Have rebooted the switch just in case as it has been a year or so,
but that just got more angry calls :)  

 

CPE is just a simple modem on other side, no difference between working and
non working ones, BRAS is a 7204vxr with a G2.  "core" switch is just a
simple 3560g

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://puck.nether.net/pipermail/cisco-bba/attachments/20160524/ea0640fa/attachment.html>