A friend of mine, running RedHat 6.1 is having problems making PPP
connections to his ISP. It finally works after lots of dial retries, but
can take a long time. There should be a clue in the log entries, but
I can't quite figure it out. I believe he starts the PPP connection with
"ifup ppp0".
When it fails, things look like this
----------------------------------------
Feb 9 08:10:46 scrappy ifup-ppp: pppd started for ppp0 on /dev/modem at 115200
Feb 9 08:10:46 scrappy pppd[17668]: pppd 2.3.7 started by root, uid 0
Feb 9 08:10:47 scrappy chat[17670]: send (ATZ^M)
Feb 9 08:10:47 scrappy chat[17670]: expect (OK)
Feb 9 08:10:47 scrappy chat[17670]: ATZ^M^M
Feb 9 08:10:47 scrappy chat[17670]: OK
Feb 9 08:10:47 scrappy chat[17670]: -- got it
Feb 9 08:10:47 scrappy chat[17670]: send (ATDT714-8111^M)
Feb 9 08:10:48 scrappy chat[17670]: expect (CONNECT)
Feb 9 08:10:48 scrappy chat[17670]: ^M
Feb 9 08:11:14 scrappy chat[17670]: ATDT714-8111^M^M
Feb 9 08:11:14 scrappy chat[17670]: CONNECT
Feb 9 08:11:14 scrappy chat[17670]: -- got it
Feb 9 08:11:14 scrappy chat[17670]: send (^M)
Feb 9 08:11:14 scrappy chat[17670]: expect (ogin:)
Feb 9 08:11:14 scrappy chat[17670]: 115200^M
Feb 9 08:11:21 scrappy chat[17670]: ^M
Feb 9 08:11:21 scrappy chat[17670]:
Feb 9 08:11:21 scrappy last message repeated 23 times
Feb 9 08:11:21 scrappy chat[17670]: Level 3 Comm nas35.bos1.Level3.net UQKT2^M
Feb 9 08:11:21 scrappy chat[17670]: ^M
Feb 9 08:11:21 scrappy chat[17670]: ^M
Feb 9 08:11:21 scrappy chat[17670]: login:
Feb 9 08:11:21 scrappy chat[17670]: -- got it
Feb 9 08:11:21 scrappy chat[17670]: send (hisname^M)
Feb 9 08:11:21 scrappy chat[17670]: expect (ord:)
Feb 9 08:11:21 scrappy chat[17670]: hisname^M
Feb 9 08:11:21 scrappy chat[17670]: Password:
Feb 9 08:11:21 scrappy chat[17670]: -- got it
Feb 9 08:11:21 scrappy chat[17670]: send (hispasswd^M)
Feb 9 08:11:21 scrappy chat[17670]: timeout set to 5 seconds
Feb 9 08:11:21 scrappy chat[17670]: expect (~)
Feb 9 08:11:21 scrappy chat[17670]: ^M
Feb 9 08:11:21 scrappy chat[17670]: Entering PPP Session.^M
Feb 9 08:11:21 scrappy chat[17670]: IP address is 209.6.68.137^M
Feb 9 08:11:21 scrappy chat[17670]: MTU is 1500.^M
Feb 9 08:11:21 scrappy pppd[17668]: Serial connection established.
Feb 9 08:11:21 scrappy pppd[17668]: Using interface ppp0
Feb 9 08:11:21 scrappy pppd[17668]: Connect: ppp0 <--> /dev/modem
Feb 9 08:11:21 scrappy chat[17670]: ~
Feb 9 08:11:21 scrappy chat[17670]: -- got it
Feb 9 08:11:21 scrappy chat[17670]: send (^M)
Feb 9 08:11:26 scrappy modprobe: can't locate module ppp-compress-21
Feb 9 08:11:26 scrappy modprobe: can't locate module ppp-compress-26
Feb 9 08:11:26 scrappy modprobe: can't locate module ppp-compress-24
Feb 9 08:11:26 scrappy pppd[17668]: local IP address 192.168.1.1
Feb 9 08:11:26 scrappy pppd[17668]: remote IP address 209.247.23.37
Feb 9 08:11:27 scrappy pppd[17668]: Modem hangup
Feb 9 08:11:27 scrappy pppd[17668]: Connection terminated.
Feb 9 08:11:27 scrappy pppd[17668]: Connect time 0.1 minutes.
Feb 9 08:11:27 scrappy pppd[17668]: Sent 210 bytes, received 245 bytes.
Feb 9 08:11:27 scrappy pppd[17668]: Exit.
----------------------------------------
Note that it got assigned IP address 209.6.68.137, but the "local IP
address" comes out 192.168.1.1 which is the eth0 address.
At other times when it fails, it looks like this:
----------------------------------------
Feb 9 08:13:01 scrappy ifup-ppp: pppd started for ppp0 on /dev/modem at 115200
Feb 9 08:13:01 scrappy pppd[17812]: pppd 2.3.7 started by root, uid 0
Feb 9 08:13:02 scrappy chat[17814]: send (ATZ^M)
Feb 9 08:13:03 scrappy chat[17814]: expect (OK)
Feb 9 08:13:03 scrappy chat[17814]: ATZ^M^M
Feb 9 08:13:03 scrappy chat[17814]: OK
Feb 9 08:13:03 scrappy chat[17814]: -- got it
Feb 9 08:13:03 scrappy chat[17814]: send (ATDT714-8111^M)
Feb 9 08:13:03 scrappy chat[17814]: expect (CONNECT)
Feb 9 08:13:03 scrappy chat[17814]: ^M
Feb 9 08:13:32 scrappy chat[17814]: ATDT714-8111^M^M
Feb 9 08:13:32 scrappy chat[17814]: CONNECT
Feb 9 08:13:32 scrappy chat[17814]: -- got it
Feb 9 08:13:32 scrappy chat[17814]: send (^M)
Feb 9 08:13:32 scrappy chat[17814]: expect (ogin:)
Feb 9 08:13:32 scrappy chat[17814]: 115200^M
Feb 9 08:13:38 scrappy chat[17814]: ^M
Feb 9 08:13:38 scrappy chat[17814]:
Feb 9 08:13:38 scrappy last message repeated 23 times
Feb 9 08:13:38 scrappy chat[17814]: Level 3 Comm nas35.bos1.Level3.net UQKT2^M
Feb 9 08:13:38 scrappy chat[17814]: ^M
Feb 9 08:13:38 scrappy chat[17814]: ^M
Feb 9 08:13:38 scrappy chat[17814]: login:
Feb 9 08:13:38 scrappy chat[17814]: -- got it
Feb 9 08:13:38 scrappy chat[17814]: send (hisname^M)
Feb 9 08:13:38 scrappy chat[17814]: expect (ord:)
Feb 9 08:13:38 scrappy chat[17814]: hisname^M
Feb 9 08:13:38 scrappy chat[17814]: Password:
Feb 9 08:13:38 scrappy chat[17814]: -- got it
Feb 9 08:13:38 scrappy chat[17814]: send (hispasswd^M)
Feb 9 08:13:38 scrappy chat[17814]: timeout set to 5 seconds
Feb 9 08:13:38 scrappy chat[17814]: expect (~)
Feb 9 08:13:38 scrappy chat[17814]: ^M
Feb 9 08:13:39 scrappy chat[17814]: Entering PPP Session.^M
Feb 9 08:13:39 scrappy chat[17814]: IP address is 209.6.67.21^M
Feb 9 08:13:39 scrappy chat[17814]: MTU is 1500.^M
Feb 9 08:13:39 scrappy chat[17814]: ~
Feb 9 08:13:39 scrappy chat[17814]: -- got it
Feb 9 08:13:39 scrappy chat[17814]: send (^M)
Feb 9 08:13:39 scrappy pppd[17812]: Serial connection established.
Feb 9 08:13:39 scrappy pppd[17812]: Using interface ppp0
Feb 9 08:13:39 scrappy pppd[17812]: Connect: ppp0 <--> /dev/modem
Feb 9 08:13:53 scrappy pppd[17812]: Modem hangup
Feb 9 08:13:53 scrappy pppd[17812]: Connection terminated.
Feb 9 08:13:53 scrappy pppd[17812]: Connect time 0.3 minutes.
Feb 9 08:13:54 scrappy pppd[17812]: Exit.
----------------------------------------
When it finally works (usually after a LARGE number of tries), the local IP
comes out to the one given after "Entering PPP Session":
--------------------------------------------------
Feb 9 08:16:54 scrappy ifup-ppp: pppd started for ppp0 on /dev/modem at 115200
Feb 9 08:16:54 scrappy pppd[18011]: pppd 2.3.7 started by root, uid 0
Feb 9 08:16:55 scrappy chat[18013]: send (ATZ^M)
Feb 9 08:16:55 scrappy chat[18013]: expect (OK)
Feb 9 08:16:55 scrappy chat[18013]: ATZ^M^M
Feb 9 08:16:55 scrappy chat[18013]: OK
Feb 9 08:16:55 scrappy chat[18013]: -- got it
Feb 9 08:16:55 scrappy chat[18013]: send (ATDT714-8111^M)
Feb 9 08:16:55 scrappy chat[18013]: expect (CONNECT)
Feb 9 08:16:55 scrappy chat[18013]: ^M
Feb 9 08:17:22 scrappy chat[18013]: ATDT714-8111^M^M
Feb 9 08:17:22 scrappy chat[18013]: CONNECT
Feb 9 08:17:22 scrappy chat[18013]: -- got it
Feb 9 08:17:22 scrappy chat[18013]: send (^M)
Feb 9 08:17:22 scrappy chat[18013]: expect (ogin:)
Feb 9 08:17:22 scrappy chat[18013]: 115200^M
Feb 9 08:17:29 scrappy chat[18013]: ^M
Feb 9 08:17:29 scrappy chat[18013]:
Feb 9 08:17:29 scrappy last message repeated 23 times
Feb 9 08:17:29 scrappy chat[18013]: Level 3 Comm nas26.bos1.Level3.net UQKT2^M
Feb 9 08:17:29 scrappy chat[18013]: ^M
Feb 9 08:17:29 scrappy chat[18013]: ^M
Feb 9 08:17:29 scrappy chat[18013]: login:
Feb 9 08:17:29 scrappy chat[18013]: -- got it
Feb 9 08:17:29 scrappy chat[18013]: send (hisname^M)
Feb 9 08:17:29 scrappy chat[18013]: expect (ord:)
Feb 9 08:17:29 scrappy chat[18013]: hisname^M
Feb 9 08:17:29 scrappy chat[18013]: Password:
Feb 9 08:17:29 scrappy chat[18013]: -- got it
Feb 9 08:17:29 scrappy chat[18013]: send (hispasswd^M)
Feb 9 08:17:29 scrappy chat[18013]: timeout set to 5 seconds
Feb 9 08:17:29 scrappy chat[18013]: expect (~)
Feb 9 08:17:29 scrappy chat[18013]: ^M
Feb 9 08:17:29 scrappy chat[18013]: Entering PPP Session.^M
Feb 9 08:17:29 scrappy chat[18013]: IP address is 209.6.66.181^M
Feb 9 08:17:29 scrappy chat[18013]: MTU is 1500.^M
Feb 9 08:17:29 scrappy chat[18013]: ~
Feb 9 08:17:29 scrappy pppd[18011]: Serial connection established.
Feb 9 08:17:29 scrappy pppd[18011]: Using interface ppp0
Feb 9 08:17:29 scrappy pppd[18011]: Connect: ppp0 <--> /dev/modem
Feb 9 08:17:29 scrappy chat[18013]: -- got it
Feb 9 08:17:29 scrappy chat[18013]: send (^M)
Feb 9 08:17:34 scrappy modprobe: can't locate module ppp-compress-21
Feb 9 08:17:34 scrappy modprobe: can't locate module ppp-compress-26
Feb 9 08:17:34 scrappy modprobe: can't locate module ppp-compress-24
Feb 9 08:17:37 scrappy pppd[18011]: local IP address 209.6.66.181
Feb 9 08:17:37 scrappy pppd[18011]: remote IP address 209.244.43.218
Feb 9 09:26:00 scrappy pppd[18011]: Modem hangup
Feb 9 09:26:00 scrappy pppd[18011]: Connection terminated.
Feb 9 09:26:00 scrappy pppd[18011]: Connect time 68.6 minutes.
Feb 9 09:26:00 scrappy pppd[18011]: Sent 789 bytes, received 826 bytes.
Feb 9 09:26:00 scrappy pppd[18011]: Exit.
--------------------------------------------------
Any idea why the PPP connection is using the eth0 address MOST of the time,
but not ALL the time? I'd have a better chance of understanding if it
NEVER worked, but when it works one time out of several dozen -- that's
really strange.
All the other machine I have contact with are either on a real LAN or
connected to a cable-modem, so I haven't had any occasion to mess with
PPP for a very long time. Any clues would be welcome.
pete peterson
GenRad, Inc.
7 Technology Park Drive
Westford, MA 01886-0033
[EMAIL PROTECTED] or [EMAIL PROTECTED]
+1-978-589-7478 (GenRad); +1-978-256-5829 (Home: Chelmsford, MA)
+1-978-589-2088 (Closest FAX); +1-978-589-7007 (Main GenRad FAX)
--
To unsubscribe: mail [EMAIL PROTECTED] with "unsubscribe"
as the Subject.
