Error message with persist option

Error message with persist option

[Gregory Colpart]

Hello,

I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
My DSL connnection is PPPoA with a modem PCI card Bewan ST
(unicorn driver).

When I pon/poff, it works fine. But every 24 hours, my ISP reset
my connection and persist option fails to reactivate it.


See my debug messages :

* End of connection

21:00:03 pppd[29191]: rcvd [LCP TermReq id=0xe7]
21:00:03 pppd[29191]: LCP terminated by peer
21:00:03 pppd[29191]: Connect time 1440.0 minutes.
21:00:03 pppd[29191]: Sent 410466878 bytes, received 450988023
bytes. 
21:00:03 pppd[29191]: Script /etc/ppp/ip-down started (pid 31487) 
21:00:03 pppd[29191]: Script /etc/ppp/ipv6-down started (pid
31488) 
21:00:03 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
21:00:03 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
21:00:03 pppd[29191]: sent [LCP TermAck id=0xe7]
21:00:03 pppd[29191]: Script /etc/ppp/ipv6-down finished (pid
31488), status = 0x0
21:00:03 pppd[29191]: Script /etc/ppp/ip-down finished (pid
31487), status = 0x0
21:00:06 pppd[29191]: Connection terminated.
21:00:06 pppd[29191]: Connect time 1440.0 minutes.
21:00:06 pppd[29191]: Sent 410466878 bytes, received 450988023
bytes. 
21:00:06 pppd[29191]: using channel 933
21:00:06 pppd[29191]: Using interface ppp0
21:00:06 pppd[29191]: Connect: ppp0 <--> 8.35
21:00:06 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
21:00:06 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
21:00:07 pppd[29191]: sent [LCP ConfReq id=0x4 <mru 1492> <magic
0x465bebe1>]
21:00:07 pppd[29191]: Modem hangup 

* try to reconnect with persist option

21:00:17 pppd[29191]: using channel 934
21:00:17 pppd[29191]: in make_ppp_unit, already had /dev/ppp
open?
21:00:17 pppd[29191]: Using interface ppp0
21:00:17 pppd[29191]: Connect: ppp0 <--> 8.35
21:00:17 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
21:00:17 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
21:00:17 pppd[29191]: sent [LCP ConfReq id=0x5 <mru 1492> <magic
0x252c61a9>]
21:00:44 last message repeated 9 times
21:00:47 pppd[29191]: LCP: timeout sending Config-Requests
21:00:47 pppd[29191]: Connection terminated.
21:00:47 pppd[29191]: Modem hangup 

* another chance

21:00:47 pppd[29191]: using channel 935
21:00:47 pppd[29191]: Using interface ppp0
21:00:47 pppd[29191]: Connect: ppp0 <--> 8.35
21:00:47 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
21:00:47 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
21:00:47 pppd[29191]: sent [LCP ConfReq id=0x6 <mru 1492> <magic
0xf00f7f8c>]
21:00:47 pppd[29191]: Connection terminated.
21:00:47 pppd[29191]: sent [LCP TermReq id=0x7]
21:00:47 pppd[29191]: write: Bad file descriptor (9)
21:00:50 pppd[29191]: sent [LCP TermReq id=0x8]
21:00:50 pppd[29191]: write: Bad file descriptor (9)
21:00:53 pppd[29191]: Connection terminated.
21:00:53 pppd[29191]: sent [LCP ConfReq id=0x9 <mru 1492> <magic
0x9c6381e4>]
21:00:53 pppd[29191]: write: Bad file descriptor (9)
21:00:53 pppd[29191]: sent [LCP TermReq id=0xa]
21:00:53 pppd[29191]: write: Bad file descriptor (9)
21:00:56 pppd[29191]: sent [LCP TermReq id=0xb]
21:00:56 pppd[29191]: write: Bad file descriptor (9)
21:00:59 pppd[29191]: Connection terminated.
21:00:59 pppd[29191]: Modem hangup 

* another chance

21:00:59 pppd[29191]: using channel 936

[infinite loop]



If I "poff & pon", all is right !
My temporary solution is a crontab script with "poff & pon" :-P

I found some similar bug in mailing-list archives but no real
solution. I am going to see PPP sources : perhaps file descriptor
ppp_dev_fd seems not to be reset to -1 in make_ppp_unit() when my
ISP reset his connection every 24 hours...

All ideas are welcome !



My PPP(oA) configuration is classic.

file /etc/ppp/peers/dsl-provider :

***
# ISP login
user "foo@bar"

# Load the PPPoA plugin
plugin /usr/lib/pppd/2.4.3/pppoatm.so

# VP.VC pair used by your ISP
8.35

# perhaps a bug with PMTU IPv6
mtu 1492
mru 1492
***


file /etc/ppp/options :

***
lock
noipdefault
noauth
hide-password
lcp-echo-interval 20
lcp-echo-failure 3
persist
holdoff 10
debug
ipv6 ,
***


My lspci message for PCI card :

0000:00:0e.0 ATM network controller: STMicroelectronics ST70137
[Unicorn] ADSL DMT Transceiver (rev 10)



Thanks,
--
Gregory Colpart <reg@evolix.fr>  GnuPG:1024D/C1027A0E
Evolix - Informatique et Logiciels Libres http://www.evolix.fr

Re: Error message with persist option

[Marco d'Itri]

[-- Attachment #1: Type: text/plain, Size: 313 bytes --]

On Oct 26, Gregory Colpart <gcolpart@evolix.net> wrote:

> I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
This version of pppd is buggy. I have been told that this bug has been
fixed in the latest upstream release, but I had no time to verify this
and package it yet.

-- 
ciao,
Marco

[-- Attachment #2: Digital signature --]
[-- Type: application/pgp-signature, Size: 189 bytes --]

Re: Error message with persist option

[Gilles Espinasse]

----- Original Message ----- 
From: "Gregory Colpart" <gcolpart@evolix.net>
To: <linux-ppp@vger.kernel.org>
Sent: Wednesday, October 26, 2005 9:41 PM
Subject: Error message with persist option


> Hello,
>
> I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
> My DSL connnection is PPPoA with a modem PCI card Bewan ST
> (unicorn driver).
>
with ppp-2.4.3 version, is it the debian package or standard ppp-2.4.3
There is numerous ppp-2.4.3 flavour including some patches wich may help.
You should try with the debian package or with ppp-2.4.4b1 wich should
include all those fixes.
http://bugs.debian.org/cgi-bin/pkgreport.cgi?pkg=ppp
ftp://ftp.samba.org/pub/ppp/ppp-2.4.4b1.tar.gz

> When I pon/poff, it works fine. But every 24 hours, my ISP reset
> my connection and persist option fails to reactivate it.
>
>
> See my debug messages :
>
> * End of connection
>
> 21:00:03 pppd[29191]: rcvd [LCP TermReq id=0xe7]
> 21:00:03 pppd[29191]: LCP terminated by peer
> 21:00:03 pppd[29191]: Connect time 1440.0 minutes.
> 21:00:03 pppd[29191]: Sent 410466878 bytes, received 450988023
> bytes.
> 21:00:03 pppd[29191]: Script /etc/ppp/ip-down started (pid 31487)
> 21:00:03 pppd[29191]: Script /etc/ppp/ipv6-down started (pid
> 31488)
> 21:00:03 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
> 21:00:03 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
I don't know for ipv6 but with ipv4,you could remove MTU/MRU\x1492
This is only necessary with PPPoE and not PPPoA

Gilles

Re: Error message with persist option

[Gregory Colpart]

On Wed, Oct 26, 2005 at 09:45:51PM +0200, Marco d'Itri wrote:
> 
> > I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
> This version of pppd is buggy. I have been told that this bug has been
> fixed in the latest upstream release, but I had no time to verify this
> and package it yet.

Okay. I will verify if version 2.4.4b1 fix my bug and package it.
I will forward you my experimental packages asap.

Thanks,
-- 
Gregory Colpart <reg@evolix.fr>  GnuPG:1024D/C1027A0E
Evolix - Informatique et Logiciels Libres http://www.evolix.fr

Re: Error message with persist option

[Bill Unruh]

persist is NOT a generic "redialup and reconnect" option, but is an attempt
by pppd to maintain a connection when something goes wrong. What seems to
be happening in you case is that the remote side has hung up on you. There
is not connection from your modem to theirs anymore. What yo uneed to do is
to redialup and connect again. Ie, you need to rerun the ppon script again. 
What you probably want to do is in the /etc/ppp/ip-down script is to put an
at command which tells it to run ppon again in 1 or 5 min.

Eg, at the end of that script put something like

at +1 min <<EOF
ppon
EOF

Of course this means that each time pppd goes down, it will try to come up
again, and there is little you can do except run atrm in that one min time
frame ( or change the permissions on the ip-down script or remove that
line. Of course you could put a counter into ppon so that if it tries say
more than 3 times in 5 min, it stops trying.)


I am not positive that this will work, but it is an idea to try.


On Wed, 26 Oct 2005, Gregory Colpart wrote:

> Hello,
>
> I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
> My DSL connnection is PPPoA with a modem PCI card Bewan ST
> (unicorn driver).
>
> When I pon/poff, it works fine. But every 24 hours, my ISP reset
> my connection and persist option fails to reactivate it.
>
>
> See my debug messages :
>
> * End of connection
>
> 21:00:03 pppd[29191]: rcvd [LCP TermReq id=0xe7]
> 21:00:03 pppd[29191]: LCP terminated by peer
> 21:00:03 pppd[29191]: Connect time 1440.0 minutes.
> 21:00:03 pppd[29191]: Sent 410466878 bytes, received 450988023
> bytes.
> 21:00:03 pppd[29191]: Script /etc/ppp/ip-down started (pid 31487)
> 21:00:03 pppd[29191]: Script /etc/ppp/ipv6-down started (pid
> 31488)
> 21:00:03 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
> 21:00:03 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
> 21:00:03 pppd[29191]: sent [LCP TermAck id=0xe7]
> 21:00:03 pppd[29191]: Script /etc/ppp/ipv6-down finished (pid
> 31488), status = 0x0
> 21:00:03 pppd[29191]: Script /etc/ppp/ip-down finished (pid
> 31487), status = 0x0
> 21:00:06 pppd[29191]: Connection terminated.
> 21:00:06 pppd[29191]: Connect time 1440.0 minutes.
> 21:00:06 pppd[29191]: Sent 410466878 bytes, received 450988023
> bytes.
> 21:00:06 pppd[29191]: using channel 933
> 21:00:06 pppd[29191]: Using interface ppp0
> 21:00:06 pppd[29191]: Connect: ppp0 <--> 8.35
> 21:00:06 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
> 21:00:06 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
> 21:00:07 pppd[29191]: sent [LCP ConfReq id=0x4 <mru 1492> <magic
> 0x465bebe1>]
> 21:00:07 pppd[29191]: Modem hangup
>
> * try to reconnect with persist option
>
> 21:00:17 pppd[29191]: using channel 934
> 21:00:17 pppd[29191]: in make_ppp_unit, already had /dev/ppp
> open?
> 21:00:17 pppd[29191]: Using interface ppp0
> 21:00:17 pppd[29191]: Connect: ppp0 <--> 8.35
> 21:00:17 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
> 21:00:17 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
> 21:00:17 pppd[29191]: sent [LCP ConfReq id=0x5 <mru 1492> <magic
> 0x252c61a9>]
> 21:00:44 last message repeated 9 times
> 21:00:47 pppd[29191]: LCP: timeout sending Config-Requests
> 21:00:47 pppd[29191]: Connection terminated.
> 21:00:47 pppd[29191]: Modem hangup
>
> * another chance
>
> 21:00:47 pppd[29191]: using channel 935
> 21:00:47 pppd[29191]: Using interface ppp0
> 21:00:47 pppd[29191]: Connect: ppp0 <--> 8.35
> 21:00:47 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
> 21:00:47 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
> 21:00:47 pppd[29191]: sent [LCP ConfReq id=0x6 <mru 1492> <magic
> 0xf00f7f8c>]
> 21:00:47 pppd[29191]: Connection terminated.
> 21:00:47 pppd[29191]: sent [LCP TermReq id=0x7]
> 21:00:47 pppd[29191]: write: Bad file descriptor (9)
> 21:00:50 pppd[29191]: sent [LCP TermReq id=0x8]
> 21:00:50 pppd[29191]: write: Bad file descriptor (9)
> 21:00:53 pppd[29191]: Connection terminated.
> 21:00:53 pppd[29191]: sent [LCP ConfReq id=0x9 <mru 1492> <magic
> 0x9c6381e4>]
> 21:00:53 pppd[29191]: write: Bad file descriptor (9)
> 21:00:53 pppd[29191]: sent [LCP TermReq id=0xa]
> 21:00:53 pppd[29191]: write: Bad file descriptor (9)
> 21:00:56 pppd[29191]: sent [LCP TermReq id=0xb]
> 21:00:56 pppd[29191]: write: Bad file descriptor (9)
> 21:00:59 pppd[29191]: Connection terminated.
> 21:00:59 pppd[29191]: Modem hangup
>
> * another chance
>
> 21:00:59 pppd[29191]: using channel 936
>
> [infinite loop]
>
>
>
> If I "poff & pon", all is right !
> My temporary solution is a crontab script with "poff & pon" :-P
>
> I found some similar bug in mailing-list archives but no real
> solution. I am going to see PPP sources : perhaps file descriptor
> ppp_dev_fd seems not to be reset to -1 in make_ppp_unit() when my
> ISP reset his connection every 24 hours...
>
> All ideas are welcome !
>
>
>
> My PPP(oA) configuration is classic.
>
> file /etc/ppp/peers/dsl-provider :
>
> ***
> # ISP login
> user "foo@bar"
>
> # Load the PPPoA plugin
> plugin /usr/lib/pppd/2.4.3/pppoatm.so
>
> # VP.VC pair used by your ISP
> 8.35
>
> # perhaps a bug with PMTU IPv6
> mtu 1492
> mru 1492
> ***
>
>
> file /etc/ppp/options :
>
> ***
> lock
> noipdefault
> noauth
> hide-password
> lcp-echo-interval 20
> lcp-echo-failure 3
> persist
> holdoff 10
> debug
> ipv6 ,
> ***
>
>
> My lspci message for PCI card :
>
> 0000:00:0e.0 ATM network controller: STMicroelectronics ST70137
> [Unicorn] ADSL DMT Transceiver (rev 10)
>
>
>
> Thanks,
> --
> Gregory Colpart <reg@evolix.fr>  GnuPG:1024D/C1027A0E
> Evolix - Informatique et Logiciels Libres http://www.evolix.fr
>
> -
> To unsubscribe from this list: send the line "unsubscribe linux-ppp" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at  http://vger.kernel.org/majordomo-info.html
>

-- 
William G. Unruh   |  Canadian Institute for|     Tel: +1(604)822-3273
Physics&Astronomy  |     Advanced Research  |     Fax: +1(604)822-5324
UBC, Vancouver,BC  |   Program in Cosmology |     unruh@physics.ubc.ca
Canada V6T 1Z1     |      and Gravity       |  www.theory.physics.ubc.ca/

Re: Error message with persist option

[Gregory Colpart]

On Wed, Oct 26, 2005 at 10:18:18PM +0200, Gilles Espinasse wrote:
> with ppp-2.4.3 version, is it the debian package or standard ppp-2.4.3
> There is numerous ppp-2.4.3 flavour including some patches wich may help.
> You should try with the debian package or with ppp-2.4.4b1 wich should
> include all those fixes.

Yes, I use debian package then debian patches and this doesn't
fix my bug. I will try with version 2.4.4b1.

> > 21:00:03 pppd[29191]: Couldn't increase MTU to 1500. Using 1492
> > 21:00:03 pppd[29191]: Couldn't increase MRU to 1500. Using 1492
> I don't know for ipv6 but with ipv4,you could remove MTU/MRU\x1492
> This is only necessary with PPPoE and not PPPoA

Yes, no problem with IPv4. I use MTU/MRU\x1492 for IPv6 because I have
a problem with PMTU Discovery. PMTU Discovery works fine when I use
tracepath6 util but with real IPv6 connection, it seems broken...
I have no time to investigate this problem yet. 

Thanks,
-- 
Gregory Colpart <reg@evolix.fr>  GnuPG:1024D/C1027A0E
Evolix - Informatique et Logiciels Libres http://www.evolix.fr

Re: Error message with persist option

[Clifford Kite]

On Wed, 26 Oct 2005, Gregory Colpart wrote:

|I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
|My DSL connnection is PPPoA with a modem PCI card Bewan ST
|(unicorn driver).
|
|When I pon/poff, it works fine. But every 24 hours, my ISP reset
|my connection and persist option fails to reactivate it.

My two cents:  I think Bill Unruh is correct, i.e., persist only
works when a PPP link has gone down but the physical layer remains
functional.  A workaround such as you and Unruh described is likely
required to automatically reestablish the physical layer after the
ISP hangup and then the PPP link.

---
Clifford Kite

Re: Error message with persist option

[Gilles Espinasse]

----- Original Message ----- 
From: "Clifford Kite" <kite_linux-ppp@ev1.net>
To: "Gregory Colpart" <gcolpart@evolix.net>
Cc: <linux-ppp@vger.kernel.org>
Sent: Thursday, October 27, 2005 5:48 PM
Subject: Re: Error message with persist option


> On Wed, 26 Oct 2005, Gregory Colpart wrote:
>
> |I have a i386 Debian 3.1 box with a kernel 2.4.30 and pppd 2.4.3
> |My DSL connnection is PPPoA with a modem PCI card Bewan ST
> |(unicorn driver).
> |
> |When I pon/poff, it works fine. But every 24 hours, my ISP reset
> |my connection and persist option fails to reactivate it.
>
> My two cents:  I think Bill Unruh is correct, i.e., persist only
> works when a PPP link has gone down but the physical layer remains
> functional.  A workaround such as you and Unruh described is likely
> required to automatically reestablish the physical layer after the
> ISP hangup and then the PPP link.
>
modem is still synchronized, atm link remain, is it not the physical layer?

Such PPPoA case was working well  for me with ppp-2.4.1 and a pppoatm.so
plugin.
But as there was sometime a problem with pppoe (and some usb modem driver
don't know to synchronise by themself, some other time usb harware has bug),
I made an ugly hack wich is a bit more complicated than restart the
connection when it goes down.
http://cvs.sourceforge.net/viewcvs.py/ipcop/ipcop/src/rc.d/Attic/rc.connectioncheck?rev=1.4.2.22&only_with_tag=IPCOP_v1_4_0&view=markup

It is a sum of various hack, it may have some races, it is not very
interactive user friendly due to the numerous wait.
But it does reconnect in every cases I know (ppp-2.4.3 is used without
persist option).

Gilles

Re: Error message with persist option

[Clifford Kite]

On Thu, 27 Oct 2005, Gilles Espinasse wrote:

|----- Original Message ----- 
|From: "Clifford Kite" <kite_linux-ppp@ev1.net>
|To: "Gregory Colpart" <gcolpart@evolix.net>

|> My two cents:  I think Bill Unruh is correct, i.e., persist only
|> works when a PPP link has gone down but the physical layer remains
|> functional.  A workaround such as you and Unruh described is likely
|> required to automatically reestablish the physical layer after the
|> ISP hangup and then the PPP link.
|>
|modem is still synchronized, atm link remain, is it not the physical layer?

Yes, but after the reset is it functional in the sense of the ISP
recognizing as such?  Do identifiers, e.g., endpoint MACs, session
ID as in PPPoE, need to be reestablished?  In the log pppd reported
a "Modem hangup," which for a regular modem means the data mode is
lost and needs to be renegotiated.

|Such PPPoA case was working well  for me with ppp-2.4.1 and a pppoatm.so
|plugin.

Okay, that appears to be a counter-example, and irrefutable by me since
I've never used PPPoA.  Perhaps buried in the pppd, or pppoatm.so, code
_is_ a mechanism for bringing physical layer functionality back when
persist is used.

---
Clifford Kite