Hi Liste,
Vielleicht off-toppic, dennoch...
Problem:
ADSL-Verbindung bricht nach kurzer Zeit ab
Beschreibung:
Verbindung kann aufgebaut werden. Nach kurzer Zeit (von 3min bis 30min),
jedoch nicht immer noch der gleichen Dauer, erfolgt ein disconnect, weil
keine echos mehr zurückkommen.
System:
SuSE Linux 7.2 Kernel 2.2.19
pppd version 2.4.0
pppoe version 0.4 build 20001008 (mitgeliefert von ARCOR - enternet)
SuSEfirewall (ipchains)
Diagnoseversuch:
1. die Verbindung chocked (wieso ist unklar)
2. damit können keine echos mehr empfangen werden
3. pppd merkt das und legt auf
4. Verbindung ist beim Provider jedoch noch aufgebaut, der hat nichts vom
disconnect mitbekommen, weil ja keine daten druchgehn
5. damit kann die Verbindung nicht wieder aufgebaut werden (2 mal lassen die
einen nicht rein)
Hat jemand ähnliche Erfahrungen schon mal gemacht und womöglich ein
Erklärung?
eGrüsse aus dem Grossraum Stuttgart,
.der Bernd
Auszug aus /var/log/messeges:
Oct 2 22:22:12 dslrouter modprobe: modprobe: Can't locate module
char-major-108
Oct 2 22:22:12 dslrouter kernel: registered device ppp0
Oct 2 22:22:12 dslrouter pppd[1122]: pppd 2.4.0 started by root, uid 0
Oct 2 22:22:12 dslrouter kernel: ppp_ioctl: set dbg flags to 10000
Oct 2 22:22:12 dslrouter pppd[1122]: Using interface ppp0
Oct 2 22:22:12 dslrouter pppd[1122]: Connect: ppp0 <--> /dev/pts/2
Oct 2 22:22:12 dslrouter kernel: ppp_tty_ioctl: set xasyncmap
Oct 2 22:22:12 dslrouter kernel: ppp_tty_ioctl: set xmit asyncmap ffffffff
Oct 2 22:22:12 dslrouter kernel: ppp_ioctl: set flags to 10000
Oct 2 22:22:12 dslrouter kernel: ppp_ioctl: set mru to 5dc
Oct 2 22:22:12 dslrouter kernel: ppp_tty_ioctl: set rcv asyncmap 0
Oct 2 22:22:12 dslrouter pppoed[1125]: pppoed 1.300.000 started
Oct 2 22:22:12 dslrouter kernel: pppoed uses obsolete (PF_INET,SOCK_PACKET)
Oct 2 22:22:12 dslrouter pppoed[1127]: Related PIDs: 1118 1125 1127
Oct 2 22:22:12 dslrouter pppoed[1125]: Sending PADI.
Oct 2 22:22:12 dslrouter pppoed[1127]: Connecting to AC, "myAC001".
Oct 2 22:22:12 dslrouter pppoed[1125]: Sending PADR.
Oct 2 22:22:12 dslrouter pppoed[1127]: Connected SessionID, 1277.
Oct 2 22:22:13 dslrouter pppd[1122]: sent [LCP ConfReq id=0x1 <mru 1492>
<asyncmap 0x0> <magic 0x273a9734> <pcomp>]
Oct 2 22:22:13 dslrouter pppoed[1125]: Operating in Async mode.
Oct 2 22:22:13 dslrouter kernel: ppp: tossing frame (e0)
Oct 2 22:22:13 dslrouter pppd[1122]: rcvd [LCP ConfReq id=0x74 <magic
0x583b7149> <mru 1500> <auth chap MD5>]
Oct 2 22:22:13 dslrouter pppd[1122]: sent [LCP ConfAck id=0x74 <magic
0x583b7149> <mru 1500> <auth chap MD5>]
Oct 2 22:22:13 dslrouter pppd[1122]: rcvd [LCP ConfRej id=0x1 <asyncmap
0x0>]
Oct 2 22:22:13 dslrouter pppd[1122]: sent [LCP ConfReq id=0x2 <mru 1492>
<magic 0x273a9734> <pcomp>]
Oct 2 22:22:13 dslrouter pppd[1122]: rcvd [LCP ConfAck id=0x2 <mru 1492>
<magic 0x273a9734> <pcomp>]
Oct 2 22:22:13 dslrouter kernel: ppp_tty_ioctl: set xmit asyncmap ffffffff
Oct 2 22:22:13 dslrouter kernel: ppp_ioctl: set flags to f010000
Oct 2 22:22:13 dslrouter kernel: ppp_ioctl: set mru to 5dc
Oct 2 22:22:13 dslrouter kernel: ppp_tty_ioctl: set rcv asyncmap 0
Oct 2 22:22:13 dslrouter pppd[1122]: sent [LCP EchoReq id=0x0
magic=0x273a9734]
Oct 2 22:22:13 dslrouter pppd[1122]: cbcp_lowerup
Oct 2 22:22:13 dslrouter pppd[1122]: want: 2
Oct 2 22:22:13 dslrouter pppd[1122]: rcvd [CHAP Challenge id=0x1
<fcbb82484abd2f63a4ae0d78254dba49>, name = "ppp(a)shastanets.com"]
Oct 2 22:22:13 dslrouter pppd[1122]: sent [CHAP Response id=0x1
<a5ba4b47c3d777554beb48ec0bd41df3>, name = "username"]
Oct 2 22:22:13 dslrouter pppd[1122]: rcvd [LCP EchoRep id=0x0
magic=0x583b7149]
Oct 2 22:22:14 dslrouter pppd[1122]: rcvd [CHAP Success id=0x1 ""]
Oct 2 22:22:14 dslrouter pppd[1122]: sent [IPCP ConfReq id=0x1 <addr
0.0.0.0> <compress VJ 0f 01>]
Oct 2 22:22:14 dslrouter kernel: ppp_ioctl: set flags to f010040
Oct 2 22:22:14 dslrouter kernel: PPP BSD Compression module registered
Oct 2 22:22:14 dslrouter kernel: PPP Deflate Compression module registered
Oct 2 22:22:14 dslrouter pppd[1122]: sent [CCP ConfReq id=0x1 <deflate 15>
<deflate(old#) 15> <bsd v1 15>]
Oct 2 22:22:14 dslrouter kernel: ppp_proto_ccp rcvd=0 code=1 flags=f010040
Oct 2 22:22:14 dslrouter pppd[1122]: rcvd [IPCP ConfReq id=0x2e <addr
145.xxx.xxx.xxx>]
Oct 2 22:22:14 dslrouter pppd[1122]: sent [IPCP ConfAck id=0x2e <addr
145.xxx.xxx.xxx>]
Oct 2 22:22:14 dslrouter pppd[1122]: rcvd [IPCP ConfRej id=0x1 <compress VJ
0f 01>]
Oct 2 22:22:14 dslrouter pppd[1122]: sent [IPCP ConfReq id=0x2 <addr
0.0.0.0>]
Oct 2 22:22:14 dslrouter pppd[1122]: rcvd [LCP ProtRej id=0x75 80 fd 01 01
00 0f 1a 04 78 00 18 04 78 00 15 03 2f 43 ec 0b d4 1d f3 62 65 72 6e 64 2e
73 69 68 ...]
Oct 2 22:22:14 dslrouter kernel: ppp0: ccp closed
Oct 2 22:22:14 dslrouter kernel: ppp_ioctl: set flags to f010000
Oct 2 22:22:14 dslrouter pppd[1122]: rcvd [IPCP ConfNak id=0x2 <addr
213.xxx.xxx.xxx>]
Oct 2 22:22:14 dslrouter pppd[1122]: sent [IPCP ConfReq id=0x3 <addr
213.xxx.xxx.xxx>]
Oct 2 22:22:14 dslrouter pppd[1122]: rcvd [IPCP ConfAck id=0x3 <addr
213.xxx.xxx.xxx>]
Oct 2 22:22:14 dslrouter kernel: ppp_ioctl: set flags to f010008
Oct 2 22:22:14 dslrouter kernel: ppp: set np 0 to 0
Oct 2 22:22:14 dslrouter pppd[1122]: local IP address 213.xxx.xxx.xxx
Oct 2 22:22:14 dslrouter pppd[1122]: remote IP address 145.xxx.xxx.xxx
Oct 2 22:22:14 dslrouter pppd[1122]: Script /etc/ppp/ip-up started (pid
1130)
Oct 2 22:22:17 dslrouter SuSEfirewall: Firewall rules successfully set from
/etc/rc.config.d/firewall.rc.config
Oct 2 22:22:17 dslrouter pppd[1122]: Script /etc/ppp/ip-up finished (pid
1130), status = 0x0
Oct 2 22:22:24 dslrouter pppd[1122]: rcvd [LCP EchoReq id=0x0
magic=0x583b7149]
.
.
.
.
Oct 2 22:28:19 dslrouter pppd[1122]: rcvd [LCP EchoReq id=0x22
magic=0x583b7149]
Oct 2 22:28:19 dslrouter pppd[1122]: sent [LCP EchoRep id=0x22
magic=0x273a9734]
Oct 2 22:28:29 dslrouter pppd[1122]: rcvd [LCP EchoReq id=0x23
magic=0x583b7149]
Oct 2 22:28:29 dslrouter pppd[1122]: sent [LCP EchoRep id=0x23
magic=0x273a9734]
Oct 2 22:28:43 dslrouter pppd[1122]: sent [LCP EchoReq id=0xd
magic=0x273a9734]
Oct 2 22:29:13 dslrouter pppd[1122]: sent [LCP EchoReq id=0xe
magic=0x273a9734]
Oct 2 22:29:43 dslrouter pppd[1122]: sent [LCP EchoReq id=0xf
magic=0x273a9734]
Oct 2 22:30:13 dslrouter pppd[1122]: sent [LCP EchoReq id=0x10
magic=0x273a9734]
Oct 2 22:30:43 dslrouter pppd[1122]: No response to 4 echo-requests
Oct 2 22:30:43 dslrouter pppd[1122]: Serial link appears to be
disconnected.
Oct 2 22:30:43 dslrouter pppd[1122]: cbcp_lowerdown
Oct 2 22:30:43 dslrouter pppd[1122]: Script /etc/ppp/ip-down started (pid
1403)
Oct 2 22:30:43 dslrouter pppd[1122]: sent [LCP TermReq id=0x3 "Peer not
responding"]
Oct 2 22:30:43 dslrouter kernel: ppp_ioctl: set flags to f010008
Oct 2 22:30:43 dslrouter kernel: ppp: set np 0 to 1
Oct 2 22:30:43 dslrouter kernel: ppp_ioctl: set flags to f010008
Oct 2 22:30:43 dslrouter kernel: ppp_tty_ioctl: set xmit asyncmap ffffffff
Oct 2 22:30:43 dslrouter kernel: ppp_ioctl: set flags to f010008
Oct 2 22:30:43 dslrouter kernel: ppp_ioctl: set mru to 5dc
Oct 2 22:30:43 dslrouter kernel: ppp_tty_ioctl: set rcv asyncmap ffffffff
Oct 2 22:30:45 dslrouter pppd[1122]: sent [LCP TermReq id=0x4 "Peer not
responding"]
Oct 2 22:30:47 dslrouter SuSEfirewall: Firewall rules successfully set from
/etc/rc.config.d/firewall.rc.config
Oct 2 22:30:47 dslrouter pppd[1122]: Script /etc/ppp/ip-down finished (pid
1403), status = 0x0
Oct 2 22:30:47 dslrouter pppd[1122]: Connection terminated.
Oct 2 22:30:47 dslrouter pppd[1122]: Connect time 8.6 minutes.
Oct 2 22:30:47 dslrouter pppd[1122]: Sent 1140452 bytes, received 13667772
bytes.
Oct 2 22:30:47 dslrouter kernel: ppp: channel ppp0 closing.
Oct 2 22:30:47 dslrouter kernel: ppp0 released
Oct 2 22:30:47 dslrouter kernel: ppp0: ccp closed
Oct 2 22:30:47 dslrouter pppoed[1125]: Good packets sent, 10863, and
received, 9480, by pppd.
Oct 2 22:30:47 dslrouter pppoed[1125]: Exit.
Oct 2 22:30:47 dslrouter kernel: ppp_ioctl: set dbg flags to 10000
Oct 2 22:30:47 dslrouter pppoed[1591]: pppoed 1.300.000 started
Oct 2 22:30:47 dslrouter pppd[1122]: Using interface ppp0
Oct 2 22:30:47 dslrouter pppd[1122]: Connect: ppp0 <--> /dev/pts/2
Oct 2 22:30:47 dslrouter kernel: ppp_tty_ioctl: set xasyncmap
Oct 2 22:30:47 dslrouter kernel: ppp_tty_ioctl: set xmit asyncmap ffffffff
Oct 2 22:30:47 dslrouter kernel: ppp_ioctl: set flags to 10000
Oct 2 22:30:48 dslrouter kernel: ppp_ioctl: set mru to 5dc
Oct 2 22:30:48 dslrouter kernel: ppp_tty_ioctl: set rcv asyncmap 0
Oct 2 22:30:48 dslrouter pppoed[1593]: Related PIDs: 1118 1591 1593
Oct 2 22:30:48 dslrouter pppoed[1591]: Sending PADI.
Oct 2 22:30:49 dslrouter pppd[1122]: sent [LCP ConfReq id=0x5 <mru 1492>
<asyncmap 0x0> <magic 0xaf49ecf9> <pcomp>]
Oct 2 22:30:49 dslrouter pppd[1122]: Script /usr/local/bin/pppoed -I eth1
finished (pid 1125), status = 0x0
Oct 2 22:30:49 dslrouter pppoed[1591]: No PADO responses received.
Oct 2 22:30:49 dslrouter pppoed[1591]: Re-sending PADI.
Oct 2 22:30:51 dslrouter pppd[1122]: sent [LCP ConfReq id=0x5 <mru 1492>
<asyncmap 0x0> <magic 0xaf49ecf9> <pcomp>]
Oct 2 22:30:51 dslrouter pppoed[1591]: No PADO responses received.
Oct 2 22:30:51 dslrouter pppoed[1591]: Re-sending PADI.
Oct 2 22:30:53 dslrouter pppd[1122]: sent [LCP ConfReq id=0x5 <mru 1492>
<asyncmap 0x0> <magic 0xaf49ecf9> <pcomp>]
Oct 2 22:30:55 dslrouter pppd[1122]: sent [LCP ConfReq id=0x5 <mru 1492>
<asyncmap 0x0> <magic 0xaf49ecf9> <pcomp>]
Oct 2 22:30:55 dslrouter pppoed[1591]: No PADO responses received.
Oct 2 22:30:55 dslrouter pppoed[1591]: Re-sending PADI.
Oct 2 22:30:57 dslrouter pppd[1122]: sent [LCP ConfReq id=0x5 <mru 1492>
<asyncmap 0x0> <magic 0xaf49ecf9> <pcomp>]
Oct 2 22:31:01 dslrouter last message repeated 2 times
Oct 2 22:31:03 dslrouter pppoed[1591]: No PADO responses received.
Oct 2 22:31:03 dslrouter pppoed[1591]: Could not connect to requested
network resource.
Oct 2 22:31:03 dslrouter pppoed[1591]: Exit.
<snipp>--------------------------------------------</snipp>
Bernd Sihling mailto: b.sihling(a)web.de.de
73728 Esslingen Deutschland
yahoo_messenger: b_sihling
icq#: 82940629
<snapp>--------------------------------------------</snapp>