Wiedereinwahl PPP

From: Sebastian Ahndorf <webmaster(at)it-is-warlock.de>
Date: Thu, 02 Jun 2005 23:55:04 +0200

Hallo zusammen,

schon seit längerem Stelle ich (nicht nur) bei meinem Router folgendes
Problemfest.
Nach der 24h-Trennung (TDSL, bzw. mitlerweile DSL bei Versatel) schafft
es der Router nicht mehr die Verbindung alleine wieder herzustellen.

Das lustige dabei: An der Konfiguration wurde seit ewigkeiten nichts
verändert, die automatische Wiedereinwahl nach der 24h-Trennung
funktionierte auch schon reibungslos und das Problem tritt mitlerweile
auch auf verschiedenen FBSD Versionen auf.
Ich verwende z.Z. 4.11-STABLE während auf einem anderen Router mit dem
selben Problem noch 4.9-RELEASE werkelt.
Bei beiden Rechnern funktionierte wie gesagt bei gleicher Konfiguration
die Wiedereinwahl bis vor einiger Zeit problemlos. Die ppp.conf wurde
nach Udo Erdelhoffs Anleitung erstellt.

Nach 24h ohne Trennung tauchen im ppp.log folgende Meldungen auf,
vielleicht wird ja irgendjemand anderes daraus schlau: [1]

Mit freundlichen Grüßen
Sebastian Ahndorf

[1]
May 31 09:21:51 server ppp[58]: Phase: deflink: open -> lcp
May 31 09:21:51 server ppp[58]: IPCP: deflink: LayerDown: 83.135.148.151
May 31 09:21:51 server ppp[58]: IPCP: Using trigger address 0.0.0.0
May 31 09:21:51 server ppp[58]: IPCP: deflink: State change Opened -->
Starting
May 31 09:21:51 server ppp[58]: IPCP: deflink: LayerFinish.
May 31 09:21:51 server ppp[58]: IPCP: Connect time: 86402 secs:
1932997608 octet
s in, 1317626179 octets out
May 31 09:21:51 server ppp[58]: IPCP: 3137586 packets in, 2829855
packets out
May 31 09:21:51 server ppp[58]: IPCP: total 37622 bytes/sec, peak
336737 bytes/
sec on Mon May 30 23:34:26 2005
May 31 09:21:51 server ppp[58]: IPCP: deflink: State change Starting -->
Initial
May 31 09:21:51 server ppp[58]: Phase: Received NGM_PPPOE_CLOSE
May 31 09:21:51 server ppp[58]: Phase: deflink: Device disconnected
May 31 09:21:51 server ppp[58]: LCP: deflink: State change Stopping -->
Starting
May 31 09:21:51 server ppp[58]: LCP: deflink: LayerFinish
May 31 09:21:51 server ppp[58]: LCP: deflink: State change Starting -->
Initial
May 31 09:21:51 server ppp[58]: Phase: deflink: Disconnected!
May 31 09:21:51 server ppp[58]: Phase: deflink: lcp -> logout
May 31 09:21:51 server ppp[58]: Phase: deflink: Disconnected!
May 31 09:21:51 server ppp[58]: Phase: deflink: logout -> hangup
May 31 09:21:51 server ppp[58]: Phase: deflink: Connect time: 86403
secs: 192672
2897 octets in, 1323286394 octets out
May 31 09:21:51 server ppp[58]: Phase: deflink: 3137622 packets in,
2829895 pack
ets out
May 31 09:21:51 server ppp[58]: Phase: total 37614 bytes/sec, peak
331828 bytes
/sec on Tue May 31 08:27:24 2005
May 31 09:21:51 server ppp[58]: Phase: deflink: hangup -> opening
May 31 09:21:51 server ppp[58]: Phase: deflink: Enter pause (60) for
redialing.
May 31 09:22:51 server ppp[58]: Phase: deflink: Connected!
May 31 09:22:51 server ppp[58]: Phase: deflink: opening -> dial
May 31 09:22:51 server ppp[58]: Phase: deflink: dial -> carrier
May 31 09:22:52 server ppp[58]: Phase: Received NGM_PPPOE_ACNAME (hook
"versatel
-erx")
May 31 09:22:52 server ppp[58]: Phase: Received NGM_PPPOE_SESSIONID
May 31 09:22:52 server ppp[58]: Phase: Received NGM_PPPOE_SUCCESS
May 31 09:22:52 server ppp[58]: Phase: deflink: carrier -> login
May 31 09:22:52 server ppp[58]: Phase: deflink: login -> lcp
May 31 09:22:52 server ppp[58]: LCP: FSM: Using "deflink" as a transport
May 31 09:22:52 server ppp[58]: LCP: deflink: State change Initial -->
Closed
May 31 09:22:52 server ppp[58]: LCP: deflink: State change Closed -->
Stopped
May 31 09:22:52 server ppp[58]: LCP: deflink: RecvConfigReq(186) state =
Stopped
May 31 09:22:52 server ppp[58]: LCP: MRU[4] 1492
May 31 09:22:52 server ppp[58]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 31 09:22:52 server ppp[58]: LCP: MAGICNUM[6] 0x43ccbf4d
May 31 09:22:52 server ppp[58]: LCP: deflink: SendConfigReq(2) state =
Stopped
May 31 09:22:52 server ppp[58]: LCP: MRU[4] 1492
May 31 09:22:52 server ppp[58]: LCP: MAGICNUM[6] 0xfa019440
May 31 09:22:52 server ppp[58]: LCP: deflink: SendConfigAck(186) state =
Stopped
May 31 09:22:52 server ppp[58]: LCP: MRU[4] 1492
May 31 09:22:52 server ppp[58]: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
May 31 09:22:52 server ppp[58]: LCP: MAGICNUM[6] 0x43ccbf4d
May 31 09:22:52 server ppp[58]: LCP: deflink: LayerStart
May 31 09:22:52 server ppp[58]: LCP: deflink: State change Stopped -->
Ack-Sent
May 31 09:22:52 server ppp[58]: LCP: deflink: RecvConfigAck(2) state =
Ack-Sent
May 31 09:22:52 server ppp[58]: LCP: MRU[4] 1492
May 31 09:22:52 server ppp[58]: LCP: MAGICNUM[6] 0xfa019440
May 31 09:22:52 server ppp[58]: LCP: deflink: State change Ack-Sent -->
Opened
May 31 09:22:52 server ppp[58]: LCP: deflink: LayerUp
May 31 09:22:52 server ppp[58]: Phase: deflink: his = CHAP 0x05, mine = none
May 31 09:22:52 server ppp[58]: Phase: Chap Input: CHALLENGE (17 bytes
from dor0
02ibr003)
May 31 09:22:52 server ppp[58]: Phase: Chap Output: RESPONSE (*zensiert*)
May 31 09:22:52 server ppp[58]: Phase: Chap Input: SUCCESS
May 31 09:22:52 server ppp[58]: Phase: deflink: Already in NETWORK phase
May 31 09:22:52 server ppp[58]: Phase: deflink: lcp -> open
May 31 09:22:52 server ppp[58]: IPCP: deflink: RecvConfigReq(11) state =
Initial
May 31 09:22:52 server ppp[58]: IPCP: IPADDR[6] 62.214.64.76
May 31 09:22:52 server ppp[58]: IPCP: deflink: Oops, RCR in Initial.
May 31 09:22:55 server ppp[58]: IPCP: deflink: RecvConfigReq(12) state =
Initial
May 31 09:22:55 server ppp[58]: IPCP: IPADDR[6] 62.214.64.76
May 31 09:22:55 server ppp[58]: IPCP: deflink: Oops, RCR in Initial.
May 31 09:22:58 server ppp[58]: IPCP: deflink: RecvConfigReq(13) state =
Initial
May 31 09:22:58 server ppp[58]: IPCP: IPADDR[6] 62.214.64.76
May 31 09:22:58 server ppp[58]: IPCP: deflink: Oops, RCR in Initial.
May 31 09:23:01 server ppp[58]: IPCP: deflink: RecvConfigReq(14) state =
Initial
May 31 09:23:01 server ppp[58]: IPCP: IPADDR[6] 62.214.64.76
May 31 09:23:01 server ppp[58]: IPCP: deflink: Oops, RCR in Initial.
May 31 09:23:05 server ppp[58]: IPCP: deflink: RecvConfigReq(15) state =
Initial
May 31 09:23:05 server ppp[58]: IPCP: IPADDR[6] 62.214.64.76
May 31 09:23:05 server ppp[58]: IPCP: deflink: Oops, RCR in Initial.
May 31 09:23:05 server ppp[58]: Phase: Signal 15, terminate.
May 31 09:23:05 server ppp[58]: LCP: deflink: LayerDown
May 31 09:23:05 server ppp[58]: LCP: deflink: SendTerminateReq(3) state
= Opened
May 31 09:23:05 server ppp[58]: LCP: deflink: State change Opened -->
Closing
May 31 09:23:05 server ppp[58]: Phase: deflink: open -> lcp
May 31 09:23:05 server ppp[58]: LCP: deflink: RecvTerminateAck(3) state
= Closin
g
May 31 09:23:05 server ppp[58]: LCP: deflink: LayerFinish
May 31 09:23:05 server ppp[58]: LCP: deflink: State change Closing -->
Closed
May 31 09:23:05 server ppp[58]: LCP: deflink: State change Closed -->
Initial
May 31 09:23:05 server ppp[58]: Phase: deflink: Disconnected!
May 31 09:23:05 server ppp[58]: Phase: deflink: lcp -> logout
May 31 09:23:05 server ppp[58]: Phase: deflink: logout -> hangup
May 31 09:23:05 server ppp[58]: Phase: deflink: Disconnected!
May 31 09:23:05 server ppp[58]: Phase: deflink: Connect time: 14 secs:
145 octet
s in, 89 octets out
May 31 09:23:05 server ppp[58]: Phase: deflink: 3137632 packets in,
2829899 pack
ets out
May 31 09:23:05 server ppp[58]: Phase: total 16 bytes/sec, peak 57
bytes/sec on
Tue May 31 09:22:53 2005
May 31 09:23:05 server ppp[58]: Phase: deflink: hangup -> closed
May 31 09:23:05 server ppp[58]: Phase: bundle: Dead
May 31 09:23:05 server ppp[58]: Phase: PPP Terminated (normal).

To Unsubscribe: send mail to majordomo(at)de.FreeBSD.org
with "unsubscribe de-bsd-questions" in the body of the message
Received on Thu 02 Jun 2005 - 23:55:48 CEST