PPP:
  PPP protocol negotiation debugging is on


Feb 15 09:40:43.904: ppp303 PPP: Phase is ESTABLISHING
Feb 15 09:40:43.904: ppp303 LCP: I FORCED rcvd CONFACK len 17
Feb 15 09:40:43.904: ppp303 LCP:    ACCM 0x000A0000 (0x0206000A0000)
Feb 15 09:40:43.904: ppp303 LCP:    AuthProto CHAP (0x0305C22305)
Feb 15 09:40:43.904: ppp303 LCP:    MagicNumber 0x12B74A63 (0x050612B74A63)
Feb 15 09:40:43.904: ppp303 LCP: I FORCED sent CONFACK len 39
Feb 15 09:40:43.904: ppp303 LCP:    ACCM 0x00000000 (0x020600000000)
Feb 15 09:40:43.904: ppp303 LCP:    MagicNumber 0x55155ED2 (0x050655155ED2)
Feb 15 09:40:43.904: ppp303 LCP:    PFC (0x0702)
Feb 15 09:40:43.904: ppp303 LCP:    ACFC (0x0802)
Feb 15 09:40:43.904: ppp303 LCP:    EndpointDisc 1 Local
Feb 15 09:40:43.904: ppp303 LCP:     (0x131701CD3F46CDAB4B40AB92D1BB7A35)
Feb 15 09:40:43.904: ppp303 LCP:     (0xAB5B2B00000000)
Feb 15 09:40:43.904: ppp303 LCP: O CONFREJ [Closed] id 0 len 8
Feb 15 09:40:43.904: ppp303 LCP:    PFC (0x0702)
Feb 15 09:40:43.904: ppp303 LCP:    ACFC (0x0802)
Feb 15 09:40:43.904: ppp303 PPP: Phase is FORWARDING, Attempting Forward
Feb 15 09:40:43.904: ppp303 PPP: Phase is AUTHENTICATING, Unauthenticated User
Feb 15 09:40:43.920: ppp303 PPP: Phase is FORWARDING, Attempting Forward
Feb 15 09:40:43.988: Vi4 PPP: Phase is DOWN, Setup
Feb 15 09:40:43.996: Vi4 PPP: Outbound ip packet dropped, line protocol not up
Feb 15 09:40:43.996: Vi4 PPP: Phase is AUTHENTICATING, Authenticated User
Feb 15 09:40:43.996: Vi4 CHAP: O SUCCESS id 1 len 4
Feb 15 09:40:43.996: Vi4 PPP: Phase is UP
Feb 15 09:40:43.996: Vi4 IPCP: O CONFREQ [Closed] id 1 len 10
Feb 15 09:40:43.996: Vi4 IPCP:    Address 212.119.97.77 (0x0306D477614D)
Feb 15 09:40:43.996: Vi4 PPP: Process pending ncp packets
Feb 15 09:40:44.192: Vi4 IPCP: I CONFREQ [REQsent] id 3 len 40
Feb 15 09:40:44.192: Vi4 IPCP:    CompressType VJ 15 slots CompressSlotID (0x0206002D0F01)
Feb 15 09:40:44.192: Vi4 IPCP:    Address 0.0.0.0 (0x030600000000)
Feb 15 09:40:44.192: Vi4 IPCP:    PrimaryDNS 0.0.0.0 (0x810600000000)
Feb 15 09:40:44.192: Vi4 IPCP:    PrimaryWINS 0.0.0.0 (0x820600000000)
Feb 15 09:40:44.192: Vi4 IPCP:    SecondaryDNS 0.0.0.0 (0x830600000000)
Feb 15 09:40:44.192: Vi4 IPCP:    SecondaryWINS 0.0.0.0 (0x840600000000)
Feb 15 09:40:44.196: Vi4 AAA/AUTHOR/IPCP: Start.  Her address 0.0.0.0, we want 0.0.0.0
Feb 15 09:40:44.196: Vi4 AAA/AUTHOR/IPCP: Done.  Her address 0.0.0.0, we want 0.0.0.0
Feb 15 09:40:44.196: Vi4 IPCP: Pool returned 212.119.119.1
Feb 15 09:40:44.196: Vi4 IPCP: O CONFREJ [REQsent] id 3 len 22
Feb 15 09:40:44.196: Vi4 IPCP:    CompressType VJ 15 slots CompressSlotID (0x0206002D0F01)
Feb 15 09:40:44.196: Vi4 IPCP:    PrimaryWINS 0.0.0.0 (0x820600000000)
Feb 15 09:40:44.196: Vi4 IPCP:    SecondaryWINS 0.0.0.0 (0x840600000000)
Feb 15 09:40:44.196: Vi4 IPCP: O CONFNAK [REQsent] id 4 len 22
Feb 15 09:40:44.196: Vi4 IPCP:    Address 212.119.119.1 (0x0306D4777701)
Feb 15 09:40:44.196: Vi4 IPCP:    PrimaryDNS 212.119.96.33 (0x8106D4776021)
Feb 15 09:40:44.196: Vi4 IPCP:    SecondaryDNS 212.119.96.2 (0x8306D4776002)
Feb 15 09:40:44.196: Vi4 IPCP: O CONFACK [REQsent] id 5 len 22
Feb 15 09:40:44.196: Vi4 IPCP:    Address 212.119.119.1 (0x0306D4777701)
Feb 15 09:40:44.196: Vi4 IPCP:    PrimaryDNS 212.119.96.33 (0x8106D4776021)
Feb 15 09:40:44.196: Vi4 IPCP:    SecondaryDNS 212.119.96.2 (0x8306D4776002)
Feb 15 09:40:44.212: Vi4 IPCP: I CONFACK [ACKsent] id 1 len 10
Feb 15 09:40:44.212: Vi4 IPCP:    Address 212.119.97.77 (0x0306D477614D)
Feb 15 09:40:44.212: Vi4 IPCP: State is Open
Feb 15 09:40:44.216: Vi4 IPCP: Install route to 212.119.119.1
Feb 15 09:40:44.216: Vi4 IPCP: Add link info for cef entry 212.119.119.1
Feb 15 09:40:44.372: Vi4 IPCP: I CONFREQ [Open] id 4 len 22
Feb 15 09:40:44.372: Vi4 IPCP:    Address 0.0.0.0 (0x030600000000)
Feb 15 09:40:44.372: Vi4 IPCP:    PrimaryDNS 0.0.0.0 (0x810600000000)
Feb 15 09:40:44.372: Vi4 IPCP:    SecondaryDNS 0.0.0.0 (0x830600000000)
Feb 15 09:40:44.372: Vi4 IPCP: Ignoring predicted packet, state is Open
Feb 15 09:40:44.572: Vi4 IPCP: I CONFREQ [Open] id 5 len 22
Feb 15 09:40:44.572: Vi4 IPCP:    Address 212.119.119.1 (0x0306D4777701)
Feb 15 09:40:44.572: Vi4 IPCP:    PrimaryDNS 212.119.96.33 (0x8106D4776021)
Feb 15 09:40:44.572: Vi4 IPCP:    SecondaryDNS 212.119.96.2 (0x8306D4776002)
Feb 15 09:40:44.572: Vi4 IPCP: Ignoring predicted packet, state is Open
Feb 15 09:40:48.088: ppp304 PPP: Phase is ESTABLISHING
Feb 15 09:40:48.088: ppp304 LCP: I FORCED rcvd CONFACK len 17
Feb 15 09:40:48.088: ppp304 LCP:    ACCM 0x000A0000 (0x0206000A0000)
Feb 15 09:40:48.088: ppp304 LCP:    AuthProto CHAP (0x0305C22305)
Feb 15 09:40:48.088: ppp304 LCP:    MagicNumber 0x12685B03 (0x050612685B03)
Feb 15 09:40:48.088: ppp304 LCP: I FORCED sent CONFACK len 39
Feb 15 09:40:48.088: ppp304 LCP:    ACCM 0x00000000 (0x020600000000)
Feb 15 09:40:48.088: ppp304 LCP:    MagicNumber 0x0FD64A2A (0x05060FD64A2A)
Feb 15 09:40:48.088: ppp304 LCP:    PFC (0x0702)
Feb 15 09:40:48.088: ppp304 LCP:    ACFC (0x0802)
Feb 15 09:40:48.088: ppp304 LCP:    EndpointDisc 1 Local
Feb 15 09:40:48.088: ppp304 LCP:     (0x131701CD3F46CDAB4B40AB92D1BB7A35)
Feb 15 09:40:48.088: ppp304 LCP:     (0xAB5B2B00000000)
Feb 15 09:40:48.088: ppp304 LCP: O CONFREJ [Closed] id 0 len 8
Feb 15 09:40:48.088: ppp304 LCP:    PFC (0x0702)
Feb 15 09:40:48.088: ppp304 LCP:    ACFC (0x0802)
Feb 15 09:40:48.088: ppp304 PPP: Phase is FORWARDING, Attempting Forward
Feb 15 09:40:48.088: ppp304 PPP: Phase is AUTHENTICATING, Unauthenticated User
Feb 15 09:40:48.112: ppp304 PPP: Phase is FORWARDING, Attempting Forward
Feb 15 09:40:48.184: Vi3 PPP: Phase is DOWN, Setup
Feb 15 09:40:48.192: Vi3 PPP: Outbound ip packet dropped, line protocol not up
Feb 15 09:40:48.192: Vi3 PPP: Phase is AUTHENTICATING, Authenticated User
Feb 15 09:40:48.192: Vi3 CHAP: O SUCCESS id 1 len 4
Feb 15 09:40:48.192: Vi3 PPP: Phase is UP
Feb 15 09:40:48.192: Vi3 IPCP: O CONFREQ [Closed] id 1 len 10
Feb 15 09:40:48.192: Vi3 IPCP:    Address 212.119.97.77 (0x0306D477614D)
Feb 15 09:40:48.192: Vi3 PPP: Process pending ncp packets
Feb 15 09:40:48.372: Vi3 IPCP: I CONFREQ [REQsent] id 3 len 40
Feb 15 09:40:48.372: Vi3 IPCP:    CompressType VJ 15 slots CompressSlotID (0x0206002D0F01)
Feb 15 09:40:48.372: Vi3 IPCP:    Address 0.0.0.0 (0x030600000000)
Feb 15 09:40:48.372: Vi3 IPCP:    PrimaryDNS 0.0.0.0 (0x810600000000)
Feb 15 09:40:48.372: Vi3 IPCP:    PrimaryWINS 0.0.0.0 (0x820600000000)
Feb 15 09:40:48.372: Vi3 IPCP:    SecondaryDNS 0.0.0.0 (0x830600000000)
Feb 15 09:40:48.372: Vi3 IPCP:    SecondaryWINS 0.0.0.0 (0x840600000000)
Feb 15 09:40:48.372: Vi3 AAA/AUTHOR/IPCP: Start.  Her address 0.0.0.0, we want 0.0.0.0
Feb 15 09:40:48.372: Vi3 AAA/AUTHOR/IPCP: Done.  Her address 0.0.0.0, we want 0.0.0.0
Feb 15 09:40:48.376: Vi3 IPCP: Pool returned 212.119.119.2
Feb 15 09:40:48.376: Vi3 IPCP: O CONFREJ [REQsent] id 3 len 22
Feb 15 09:40:48.376: Vi3 IPCP:    CompressType VJ 15 slots CompressSlotID (0x0206002D0F01)
Feb 15 09:40:48.376: Vi3 IPCP:    PrimaryWINS 0.0.0.0 (0x820600000000)
Feb 15 09:40:48.376: Vi3 IPCP:    SecondaryWINS 0.0.0.0 (0x840600000000)
Feb 15 09:40:48.376: Vi3 IPCP: O CONFNAK [REQsent] id 4 len 22
Feb 15 09:40:48.376: Vi3 IPCP:    Address 212.119.119.2 (0x0306D4777702)
Feb 15 09:40:48.376: Vi3 IPCP:    PrimaryDNS 212.119.96.33 (0x8106D4776021)
Feb 15 09:40:48.376: Vi3 IPCP:    SecondaryDNS 212.119.96.2 (0x8306D4776002)
Feb 15 09:40:48.376: Vi3 IPCP: O CONFACK [REQsent] id 5 len 22
Feb 15 09:40:48.376: Vi3 IPCP:    Address 212.119.119.2 (0x0306D4777702)
Feb 15 09:40:48.376: Vi3 IPCP:    PrimaryDNS 212.119.96.33 (0x8106D4776021)
Feb 15 09:40:48.376: Vi3 IPCP:    SecondaryDNS 212.119.96.2 (0x8306D4776002)
Feb 15 09:40:48.392: Vi3 IPCP: I CONFACK [ACKsent] id 1 len 10
Feb 15 09:40:48.392: Vi3 IPCP:    Address 212.119.97.77 (0x0306D477614D)
Feb 15 09:40:48.392: Vi3 IPCP: State is Open
Feb 15 09:40:48.396: Vi3 IPCP: Install route to 212.119.119.2
Feb 15 09:40:48.396: Vi3 IPCP: Add link info for cef entry 212.119.119.2
Feb 15 09:40:48.552: Vi3 IPCP: I CONFREQ [Open] id 4 len 22
Feb 15 09:40:48.552: Vi3 IPCP:    Address 0.0.0.0 (0x030600000000)
Feb 15 09:40:48.552: Vi3 IPCP:    PrimaryDNS 0.0.0.0 (0x810600000000)
Feb 15 09:40:48.552: Vi3 IPCP:    SecondaryDNS 0.0.0.0 (0x830600000000)
Feb 15 09:40:48.552: Vi3 IPCP: Ignoring predicted packet, state is Open
Feb 15 09:40:48.752: Vi3 IPCP: I CONFREQ [Open] id 5 len 22
Feb 15 09:40:48.752: Vi3 IPCP:    Address 212.119.119.2 (0x0306D4777702)
Feb 15 09:40:48.752: Vi3 IPCP:    PrimaryDNS 212.119.96.33 (0x8106D4776021)
Feb 15 09:40:48.752: Vi3 IPCP:    SecondaryDNS 212.119.96.2 (0x8306D4776002)
Feb 15 09:40:48.752: Vi3 IPCP: Ignoring predicted packet, state is Open
Feb 15 09:40:58.360: %LDP-5-NBRCHG: TDP Neighbor 212.119.97.105:0 is UP
Feb 15 09:40:59.016: Vi3 LCP: I TERMREQ [Open] id 6 len 16 (0x0FD64A2A003CCD7400000000)
Feb 15 09:40:59.016: Vi3 LCP: O TERMACK [Open] id 6 len 4
Feb 15 09:40:59.016: Vi3 PPP: Sending Acct Event[Down] id[B0]
Feb 15 09:40:59.016: Vi3 PPP: Phase is TERMINATING
Feb 15 09:41:03.032: Vi3 LCP: TIMEout: State TERMsent
Feb 15 09:41:03.032: Vi3 LCP: State is Closed
Feb 15 09:41:03.032: Vi3 PPP: Phase is DOWN
Feb 15 09:41:03.032: Vi3 IPCP: Remove link info for cef entry 212.119.119.2
Feb 15 09:41:03.032: Vi3 IPCP: State is Closed
Feb 15 09:41:03.032: Vi3 PPP: Block vaccess from being freed [0x1]
Feb 15 09:41:03.032: Vi3 PPP: Phase is ESTABLISHING, Passive Open
Feb 15 09:41:03.032: Vi3 LCP: State is Listen
Feb 15 09:41:03.032: Vi3 IPCP: Remove route to 212.119.119.2
Feb 15 09:41:03.032: Vi3 PPP: Unlocked by [0x1] Still Locked by [0x0]
Feb 15 09:41:03.032: Vi3 PPP: Free previously blocked vaccess
