×

Warning message

  • Cisco Support Forums is in Read Only mode while the site is being migrated.
  • Cisco Support Forums is in Read Only mode while the site is being migrated.

LCP failed to negotiate / STM16 link

Unanswered Question
May 7th, 2014
User Badges:

 

 

Dear Friends,

 

 

Kindly, i am trying to establish STM16 link between 7600 and 12000 but port is didnt come up and  layer 1 is okay because i am able to see remote host and IP at both sides:

 

7600 side:

 

interface POS3/0/0
 description *** Conn.To-CORE-1-DUHOK-On-PO0/0/0/0 ***
 ip address 192.168.55.110 255.255.255.252
 encapsulation ppp
 logging event link-status
 mls qos trust dscp
 crc 32
 pos framing sdh
end

 

#sh controllers pos 3/0/0
POS3/0/0
SECTION
  LOF = 0          LOS    = 1                            BIP(B1) = 171
LINE
  AIS = 0          RDI    = 0          FEBE = 3848       BIP(B2) = 8246
PATH
  AIS = 0          RDI    = 2          FEBE = 2548000    BIP(B3) = 2553209
  PLM = 0          UNEQ   = 0          TIM  = 1          TIU     = 0
  LOP = 2          NEWPTR = 7          PSE  = 0          NSE     = 1

Active Defects: B3-TCA 
Active Alarms:  B3-TCA 
Alarm reporting enabled for: SF SLOS SLOF B1-TCA B2-TCA PLOP B3-TCA 

Framing: SDH
APS

  COAPS = 0          PSBF = 3         
  State: PSBF_state = False
  Rx(K1/K2): 00/00  Tx(K1/K2): 00/00
  Rx Synchronization Status S1 = 02
  S1S0 = 02, C2 = CF
  Remote aps status (none); Reflected local aps status (none)
CLOCK RECOVERY
  RDOOL = 0         
  State: RDOOL_state = False
PATH TRACE BUFFER: STABLE
  Remote hostname : CORE-1-DUHOK            POS0/0/0/0    192.168.55.109  0 0 0 0 

  Remote interface: POS0/0/0/0    192.168.55.109  0 0 0 0 

  Remote IP addr  : 192.168.55.109  0 0 0 0 

  Remote Rx(K1/K2): 0 /0   Tx(K1/K2): 0 /0 

BER thresholds:  SF = 10e-4  SD = 10e-6
TCA thresholds:  B1 = 10e-6  B2 = 10e-6  B3 = 10e-6

  Clock source:  line

 

 

12000 side:

 

sh controllers pos0/0/0/0
Wed May  7 11:34:39.798 gmt
Port Number         : 0
Interface           : POS0/0/0/0
Ifhandle            : 0x1002a00
CRC                 : 32
MTU                 : 4474
Port Bandwidth Kbps : 2488320
Admin state         : Up  
Driver Link state   : Up  

Bundle member       :  No
Bundle MTU          : 4474
Bundle Adminstate   : Up  

 

 

interface POS0/0/0/0
 description *** Conn.To-PE-Telkif-01-On-PO3/0/0 ***
 cdp
 ipv4 address 192.168.55.109 255.255.255.252
 encapsulation ppp
 pos
  crc 32
 !

 

controller SONET0/0/0/0
 path
  scrambling disable
 !
 framing sdh
 clock source line
 

 

When i debug i got below logs:

 

*May  6 23:07:05.339: PO3/0/0 LCP: O CONFREQ [REQsent] id 10 len 14
*May  6 23:07:05.339: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:05.339: PO3/0/0 LCP:    MagicNumber 0x7362820B (0x05067362820B)
*May  6 23:07:05.339: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:07.355: PO3/0/0 PPP DISC: LCP failed to negotiate
*May  6 23:07:07.355: PPP: NET STOP send to AAA.
*May  6 23:07:07.355: PO3/0/0 LCP: Event[Timeout-] State[REQsent to Stopped]
*May  6 23:07:07.355: PO3/0/0 LCP: Event[DOWN] State[Stopped to Starting]
*May  6 23:07:07.355: PO3/0/0 PPP: Phase is DOWN
*May  6 23:07:08.355: PPP: Alloc Context [1BE739AC]
*May  6 23:07:08.355: ppp404 PPP: Phase is ESTABLISHING
*May  6 23:07:08.355: PO3/0/0 PPP: Using default call direction
*May  6 23:07:08.355: PO3/0/0 PPP: Treating connection as a dedicated line
*May  6 23:07:08.355: PO3/0/0 PPP: Session handle[EA000C31] Session id[404]
*May  6 23:07:08.355: PO3/0/0 LCP: Event[OPEN] State[Initial to Starting]
*May  6 23:07:08.355: PO3/0/0 LCP: O CONFREQ [Starting] id 1 len 14
*May  6 23:07:08.355: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:08.355: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:08.355: PO3/0/0 LCP: Event[UP] State[Starting to REQsent]
*May  6 23:07:10.363: PO3/0/0 LCP: O CONFREQ [REQsent] id 2 len 14
*May  6 23:07:10.363: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:10.363: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:10.363: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:12.379: PO3/0/0 LCP: O CONFREQ [REQsent] id 3 len 14
*May  6 23:07:12.379: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:12.379: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:12.379: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:14.395: PO3/0/0 LCP: O CONFREQ [REQsent] id 4 len 14
*May  6 23:07:14.395: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:14.395: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:14.395: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:16.411: PO3/0/0 LCP: O CONFREQ [REQsent] id 5 len 14
*May  6 23:07:16.411: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:16.411: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:16.411: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:18.427: PO3/0/0 LCP: O CONFREQ [REQsent] id 6 len 14
*May  6 23:07:18.427: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:18.427: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:18.427: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:20.443: PO3/0/0 LCP: O CONFREQ [REQsent] id 7 len 14
*May  6 23:07:20.443: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:20.443: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:20.443: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:22.459: PO3/0/0 LCP: O CONFREQ [REQsent] id 8 len 14
*May  6 23:07:22.459: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:22.459: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:22.459: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:24.475: PO3/0/0 LCP: O CONFREQ [REQsent] id 9 len 14
*May  6 23:07:24.475: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:24.475: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:24.475: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:26.491: PO3/0/0 LCP: O CONFREQ [REQsent] id 10 len 14
*May  6 23:07:26.491: PO3/0/0 LCP:    MRU 4470 (0x01041176)
*May  6 23:07:26.491: PO3/0/0 LCP:    MagicNumber 0x7362D4BB (0x05067362D4BB)
*May  6 23:07:26.491: PO3/0/0 LCP: Event[Timeout+] State[REQsent to REQsent]
*May  6 23:07:28.507: PO3/0/0 PPP DISC: LCP failed to negotiate

 

 

Physical connection is 7600 ----SDH-----SDH----12000

Thanks in advance for your help.

 

Regards,

Ahmed

 

  • 1
  • 2
  • 3
  • 4
  • 5
Overall Rating: 0 (0 ratings)
Loading.
Giuseppe Larosa Wed, 05/07/2014 - 02:04
User Badges:
  • Super Silver, 17500 points or more
  • Hall of Fame,

    Founding Member

Hello Ahmed,

please ignore, I thought it was a back to back connection but you have SDH in the middle.

However, I see you have scrambling disabled on 12000 side, I would try to enable it.

also the debug shows only O output packets from the pos 3/0/0 side there is no received LCP packet.(I)

 

 

Hope to help

Giuseppe

 

Actions

This Discussion