Date: Mon, 7 Sep 1998 09:16:36 +0200 (MEST) From: Christoph Kukulies <kuku@gilberto.physik.RWTH-Aachen.DE> To: freebsd-questions@freefall.cdrom.com Subject: my pppd problem with a linux machine Message-ID: <199809070716.JAA06293@gilberto.physik.RWTH-Aachen.DE>
next in thread | raw e-mail | index | archive | help
I'm coming closer to get that lasting problem solved - a linux user
could not get a ppp connection from my pppd dialup server.
The picture now is the following:
log from linux side:
>
>
> Sep 6 22:59:18 rabbertz-rem su: (to root) rabbertz on /dev/ttyp5
> Sep 6 22:59:51 rabbertz-rem kernel: PPP: version 2.2.0 (dynamic channel allocation)
> Sep 6 22:59:51 rabbertz-rem kernel: PPP Dynamic channel allocation code copyright 1995 Caldera, Inc.
> Sep 6 22:59:51 rabbertz-rem kernel: PPP line discipline registered.
> Sep 6 22:59:51 rabbertz-rem kernel: registered device ppp0
> Sep 6 22:59:52 rabbertz-rem syslog: IPX support is not present in the kernel
> Sep 6 22:59:52 rabbertz-rem pppd[619]: pppd 2.2.0 started by root, uid 0
> Sep 6 22:59:53 rabbertz-rem chat[626]: timeout set to 5 seconds
> Sep 6 22:59:53 rabbertz-rem chat[626]: abort on (\nBUSY\r)
> Sep 6 22:59:53 rabbertz-rem chat[626]: abort on (\nNO CARRIER\r)
> Sep 6 22:59:53 rabbertz-rem chat[626]: abort on (\nRING\r\n\r\nRING\r)
> Sep 6 22:59:53 rabbertz-rem chat[626]: abort on (\nNO DIALTONE\r)
> Sep 6 22:59:53 rabbertz-rem chat[626]: abort on (\nERROR\r)
> Sep 6 22:59:53 rabbertz-rem chat[626]: send (+++ATZ^M)
> Sep 6 22:59:54 rabbertz-rem chat[626]: expect (OK)
> Sep 6 22:59:54 rabbertz-rem chat[626]: ATZ^M^M
> Sep 6 22:59:54 rabbertz-rem chat[626]: OK -- got it
> Sep 6 22:59:54 rabbertz-rem chat[626]: send (AT&FE0^M)
> Sep 6 22:59:54 rabbertz-rem chat[626]: timeout set to 45 seconds
> Sep 6 22:59:54 rabbertz-rem chat[626]: expect (OK)
> Sep 6 22:59:54 rabbertz-rem chat[626]: ^M
> Sep 6 22:59:54 rabbertz-rem chat[626]: AT&FE0^M^M
> Sep 6 22:59:54 rabbertz-rem chat[626]: OK -- got it
> Sep 6 22:59:54 rabbertz-rem chat[626]: send (ATLX4DTXXXXXXXXXX^M)
> Sep 6 22:59:54 rabbertz-rem chat[626]: expect (CONNECT)
> Sep 6 22:59:54 rabbertz-rem chat[626]: ^M
> Sep 6 23:00:00 rabbertz-rem /USR/SBIN/CRON[628]: (root) CMD (test -x /usr/sbin/faxqclean && /usr/sbin/faxqclean)
> Sep 6 23:00:22 rabbertz-rem chat[626]: ^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: CONNECT -- got it
> Sep 6 23:00:22 rabbertz-rem chat[626]: send (^M)
> Sep 6 23:00:22 rabbertz-rem chat[626]: timeout set to 10 seconds
> Sep 6 23:00:22 rabbertz-rem chat[626]: expect (ogin:)
> Sep 6 23:00:22 rabbertz-rem chat[626]: 57600^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: ^M^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: FreeBSD (-----.---------th-aachen.de) (ttyd0)^M^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: ^M^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: login: -- got it
> Sep 6 23:00:22 rabbertz-rem chat[626]: send (........^M)
> Sep 6 23:00:22 rabbertz-rem chat[626]: expect (assword:)
> Sep 6 23:00:22 rabbertz-rem chat[626]: ^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: ^M^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: FreeBSD (-----.---------th-aachen.de) (ttyd0)^M^M
> Sep 6 23:00:22 rabbertz-rem chat[626]: ^M^M
> Sep 6 23:00:23 rabbertz-rem chat[626]: login: ........^M
> Sep 6 23:00:23 rabbertz-rem chat[626]: Password: -- got it
> Sep 6 23:00:23 rabbertz-rem chat[626]: send (........^M)
> Sep 6 23:00:23 rabbertz-rem pppd[619]: Serial connection established.
> Sep 6 23:00:24 rabbertz-rem pppd[619]: Using interface ppp0
> Sep 6 23:00:24 rabbertz-rem kernel: ppp: write frame, count = 28
> Sep 6 23:00:24 rabbertz-rem kernel: FF 03 C0 21 01 01 00 18 ...!....
> Sep 6 23:00:24 rabbertz-rem kernel: 01 04 05 F4 02 06 02 0A ........
> Sep 6 23:00:24 rabbertz-rem kernel: 00 00 05 06 4C 9E C8 01 ....L...
> Sep 6 23:00:24 rabbertz-rem kernel: 07 02 08 02 ....
> Sep 6 23:00:24 rabbertz-rem pppd[619]: Connect: ppp0 <--> /dev/modem
> Sep 6 23:00:24 rabbertz-rem pppd[619]: sent [LCP ConfReq id=0x1 <mru 1524> <asyncmap 0x20a0000> <magic 0x4c9ec801> <pcomp> <accomp>]
> Sep 6 23:00:24 rabbertz-rem pppd[619]: rcvd [LCP ConfReq id=0x1 <mru 1524> <asyncmap 0x20a0000> <magic 0x4c9ec801> <pcomp> <accomp>]
> Sep 6 23:00:24 rabbertz-rem pppd[619]: sent [LCP ConfNak id=0x1 <magic 0x61c6e242>]
> Sep 6 23:00:24 rabbertz-rem kernel: ppp: write frame, count = 14
> Sep 6 23:00:24 rabbertz-rem kernel: FF 03 C0 21 03 01 00 0A ...!....
> Sep 6 23:00:24 rabbertz-rem kernel: 05 06 61 C6 E2 42 ..a..B
> Sep 6 23:00:24 rabbertz-rem kernel: ppp: write frame, count = 28
> Sep 6 23:00:24 rabbertz-rem kernel: FF 03 C0 21 01 02 00 18 ...!....
> Sep 6 23:00:24 rabbertz-rem kernel: 01 04 05 F4 02 06 02 0A ........
> Sep 6 23:00:24 rabbertz-rem kernel: 00 00 05 06 69 C3 BE 42 ....i..B
> Sep 6 23:00:24 rabbertz-rem kernel: 07 02 08 02 ....
> Sep 6 23:00:24 rabbertz-rem kernel: ppp: write frame, count = 14
> Sep 6 23:00:24 rabbertz-rem kernel: FF 03 C0 21 03 02 00 0A ...!....
> Sep 6 23:00:24 rabbertz-rem kernel: 05 06 7D 7F A6 4B ..}..K
> Sep 6 23:00:24 rabbertz-rem pppd[619]: rcvd [LCP ConfNak id=0x1 <magic 0x61c6e242>]
> Sep 6 23:00:24 rabbertz-rem pppd[619]: sent [LCP ConfReq id=0x2 <mru 1524> <asyncmap 0x20a0000> <magic 0x69c3be42> <pcomp> <accomp>]
> Sep 6 23:00:24 rabbertz-rem pppd[619]: rcvd [LCP ConfReq id=0x2 <mru 1524> <asyncmap 0x20a0000> <magic 0x69c3be42> <pcomp> <accomp>]
> Sep 6 23:00:24 rabbertz-rem pppd[619]: sent [LCP ConfNak id=0x2 <magic 0x7d7fa64b>]
> Sep 6 23:00:26 rabbertz-rem kernel: ppp: write frame, count = 12
> Sep 6 23:00:26 rabbertz-rem kernel: FF 03 C0 21 04 01 00 08 ...!....
> Sep 6 23:00:26 rabbertz-rem kernel: 03 04 C0 23 ...#
> Sep 6 23:00:26 rabbertz-rem pppd[619]: rcvd [LCP ConfReq id=0x1 <mru 1524> <auth pap> <magic 0x62521118> <pcomp> <accomp>]
> Sep 6 23:00:26 rabbertz-rem pppd[619]: sent [LCP ConfRej id=0x1 <auth pap>]
> Sep 6 23:00:26 rabbertz-rem pppd[619]: rcvd [LCP ConfReq id=0x2 <mru 1524> <magic 0x62521118> <pcomp> <accomp>]
> Sep 6 23:00:26 rabbertz-rem pppd[619]: sent [LCP ConfAck id=0x2 <mru 1524> <magic 0x62521118> <pcomp> <accomp>]
> Sep 6 23:00:26 rabbertz-rem kernel: ppp: write frame, count = 22
> Sep 6 23:00:26 rabbertz-rem kernel: FF 03 C0 21 02 02 00 12 ...!....
> Sep 6 23:00:26 rabbertz-rem kernel: 01 04 05 F4 05 06 62 52 ......bR
> Sep 6 23:00:26 rabbertz-rem kernel: 11 18 07 02 08 02 ......
> Sep 6 23:00:27 rabbertz-rem kernel: ppp: write frame, count = 28
> Sep 6 23:00:27 rabbertz-rem kernel: FF 03 C0 21 01 02 00 18 ...!....
> Sep 6 23:00:27 rabbertz-rem kernel: 01 04 05 F4 02 06 02 0A ........
> Sep 6 23:00:27 rabbertz-rem kernel: 00 00 05 06 69 C3 BE 42 ....i..B
> Sep 6 23:00:27 rabbertz-rem kernel: 07 02 08 02 ....
> Sep 6 23:00:27 rabbertz-rem pppd[619]: sent [LCP ConfReq id=0x2 <mru 1524> <asyncmap 0x20a0000> <magic 0x69c3be42> <pcomp> <accomp>]
> Sep 6 23:00:27 rabbertz-rem pppd[619]: rcvd [LCP ConfAck id=0x2 <mru 1524> <asyncmap 0x20a0000> <magic 0x69c3be42> <pcomp> <accomp>]
> Sep 6 23:00:27 rabbertz-rem pppd[619]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <compress VJ 0f 01>]
> Sep 6 23:00:27 rabbertz-rem pppd[619]: rcvd [LCP TermReq id=0x3]
> Sep 6 23:00:27 rabbertz-rem pppd[619]: LCP terminated at peer's request
> Sep 6 23:00:27 rabbertz-rem pppd[619]: sent [LCP TermAck id=0x3]
> Sep 6 23:00:27 rabbertz-rem kernel: ppp: write frame, count = 20
> Sep 6 23:00:27 rabbertz-rem kernel: FF 03 80 21 01 01 00 10 ...!....
> Sep 6 23:00:27 rabbertz-rem kernel: 03 06 00 00 00 00 02 06 ........
> Sep 6 23:00:27 rabbertz-rem kernel: 00 2D 0F 01 .-..
> Sep 6 23:00:27 rabbertz-rem kernel: ppp: write frame, count = 8
> Sep 6 23:00:27 rabbertz-rem kernel: FF 03 C0 21 06 03 00 04 ...!....
> Sep 6 23:00:28 rabbertz-rem pppd[619]: Hangup (SIGHUP)
> Sep 6 23:00:28 rabbertz-rem pppd[619]: Modem hangup
> Sep 6 23:00:28 rabbertz-rem pppd[619]: Connection terminated.
> Sep 6 23:00:28 rabbertz-rem pppd[619]: Exit.
> Sep 6 23:01:51 rabbertz-rem kernel: PPP: ppp line discipline successfully unregistered
And the FreeBSD server side - sorry, that I cannot supply more detailed
data at the moment - logging level was very low at that time. I can
supply more if necessary. But maybe it's obvious already to a ppp(d)
expert.
I scaffolded /usr/local/bin/ppplogin.sh with logger messages and found out
that the following line was used to start pppd:
logger "Server address is $LOCAL. Your address is $REMOTE."
exec /usr/sbin/pppd auth login +pap modem $LOCAL:$REMOTE
Sep 6 22:59:43 agate prabbert: Server address is 137.123.12.12. Your address is
137.123.12.2.
Sep 6 22:59:43 agate pppd[1970]: pppd 2.2.0 started by prabbert, uid 2134
Sep 6 22:59:43 agate pppd[1970]: Connect: ppp0 <--> /dev/ttyd0
Sep 6 22:59:44 agate pppd[1970]: peer refused to authenticate
Sep 6 22:59:45 agate pppd[1970]: Connection terminated.
This machines pppd setup works fine with Win95, WinNT and FreeBSD
peers.
--
Chris Christoph P. U. Kukulies kuku@gil.physik.rwth-aachen.de
To Unsubscribe: send mail to majordomo@FreeBSD.org
with "unsubscribe freebsd-questions" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?199809070716.JAA06293>