Date: Tue, 29 Apr 2008 01:21:29 +0930 From: Malcolm Kay <malcolm.kay@internode.on.net> To: freebsd-questions@freebsd.org Cc: Ivan Toman <ivtoman@inet.hr> Subject: Re: ppp reconnecting problem Message-ID: <200804290121.29935.malcolm.kay@internode.on.net> In-Reply-To: <48142782.1060206@inet.hr> References: <48142782.1060206@inet.hr>
next in thread | previous in thread | raw e-mail | index | archive | help
On Sun, 27 Apr 2008 04:43 pm, Ivan Toman wrote: >=20 > Hello! > I encountered big problem after switching router from gentoo to > freebsd. It does not properly reconnect ADSL link after loosing > connection, for example, when ISP cycle IP address or when I pull out > cable from ADSL switcher for testing purporse. I cannot realize what's > going on and really need help. > First problem get when ISP disconnect me after 24 hours due to IP > change. Link does not properly get reconnected. ppp tries to connect, > and appearenty is connected, but something is wrong because no traffic > is possible and after few seconds ppp goes down and reconnects again. > And again and again.... Strange above all is that during reconnecting > routing table always has default route, but ping does not go. Next, I > will put some information that I think is relevant to problem, but it > seems to me, not very useful in debugging this. > During reconnecting as I describe above, this is my routing table: > [root@maraska-gw /home/coldplug]# netstat -rn > Routing tables > Internet: > Destination=C2 =C2 =C2 =C2 =C2 =C2 =C2 Gateway=C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 Flags=C2 =C2 =C2 > Refs=C2 =C2 =C2 =C2 =C2 Use=C2 Netif Expire > default=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 172.29.252.12=C2 = =C2 =C2 =C2 =C2 > UGS=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 1=C2 2284023=C2 =C2 tun0 > 10.23.99.64/29=C2 =C2 =C2 =C2 link#1=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 = =C2 =C2 =C2 =C2 > UC=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 0=C2 =C2 =C2 =C2 =C2 =C2 =C2 0= =C2 =C2 nfe0 > 10.23.99.66=C2 =C2 =C2 =C2 =C2 =C2 =C2 00:30:84:ee:3c:cf=C2 UHLW=C2 = =C2 =C2 =C2 =C2 =C2 =C2 > 1=C2 =C2 =C2 =C2 4065=C2 =C2 nfe0=C2 =C2 1030 > 10.23.99.70=C2 =C2 =C2 =C2 =C2 =C2 =C2 00:02:b3:9e:b9:81=C2 UHLW=C2 = =C2 =C2 =C2 =C2 =C2 =C2 1=C2 =C2 > 223104=C2 =C2 nfe0=C2 =C2 1027 > 127.0.0.1=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 127.0.0.1=C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 > UH=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 0=C2 =C2 =C2 =C2 =C2 =C2 72=C2= =C2 =C2 lo0 > 172.29.252.12=C2 =C2 =C2 =C2 =C2 78.3.33.136=C2 =C2 =C2 =C2 =C2 =C2 = =C2 UGH=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 > 1=C2 =C2 =C2 =C2 =C2 =C2 =C2 0=C2 =C2 tun0 > Internet6: > Destination=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 =C2 > Gateway=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 Flags=C2 Netif > Expire > ::1=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 > ::1=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 UHL=C2 =C2 =C2 =C2 > lo0 > fe80::%lo0/64=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 = =C2 =C2 =C2 =C2 =C2 =C2 > fe80::1%lo0=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 U=C2 =C2 =C2 =C2 lo0 > fe80::1%lo0=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 =C2 > link#5=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 = =C2 =C2 =C2 =C2 =C2 =C2 =C2 UHL=C2 =C2 =C2 =C2 lo0 > ff01:5::/32=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 =C2 > fe80::1%lo0=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 UC=C2 =C2 =C2 =C2 lo0 > ff01:6::/32=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 =C2 =C2 =C2 =C2 > link#6=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 = =C2 =C2 =C2 =C2 =C2 =C2 =C2 UGC=C2 =C2 =C2 tun0 > ff02::%lo0/32=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 = =C2 =C2 =C2 =C2 =C2 =C2 > fe80::1%lo0=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2= =C2 =C2 =C2 UC=C2 =C2 =C2 =C2 lo0 > ff02::%tun0/32=C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 =C2 = =C2 =C2 =C2 =C2 =C2 > fe80::211:9ff:fe8d:4a27%tun0=C2 UGC=C2 =C2 =C2 tun0 > [root@maraska-gw /home/coldplug]# > And this.... I get if try to ping ISP's dns > [root@maraska-gw /home/coldplug]# ping 195.29.150.3 > PING 195.29.150.3 (195.29.150.3): 56 data bytes > ping: sendto: No buffer space available > ping: sendto: No buffer space available > ping: sendto: No buffer space available > ping: sendto: No buffer space available > ^C > --- 195.29.150.3 ping statistics --- > 10 packets transmitted, 0 packets received, 100.0% packet loss > [root@maraska-gw /home/coldplug]# > No buffer space available??? What is that? > These are lines from log, where you can see that it reconnects and > never stops that > [root@maraska-gw /home/coldplug]# tail -f /var/log/ppp.log > Apr 26 12:06:22 maraska-gw ppp[956]: tun0: Phase: deflink: carrier -> > login > Apr 26 12:06:22 maraska-gw ppp[956]: tun0: Phase: deflink: login -> > lcp > Apr 26 12:06:23 maraska-gw ppp[956]: tun0: Warning: deflink: Reducing > configured MRU from 1500 to 1492 > Apr 26 12:06:23 maraska-gw ppp[956]: tun0: Phase: deflink: his =3D PAP, > mine =3D none > Apr 26 12:06:23 maraska-gw ppp[956]: tun0: Phase: Pap Output: > ertoman1@htnet-dsl ******** > Apr 26 12:06:24 maraska-gw ppp[956]: tun0: Phase: Pap Input: SUCCESS > (Access Accepted. ) > Apr 26 12:06:24 maraska-gw ppp[956]: tun0: Phase: deflink: Already in > NETWORK phase > Apr 26 12:06:24 maraska-gw ppp[956]: tun0: Phase: deflink: lcp -> open > Apr 26 12:06:24 maraska-gw ppp[956]: tun0: Warning: 0.0.0.0/0: Change > route failed: errno: No such process > Apr 26 12:06:24 maraska-gw ppp[956]: tun0: Warning: ff02:6::/32: > Change route failed: errno: Network is unreachable > Apr 26 12:08:23 maraska-gw ppp[956]: tun0: Phase: deflink: open -> lcp > Apr 26 12:08:23 maraska-gw ppp[956]: tun0: Warning: 0.0.0.0/0: Change > route failed: errno: No such process > Apr 26 12:08:23 maraska-gw ppp[956]: tun0: Warning: ff02:6::/32: > Change route failed: errno: Network is unreachable > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: Received > NGM_PPPOE_CLOSE > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: Device > disconnected > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: > Disconnected! > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: lcp -> > logout > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: > Disconnected! > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: logout -> > hangup > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: Connect > time: 123 secs: 374 octets in, 96 octets out > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: 3218212 > packets in, 2284164 packets out > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase:=C2 total 3 bytes/se= c, > peak 40 bytes/sec on Sat Apr 26 12:06:24 2008 > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: hangup -> > opening > Apr 26 12:08:24 maraska-gw ppp[956]: tun0: Phase: deflink: Enter pause > (3) for redialing. > Apr 26 12:08:27 maraska-gw ppp[956]: tun0: Phase: deflink: Connected! > Apr 26 12:08:27 maraska-gw ppp[956]: tun0: Phase: deflink: opening -> > dial > Apr 26 12:08:27 maraska-gw ppp[956]: tun0: Phase: deflink: dial -> > carrier > Apr 26 12:08:28 maraska-gw ppp[956]: tun0: Phase: Received > NGM_PPPOE_ACNAME (hook "HTdsl") > Apr 26 12:08:28 maraska-gw ppp[956]: tun0: Phase: Received > NGM_PPPOE_SESSIONID > Apr 26 12:08:28 maraska-gw ppp[956]: tun0: Phase: Received > NGM_PPPOE_SUCCESS > Apr 26 12:08:28 maraska-gw ppp[956]: tun0: Phase: deflink: carrier -> > login > Apr 26 12:08:28 maraska-gw ppp[956]: tun0: Phase: deflink: login -> > lcp > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Warning: deflink: Reducing > configured MRU from 1500 to 1492 > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Phase: deflink: his =3D PAP, > mine =3D none > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Phase: Pap Output: > ertoman1@htnet-dsl ******** > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Phase: Pap Input: SUCCESS > (Access Accepted. ) > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Phase: deflink: Already in > NETWORK phase > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Phase: deflink: lcp -> open > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Warning: 0.0.0.0/0: Change > route failed: errno: No such process > Apr 26 12:08:29 maraska-gw ppp[956]: tun0: Warning: ff02:6::/32: > Change route failed: errno: Network is unreachable > ^C > [root@maraska-gw /home/coldplug]# > Only way to exit this trouble is restarting ppp manually! > [root@maraska-gw /home/coldplug]# killall ppp > [root@maraska-gw /home/coldplug]# ppp -ddial htnet > Loading /lib/libalias_cuseeme.so > Loading /lib/libalias_ftp.so > Loading /lib/libalias_irc.so > Loading /lib/libalias_nbt.so > Loading /lib/libalias_pptp.so > Loading /lib/libalias_skinny.so > Loading /lib/libalias_smedia.so > Working in ddial mode > Using interface: tun0 > Warning: usage: nat addr [addr_local addr_alias] > Warning: usage: nat addr [addr_local addr_alias] > Warning: usage: nat addr [addr_local addr_alias] > [root@maraska-gw /home/coldplug]# ping 195.29.150.3 > PING 195.29.150.3 (195.29.150.3): 56 data bytes > 64 bytes from 195.29.150.3: icmp_seq=3D2 ttl=3D251 time=3D23.386 ms > This is my config file > [root@maraska-gw /home/coldplug]# cat /etc/ppp/ppp.conf > default: > =C2 =C2 =C2 =C2 =C2 =C2 set log Phase tun command > =C2 =C2 =C2 =C2 =C2 =C2 nat enable yes > htnet: > =C2 =C2 =C2 =C2 =C2 =C2 set device PPPoE:rl0: > =C2 =C2 =C2 =C2 =C2 =C2 set authname ertoman1@htnet-dsl > =C2 =C2 =C2 =C2 =C2 =C2 set authkey *** > =C2 =C2 =C2 =C2 =C2 =C2 set dial > =C2 =C2 =C2 =C2 =C2 =C2 set login > =C2 =C2 =C2 =C2 =C2 =C2 add default HISADDR > =C2 =C2 =C2 =C2 =C2 =C2 nat addr 10.23.99.66 > =C2 =C2 =C2 =C2 =C2 =C2 nat addr 10.23.99.67 > =C2 =C2 =C2 =C2 =C2 =C2 nat addr 10.23.99.70 > [root@maraska-gw /home/coldplug]# > I tried lot of things. "enable lqr", "enable echo"... nothing helps. > Moreover, testing this by pulling out cable and replugging it give no > response from system! If I do that, link goes down (real link), but > system do not realize that at all! Routing table remains unchanged, > default route still is there, tun0 interface still configured, ppp > runs, and in /var/log/ppp.log there is no new single line after that > replugging cable into ADSL modem! How is that possible? Isn't pulling > out and replugging cable should be enough for ppp to realize it that > tun0 should be reconfigured and ppp redialed? I have seen I similar but slightly different problem on my son's server running 6.x. In that case ppp was started using /etc/rc.d/ppp which also=20 calls '/etc/rc.d/pf resync'. In this case apparently the pf firewall blocked any packets when ppp tries to automatically restart after a connection inte= rrupt. We devised a work around of running another process (script) which loops=20 testing the difference in time between the modify time of ppp.log and the c= urrent=20 time and if this is too great stops and restarts ppp, through /etc/rc.d/ppp= =2E=20 Normally the file time is updated every 30 seconds or so by setting "enable= echo".=20 The loop also includes a call to sleep of a few minutes so the the loop doe= s not=20 greatly consume processing time. This has worked well for us and I suspect = would also work in your case even though it does not fix the root cause of the pr= oblem. Unfortunately I don't have access to my son's server so I can't recall the = exact=20 details of the script but I think it was started from a rc.d script. But yo= u=20 should be able to knit something similar without too much effort. This could keep you operational while looking for the base cause of the difficulty.=20 Malcolm Kay > Of course, I start ppp as: > # ppp -ddial htnet > I really need reliable connection that needs no permanent monitoring > by myself and manually reconnecting after being dropped. Please, give > me some idea what can I do because I'm still desperate after few days > of trying to fix this. For sake of completness, I had no problems with > this before, on gentoo. Now I run FreeBSD 7. > [root@maraska-gw /home/coldplug]# uname -a > FreeBSD maraska-gw.zdw 7.0-RELEASE FreeBSD 7.0-RELEASE #0: Sun Feb 24 > 19:59:52 UTC 2008=C2 =C2 =C2 =C2 > [1]root@logan.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC=C2 i386 > If you think that some other messages from system will be more useful, > I will hapily provide them. > Thanks to all! > Ivan Toman >=20 > References >=20 > 1. mailto:root@logan.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?200804290121.29935.malcolm.kay>