Re: PPP daemon dies when trying to dial out - fixed

"Luke Sharkey" <lukesharkey@xxxxxxxxxxxxx> · Fri, 20 Jul 2007 13:46:13 +0100

Hi

The short of it is that the problem was with the ISPs I was trying to use -  
I must have just stumbled across a few bad ones in a row and as a 
consequence thought it was my modem malfunctioning.

======

I first tried a few of the no-sign-up ISPs that stated that they were linux 
compatible / specifically for linux use - I think the problem I had with 
them was maybe
   that the slmodem / slamr was interfering with the linuxant driver,
   or perhaps the ISPs were just very busy?  I'm not sure.

I then tried UK free software network pay-as-you-go dialup - this is where I 
ran into the problem of pppd dying.  As it turns out pppd wasn't getting the 
response it expected from the ISP, and so terminated - so nothing wrong with 
pppd.

As a consequence, to anyone in the UK I certainly wouldn't recommend UK free 
software network dialup.

Thanks for your help,
LS

From: Jacques Goldberg <Jacques.Goldberg@xxxxxxx>
To: Luke Sharkey <lukesharkey@xxxxxxxxxxxxx>
CC: discuss@xxxxxxxxxxxxx
Subject: Re: PPP daemon dies when trying to dial out
Date: Wed, 18 Jul 2007 19:16:40 +0300

Luke,

First of all, your modem works and the problem is with the way pppd tries 
to start, not with the modem, and not with the hardware.

I do not know if this will help, because many independent situations can 
create SIGNAL 15 seen in the pppd log (signal 16 issued by wvdial simple 
means, go into pppd log to see why).

Try once by disabling New PPPD in wvdial.conf (just add ;  at the beginning 
of the line)
Likewise, try activating
Stupid Mode = yes
first with New PPPD then without it.

If all that fails, edit /etc/ppp/options
You probably will not see a line   asyncmap  because the asyncmap default 
is zero.
If my guess is right, add this line and try again:
asyncmap FFFFFFFF   (that is 8 times the letter F).

And let us know the result

Jacques

Luke Sharkey wrote:
Hi

Here is the wvdial.conf .
As to the ppp log, I did edit out my username and replace it with "user", 
which I have also done with wvdial.conf.

Thanks
LS

From: Jacques Goldberg <Jacques.Goldberg@xxxxxxx>
Reply-To: discuss@xxxxxxxxxxxxx
To: Luke Sharkey <lukesharkey@xxxxxxxxxxxxx>
CC: discuss@xxxxxxxxxxxxx
Subject: Re: PPP daemon dies when trying to dial out
Date: Wed, 18 Jul 2007 18:31:41 +0300

Luke,
Would you please:
1 copy /etc/wvdial.conf to wvdial.txt
2 edit wvdial.txt to remove or hide your password (make it ZZZZ for 
example)
3 send us the so edited  wvdial.txt

Indeed the ppp log shows an attempt to logon as "user"
Is that the username given to you by your ISP?
With the file wvdial.txt I can possibly help you, but make sure to hide 
your password before sending it out.

Jacques

Luke Sharkey wrote:
Hi

I installed the linuxant hfs driver for my connexant modem but am now 
having problems when trying to dial out - I've been trying with both 
wvdial and also kppp.  The typical sort of *basic* error message I was 
getting with kppp was like this:

Couldn't find interface ppp0: No such device

when I looked at /var/log/messages I saw that pppd kept dying for some 
reason (see attached varlogmessages.txt).

One weird thing I noticed is that pppd terminated with a signal 16 on 
wvdial and a signal 15 on kppp.
Otherwise the problems with both of them seemed similar to me.

I have attached the kppp generated bugfile (PPP-logfile2.txt), the 
wvdial log file (wvdial-logfile.txt) and also relevant sections from 
/var/log/messages (varlogmessages.txt).

What could be going wrong with pppd?

Thanks,
Luke S

_________________________________________________________________
Watch all 9 Live Earth concerts live on MSN.  
http://liveearth.uk.msn.com
user@mycomputer:~$ sudo wvdial
Password:
--> WvDial: Internet dialer version 1.56
--> Initializing modem.
--> Sending: ATZ
ATZ
OK
--> Sending: ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
OK
--> Modem initialized.
--> Sending: ATDT08456040875
--> Waiting for carrier.
ATDT08456040875
CONNECT 460800
--> Carrier detected.  Waiting for prompt.
~[7f]}#@!}!}!} &}"}&} }*} } 
}#}%B#}%}%}&},l`C}'}"}(}"}1}$}%t}3})}!BTMDIP}"_~
--> PPP negotiation detected.
--> Starting pppd at Tue Jul 17 21:18:59 2007
--> Pid of pppd: 5833
--> Using interface ppp0
--> Disconnecting at Tue Jul 17 21:19:21 2007
--> The PPP daemon has died: A modem hung up the phone (exit code = 16)
--> man pppd explains pppd error codes in more detail.
--> Try again and look into /var/log/messages and the wvdial and pppd 
man pages for more information.
--> Auto Reconnect will be attempted in 5 seconds
--> Initializing modem.
--> Sending: ATZ
ATZ
OK
--> Sending: ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
OK
--> Modem initialized.
--> Initializing modem.
--> Sending: ATZ
ATZ
OK
--> Sending: ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
OK
--> Modem initialized.
--> Sending: ATDT08456040875
--> Waiting for carrier.
ATDT08456040875
Caught signal 2:  Attempting to exit gracefully...
--> Disconnecting at Tue Jul 17 21:19:28 2007

Jul 17 21:07:54 mycomputer pppd[6015]: pppd 2.4.4 started by root, uid 0
Jul 17 21:07:55 mycomputer chat[6043]: timeout set to 60 seconds
Jul 17 21:07:55 mycomputer chat[6043]: abort on (ERROR)
Jul 17 21:07:55 mycomputer chat[6043]: abort on (BUSY)
Jul 17 21:07:55 mycomputer chat[6043]: abort on (VOICE)
Jul 17 21:07:55 mycomputer chat[6043]: abort on (NO CARRIER)
Jul 17 21:07:55 mycomputer chat[6043]: abort on (NO DIALTONE)
Jul 17 21:07:55 mycomputer chat[6043]: abort on (NO DIAL TONE)
Jul 17 21:07:55 mycomputer chat[6043]: abort on (NO ANSWER)
Jul 17 21:07:55 mycomputer chat[6043]: send (ATZ^M)
Jul 17 21:07:55 mycomputer chat[6043]: send (AT&FH0L3^M)
Jul 17 21:07:55 mycomputer chat[6043]: expect (OK)
Jul 17 21:07:55 mycomputer chat[6043]: ATZ^M^M
Jul 17 21:07:55 mycomputer chat[6043]: OK
Jul 17 21:07:55 mycomputer chat[6043]:  -- got it
Jul 17 21:07:55 mycomputer chat[6043]: send (ATDP08456040875^M)
Jul 17 21:07:55 mycomputer chat[6043]: timeout set to 75 seconds
Jul 17 21:07:55 mycomputer chat[6043]: expect (CONNECT)
Jul 17 21:07:55 mycomputer chat[6043]: ^M
Jul 17 21:07:55 mycomputer chat[6043]: AT&FH0L3^M^M
Jul 17 21:07:55 mycomputer chat[6043]: OK^M
Jul 17 21:07:58 mycomputer gconfd (root-5837): GConf server is not in 
use, shutting down.
Jul 17 21:07:58 mycomputer gconfd (root-5837): Exiting
Jul 17 21:08:09 mycomputer pppd[6015]: Exit.
Jul 17 21:08:34 mycomputer pppd[6172]: pppd 2.4.4 started by root, uid 0
Jul 17 21:08:35 mycomputer chat[6185]: timeout set to 60 seconds
Jul 17 21:08:35 mycomputer chat[6185]: abort on (ERROR)
Jul 17 21:08:35 mycomputer chat[6185]: abort on (BUSY)
Jul 17 21:08:35 mycomputer chat[6185]: abort on (VOICE)
Jul 17 21:08:35 mycomputer chat[6185]: abort on (NO CARRIER)
Jul 17 21:08:35 mycomputer chat[6185]: abort on (NO DIALTONE)
Jul 17 21:08:35 mycomputer chat[6185]: abort on (NO DIAL TONE)
Jul 17 21:08:35 mycomputer chat[6185]: abort on (NO ANSWER)
Jul 17 21:08:35 mycomputer chat[6185]: send (ATZ^M)
Jul 17 21:08:36 mycomputer chat[6185]: send (AT&FH0L3^M)
Jul 17 21:08:36 mycomputer chat[6185]: expect (OK)
Jul 17 21:08:36 mycomputer chat[6185]: ATZ^M^M
Jul 17 21:08:36 mycomputer chat[6185]: OK
Jul 17 21:08:36 mycomputer chat[6185]:  -- got it
Jul 17 21:08:36 mycomputer chat[6185]: send (ATDP08456040875^M)
Jul 17 21:08:36 mycomputer chat[6185]: timeout set to 75 seconds
Jul 17 21:08:36 mycomputer chat[6185]: expect (CONNECT)
Jul 17 21:08:36 mycomputer chat[6185]: ^M
Jul 17 21:08:36 mycomputer chat[6185]: AT&FH0L3^M^M
Jul 17 21:08:36 mycomputer chat[6185]: OK^M
Jul 17 21:09:09 mycomputer chat[6185]: ATDP08456040875^M^M
Jul 17 21:09:09 mycomputer chat[6185]: CONNECT
Jul 17 21:09:09 mycomputer chat[6185]:  -- got it
Jul 17 21:09:09 mycomputer pppd[6172]: Serial connection established.
Jul 17 21:09:10 mycomputer pppd[6172]: Using interface ppp0
Jul 17 21:09:10 mycomputer pppd[6172]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:09:27 mycomputer pppd[6172]: Terminating on signal 15
Jul 17 21:09:27 mycomputer pppd[6172]: Connection terminated.
Jul 17 21:09:27 mycomputer pppd[6172]: Exit.

= = = = = = =

Jul 17 21:12:43 mycomputer kernel: [   96.965502] PPP generic driver 
version 2.4.2
Jul 17 21:12:43 mycomputer pppd[5674]: pppd 2.4.4 started by user, uid 
1000
Jul 17 21:12:43 mycomputer pppd[5674]: Using interface ppp0
Jul 17 21:12:43 mycomputer pppd[5674]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:13:06 mycomputer pppd[5674]: Terminating on signal 15
Jul 17 21:13:06 mycomputer pppd[5674]: Connection terminated.
Jul 17 21:13:06 mycomputer pppd[5674]: Exit.
Jul 17 21:13:32 mycomputer pppd[5701]: pppd 2.4.4 started by user, uid 
1000
Jul 17 21:13:32 mycomputer pppd[5701]: Using interface ppp0
Jul 17 21:13:32 mycomputer pppd[5701]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:14:02 mycomputer pppd[5701]: Terminating on signal 15
Jul 17 21:14:02 mycomputer pppd[5701]: Connection terminated.
Jul 17 21:14:02 mycomputer pppd[5701]: Exit.
Jul 17 21:15:12 mycomputer pppd[5720]: pppd 2.4.4 started by user, uid 
1000
Jul 17 21:15:12 mycomputer pppd[5720]: Using interface ppp0
Jul 17 21:15:12 mycomputer pppd[5720]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:15:42 mycomputer pppd[5720]: Terminating on signal 15
Jul 17 21:15:42 mycomputer pppd[5720]: Connection terminated.
Jul 17 21:15:42 mycomputer pppd[5720]: Exit.
Jul 17 21:16:40 mycomputer pppd[5756]: pppd 2.4.4 started by user, uid 
1000
Jul 17 21:16:40 mycomputer pppd[5756]: Using interface ppp0
Jul 17 21:16:40 mycomputer pppd[5756]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:17:02 mycomputer pppd[5756]: Modem hangup
Jul 17 21:17:02 mycomputer pppd[5756]: Connection terminated.
Jul 17 21:17:02 mycomputer pppd[5756]: Exit.
Jul 17 21:17:36 mycomputer pppd[5792]: pppd 2.4.4 started by root, uid 0
Jul 17 21:17:36 mycomputer pppd[5792]: Using interface ppp0
Jul 17 21:17:36 mycomputer pppd[5792]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:17:58 mycomputer pppd[5792]: Modem hangup
Jul 17 21:17:58 mycomputer pppd[5792]: Connection terminated.
Jul 17 21:17:58 mycomputer pppd[5792]: Exit.
Jul 17 21:15:12 mycomputer pppd[5720]: pppd 2.4.4 started by user, uid 
1000
Jul 17 21:15:12 mycomputer pppd[5720]: using channel 3
Jul 17 21:15:12 mycomputer pppd[5720]: Using interface ppp0
Jul 17 21:15:12 mycomputer pppd[5720]: Connect: ppp0 <--> /dev/ttySHSF0
Jul 17 21:15:12 mycomputer pppd[5720]: sent [LCP ConfReq id=0x1 
<asyncmap 0x0> <magic 0x3c20ca12> <pcomp> <accomp>]
Jul 17 21:15:14 mycomputer pppd[5720]: rcvd [LCP ConfReq id=0x1 
<asyncmap 0xa0000> <auth chap MD5> <magic 0xce8f472> <pcomp> <accomp> 
<mrru 1524> <endpoint [local:42.54.4d.44.49.50]>]
Jul 17 21:15:14 mycomputer pppd[5720]: sent [LCP ConfRej id=0x1 <mrru 
1524>]
Jul 17 21:15:15 mycomputer pppd[5720]: rcvd [LCP ConfReq id=0x2 
<asyncmap 0xa0000> <auth chap MD5> <magic 0xce8f472> <pcomp> <accomp> 
<endpoint [local:42.54.4d.44.49.50]>]
Jul 17 21:15:15 mycomputer pppd[5720]: sent [LCP ConfNak id=0x2 <auth 
chap MS-v2>]
Jul 17 21:15:15 mycomputer pppd[5720]: sent [LCP ConfReq id=0x1 
<asyncmap 0x0> <magic 0x3c20ca12> <pcomp> <accomp>]
Jul 17 21:15:15 mycomputer pppd[5720]: rcvd [LCP ConfReq id=0x3 
<asyncmap 0xa0000> <auth pap> <magic 0xce8f472> <pcomp> <accomp> 
<endpoint [local:42.54.4d.44.49.50]>]
Jul 17 21:15:15 mycomputer pppd[5720]: sent [LCP ConfAck id=0x3 
<asyncmap 0xa0000> <auth pap> <magic 0xce8f472> <pcomp> <accomp> 
<endpoint [local:42.54.4d.44.49.50]>]
Jul 17 21:15:15 mycomputer pppd[5720]: rcvd [LCP ConfAck id=0x1 
<asyncmap 0x0> <magic 0x3c20ca12> <pcomp> <accomp>]
Jul 17 21:15:15 mycomputer pppd[5720]: sent [LCP EchoReq id=0x0 
magic=0x3c20ca12]
Jul 17 21:15:15 mycomputer pppd[5720]: sent [PAP AuthReq id=0x1 
user="user" password=<hidden>]
Jul 17 21:15:15 mycomputer pppd[5720]: rcvd [LCP EchoRep id=0x0 
magic=0xce8f472]
Jul 17 21:15:18 mycomputer pppd[5720]: sent [PAP AuthReq id=0x2 
user="user" password=<hidden>]
Jul 17 21:15:21 mycomputer pppd[5720]: sent [PAP AuthReq id=0x3 
user="user" password=<hidden>]
Jul 17 21:15:24 mycomputer pppd[5720]: sent [PAP AuthReq id=0x4 
user="user" password=<hidden>]
Jul 17 21:15:27 mycomputer pppd[5720]: sent [PAP AuthReq id=0x5 
user="user" password=<hidden>]
Jul 17 21:15:30 mycomputer pppd[5720]: sent [PAP AuthReq id=0x6 
user="user" password=<hidden>]
Jul 17 21:15:33 mycomputer pppd[5720]: sent [PAP AuthReq id=0x7 
user="user" password=<hidden>]
Jul 17 21:15:36 mycomputer pppd[5720]: sent [PAP AuthReq id=0x8 
user="user" password=<hidden>]
Jul 17 21:15:39 mycomputer pppd[5720]: sent [PAP AuthReq id=0x9 
user="user" password=<hidden>]
Jul 17 21:15:42 mycomputer pppd[5720]: Terminating on signal 15
Jul 17 21:15:42 mycomputer pppd[5720]: sent [LCP TermReq id=0x2 "User 
request"]
Jul 17 21:15:42 mycomputer pppd[5720]: rcvd [LCP TermAck id=0x2]
Jul 17 21:15:42 mycomputer pppd[5720]: Connection terminated.
Jul 17 21:15:42 mycomputer pppd[5720]: Exit.

_________________________________________________________________
Tell MSN about your most memorable emails!  http://www.emailbritain.co.uk/

_________________________________________________________________
Watch all 9 Live Earth concerts live on MSN.  http://liveearth.uk.msn.com