Re: How to debug ppp

2000-12-05 Thread Leif Neland

It still doesn't work sometimes.

I have a complete log (From dialing to hangup) at
http://www.neland.dk/arnold.log
My ppp.conf is at http://www.neland.dk/arnold.conf

Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
00:10:bc:06:fa:00
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: LayerStart
Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: State change Stopped --
Ack-Se
nt
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: RecvConfigReq(2) state =
Ack-Se
nt
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
00:10:bc:06:fa:00
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: SendConfigAck(2) state =
Ack-Se
nt
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)

- Original Message -
From: "Brian Somers" [EMAIL PROTECTED]
To: "Leif Neland" [EMAIL PROTECTED]
Cc: [EMAIL PROTECTED]; [EMAIL PROTECTED]
Sent: Wednesday, November 29, 2000 2:10 AM
Subject: Re: How to debug ppp


 Well, I haven't seen this before !!!

 Your ISP is *insisting* that you negotiate a multi-link connection.
 You can do this by simply adding

   set mrru 1506

 to your config.

  I sometimes have trouble connecting to my flat-rate isp via i4bsd.
  Most of the time it works, but sometimes the handshake fails.
  What is the log trying to tell me here? What can I tell my isp?
 
  When it fails, I can connect to another isp, which charges per minute
  charges, which I rather not use
  when I have flat rate.
 
  Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: Phone: x
  Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: Connected!
  Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: opening - dial
  Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: 1: Dial attempt 1 of 2
  Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: dial - carrier
  Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: /dev/i4brbch0: CD
detected
  Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: carrier - login
  Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: login - lcp
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: FSM: Using "1" as a
transport
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Initial --
  Closed
  Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: Entering STOPPED state
for
  2 s
  econds
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Closed --
  Stopped
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(1) state =
  Stopped
 
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
  00:10:bc:06:fa:00
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigReq(1) state =
  Stopped
 
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x0bde8bbc
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(1) state =
  Stopped
 
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: LayerStart
  Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Stopped --
  Req-Sent
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(2) state =
  Req-Sent
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
  00:10:bc:06:fa:00
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(2) state =
  Req-Sent
  Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
  Looping:
  Nov 27 20:48:38 arnold ppp[7461]:

Re: How to debug ppp

2000-12-05 Thread Brian Somers

What happens if you ``disable acfcomp protocomp'' and ``deny acfcomp 
protocomp'' in your config ?

This should be negotiable with isdn but perhaps our requesting it 
is upsetting the peer ?

 It still doesn't work sometimes.
 
 I have a complete log (From dialing to hangup) at
 http://www.neland.dk/arnold.log
 My ppp.conf is at http://www.neland.dk/arnold.conf
 
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: LayerStart
 Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: State change Stopped --
 Ack-Se
 nt
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: RecvConfigReq(2) state =
 Ack-Se
 nt
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: SendConfigAck(2) state =
 Ack-Se
 nt
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
 Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 
 - Original Message -
 From: "Brian Somers" [EMAIL PROTECTED]
 To: "Leif Neland" [EMAIL PROTECTED]
 Cc: [EMAIL PROTECTED]; [EMAIL PROTECTED]
 Sent: Wednesday, November 29, 2000 2:10 AM
 Subject: Re: How to debug ppp
 
 
  Well, I haven't seen this before !!!
 
  Your ISP is *insisting* that you negotiate a multi-link connection.
  You can do this by simply adding
 
set mrru 1506
 
  to your config.
 
   I sometimes have trouble connecting to my flat-rate isp via i4bsd.
   Most of the time it works, but sometimes the handshake fails.
   What is the log trying to tell me here? What can I tell my isp?
  
   When it fails, I can connect to another isp, which charges per minute
   charges, which I rather not use
   when I have flat rate.
  
   Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: Phone: x
   Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: Connected!
   Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: opening - dial
   Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: 1: Dial attempt 1 of 2
   Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: dial - carrier
   Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: /dev/i4brbch0: CD
 detected
   Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: carrier - login
   Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: login - lcp
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: FSM: Using "1" as a
 transport
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Initial --
   Closed
   Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: Entering STOPPED state
 for
   2 s
   econds
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Closed --
   Stopped
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(1) state =
   Stopped
  
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
   00:10:bc:06:fa:00
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigReq(1) state =
   Stopped
  
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x0bde8bbc
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(1) state =
   Stopped
  
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: LayerStart
   Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Stopped --
   Req-Sent
   Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(2) state =
   Req-Sent
   Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
   Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
   Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
   Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
   Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
   Nov 27 20:48:37 arnold ppp[7

Re: How to debug ppp

2000-12-05 Thread Leif Neland
[4] 0xc023 (PAP)
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MAGICNUM[6] 0x01e25945
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  PROTOCOMP[2]
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  ACFCOMP[2]
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRRU[4] 1506
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  ENDDISC[9] MAC
00:10:bc:06:fa:00
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP: 1: SendConfigRej(10) state =
Req-Sent
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  PROTOCOMP[2]
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  ACFCOMP[2]
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP: 1: SendConfigReq(1) state =
Req-Sent
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRU[4] 1500
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MAGICNUM[6] 0xc23c4361
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRRU[4] 1506
Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  SHORTSEQ[2]
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Carrier lost
Dec  6 00:21:40 arnold ppp[56941]: tun0: LCP: 1: State change Req-Sent --
Starting
Dec  6 00:21:40 arnold ppp[56941]: tun0: LCP: 1: LayerFinish
Dec  6 00:21:40 arnold ppp[56941]: tun0: LCP: 1: State change Starting --
Initial
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Disconnected!
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: lcp - logout
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Disconnected!
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: logout - hangup
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Connect time: 16 secs:
351 octets in, 228 octets out
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: : 19 packets in, 29
packets out
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase:  total 36 bytes/sec, peak 50
bytes/sec on Wed Dec  6 00:21:40 2000
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: hangup - closed
Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: bundle: Dead

- Original Message -
From: "Brian Somers" [EMAIL PROTECTED]
To: "Leif Neland" [EMAIL PROTECTED]
Cc: "Brian Somers" [EMAIL PROTECTED]; [EMAIL PROTECTED];
[EMAIL PROTECTED]
Sent: Tuesday, December 05, 2000 11:40 PM
Subject: Re: How to debug ppp


 What happens if you ``disable acfcomp protocomp'' and ``deny acfcomp
 protocomp'' in your config ?

 This should be negotiable with isdn but perhaps our requesting it
 is upsetting the peer ?

  It still doesn't work sometimes.
 
  I have a complete log (From dialing to hangup) at
  http://www.neland.dk/arnold.log
  My ppp.conf is at http://www.neland.dk/arnold.conf
 
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
  00:10:bc:06:fa:00
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: LayerStart
  Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: State change
Stopped --
  Ack-Se
  nt
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: RecvConfigReq(2) state
=
  Ack-Se
  nt
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
  00:10:bc:06:fa:00
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: SendConfigAck(2) state
=
  Ack-Se
  nt
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
  Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 
  - Original Message -
  From: "Brian Somers" [EMAIL PROTECTED]
  To: "Leif Neland" [EMAIL PROTECTED]
  Cc: [EMAIL PROTECTED]; [EMAIL PROTECTED]
  Sent: Wednesday, November 29, 2000 2:10 AM
  Subject: Re: How to debug ppp
 
 
   Well, I haven't seen this before !!!
  
   Your ISP is *insisting* that you negotiate a multi-link connection.
   You can do this by simply adding
  
 set mrru 1506
  
   to your config.
  
I sometimes have trouble connecting to my flat-rate isp via i4bsd.
Most of the time it works, but sometimes the handshake fails.
What is the log trying to tell me here? What can I tell my isp?
   
When it fails, I can connect to another isp, which charges per
minute
charges, which I rather not use
when I have flat rate.
   
Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: Phone: x
Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: Connected!
Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: opening - dial
Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: 1: Di

Re: How to debug ppp

2000-12-05 Thread Brian Somers
:36 arnold ppp[56941]: tun0: LCP:  MRRU[4] 1506
 Dec  6 00:21:36 arnold ppp[56941]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Dec  6 00:21:36 arnold ppp[56941]: tun0: LCP: 1: SendConfigRej(9) state =
 Req-Sent
 Dec  6 00:21:36 arnold ppp[56941]: tun0: LCP:  PROTOCOMP[2]
 Dec  6 00:21:36 arnold ppp[56941]: tun0: LCP:  ACFCOMP[2]
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP: 1: RecvConfigReq(10) state =
 Req-Sent
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRU[4] 1500
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MAGICNUM[6] 0x01e25945
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  PROTOCOMP[2]
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  ACFCOMP[2]
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRRU[4] 1506
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP: 1: SendConfigRej(10) state =
 Req-Sent
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  PROTOCOMP[2]
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  ACFCOMP[2]
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP: 1: SendConfigReq(1) state =
 Req-Sent
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRU[4] 1500
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MAGICNUM[6] 0xc23c4361
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  MRRU[4] 1506
 Dec  6 00:21:38 arnold ppp[56941]: tun0: LCP:  SHORTSEQ[2]
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Carrier lost
 Dec  6 00:21:40 arnold ppp[56941]: tun0: LCP: 1: State change Req-Sent --
 Starting
 Dec  6 00:21:40 arnold ppp[56941]: tun0: LCP: 1: LayerFinish
 Dec  6 00:21:40 arnold ppp[56941]: tun0: LCP: 1: State change Starting --
 Initial
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Disconnected!
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: lcp - logout
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Disconnected!
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: logout - hangup
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: Connect time: 16 secs:
 351 octets in, 228 octets out
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: : 19 packets in, 29
 packets out
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase:  total 36 bytes/sec, peak 50
 bytes/sec on Wed Dec  6 00:21:40 2000
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: 1: hangup - closed
 Dec  6 00:21:40 arnold ppp[56941]: tun0: Phase: bundle: Dead
 
 - Original Message -
 From: "Brian Somers" [EMAIL PROTECTED]
 To: "Leif Neland" [EMAIL PROTECTED]
 Cc: "Brian Somers" [EMAIL PROTECTED]; [EMAIL PROTECTED];
 [EMAIL PROTECTED]
 Sent: Tuesday, December 05, 2000 11:40 PM
 Subject: Re: How to debug ppp
 
 
  What happens if you ``disable acfcomp protocomp'' and ``deny acfcomp
  protocomp'' in your config ?
 
  This should be negotiable with isdn but perhaps our requesting it
  is upsetting the peer ?
 
   It still doesn't work sometimes.
  
   I have a complete log (From dialing to hangup) at
   http://www.neland.dk/arnold.log
   My ppp.conf is at http://www.neland.dk/arnold.conf
  
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
   00:10:bc:06:fa:00
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: LayerStart
   Dec  5 22:28:28 arnold ppp[55986]: tun0: LCP: 1: State change
 Stopped --
   Ack-Se
   nt
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: RecvConfigReq(2) state
 =
   Ack-Se
   nt
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MAGICNUM[6] 0xa14dc70c
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  PROTOCOMP[2]
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ACFCOMP[2]
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRRU[4] 1506
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  ENDDISC[9] MAC
   00:10:bc:06:fa:00
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP: 1: SendConfigAck(2) state
 =
   Ack-Se
   nt
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  MRU[4] 1500
   Dec  5 22:28:29 arnold ppp[55986]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
  
   - Original Message -
   From: "Brian Somers" [EMAIL PROTECTED]
   To: "Leif Neland" [EMAIL PROTECTED]
   Cc: [EMAIL PROTECTED]; [EMAIL PROTECTED]
   Sent: Wednesday, November 29, 2000 2:10 AM
   Subject: Re: How to debug ppp
  
  
Well, I haven't seen this before !!!
   
Your ISP is *insisting* that you negotiate a multi-link connection.
You can do this by simply adding
   
  set

Re: How to debug ppp

2000-11-28 Thread Brian Somers

Well, I haven't seen this before !!!

Your ISP is *insisting* that you negotiate a multi-link connection.  
You can do this by simply adding

  set mrru 1506

to your config.

 I sometimes have trouble connecting to my flat-rate isp via i4bsd.
 Most of the time it works, but sometimes the handshake fails.
 What is the log trying to tell me here? What can I tell my isp?
 
 When it fails, I can connect to another isp, which charges per minute
 charges, which I rather not use
 when I have flat rate.
 
 Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: Phone: x
 Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: Connected!
 Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: opening - dial
 Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: 1: Dial attempt 1 of 2
 Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: dial - carrier
 Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: /dev/i4brbch0: CD detected
 Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: carrier - login
 Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: login - lcp
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: FSM: Using "1" as a transport
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Initial --
 Closed
 Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: Entering STOPPED state for
 2 s
 econds
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Closed --
 Stopped
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(1) state =
 Stopped
 
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigReq(1) state =
 Stopped
 
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x0bde8bbc
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(1) state =
 Stopped
 
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: LayerStart
 Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Stopped --
 Req-Sent
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(2) state =
 Req-Sent
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(2) state =
 Req-Sent
 Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
 Looping:
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(3) state =
 Req-Sent
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
 00:10:bc:06:fa:00
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(3) state =
 Req-Sent
 Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
 Until hangup
 
 Leif

-- 
Brian [EMAIL PROTECTED]brian@[uk.]FreeBSD.org
  http://www.Awfulhak.org   brian@[uk.]OpenBSD.org
Don't _EVER_ lose your sense of humour !




To Unsubscribe: send mail to [EMAIL PROTECTED]
with "unsubscribe freebsd-current" in the body of the message



Re: How to debug ppp

2000-11-28 Thread Leif Neland



On Wed, 29 Nov 2000, Brian Somers wrote:

 Well, I haven't seen this before !!!
 
 Your ISP is *insisting* that you negotiate a multi-link connection.  
 You can do this by simply adding
 
   set mrru 1506
 
 to your config.
 
Strange, since my subscription is single channel flat rate isdn...

I'll try it.

Leif




To Unsubscribe: send mail to [EMAIL PROTECTED]
with "unsubscribe freebsd-current" in the body of the message



How to debug ppp

2000-11-27 Thread Leif Neland

I sometimes have trouble connecting to my flat-rate isp via i4bsd.
Most of the time it works, but sometimes the handshake fails.
What is the log trying to tell me here? What can I tell my isp?

When it fails, I can connect to another isp, which charges per minute
charges, which I rather not use
when I have flat rate.

Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: Phone: x
Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: Connected!
Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: opening - dial
Nov 27 20:48:35 arnold ppp[7461]: tun0: Chat: 1: Dial attempt 1 of 2
Nov 27 20:48:35 arnold ppp[7461]: tun0: Phase: 1: dial - carrier
Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: /dev/i4brbch0: CD detected
Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: carrier - login
Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: login - lcp
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: FSM: Using "1" as a transport
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Initial --
Closed
Nov 27 20:48:36 arnold ppp[7461]: tun0: Phase: 1: Entering STOPPED state for
2 s
econds
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Closed --
Stopped
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(1) state =
Stopped

Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
00:10:bc:06:fa:00
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigReq(1) state =
Stopped

Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x0bde8bbc
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(1) state =
Stopped

Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: LayerStart
Nov 27 20:48:36 arnold ppp[7461]: tun0: LCP: 1: State change Stopped --
Req-Sent
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(2) state =
Req-Sent
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
00:10:bc:06:fa:00
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(2) state =
Req-Sent
Nov 27 20:48:37 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
Looping:
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP: 1: RecvConfigReq(3) state =
Req-Sent
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MRU[4] 1500
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  AUTHPROTO[4] 0xc023 (PAP)
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MAGICNUM[6] 0x08f8f450
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  PROTOCOMP[2]
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  ACFCOMP[2]
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  ENDDISC[9] MAC
00:10:bc:06:fa:00
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP: 1: SendConfigRej(3) state =
Req-Sent
Nov 27 20:48:38 arnold ppp[7461]: tun0: LCP:  MRRU[4] 1506
Until hangup

Leif





To Unsubscribe: send mail to [EMAIL PROTECTED]
with "unsubscribe freebsd-current" in the body of the message