Re: diald/pppd refused connection--PAP auth?
On Thu, Jun 15, 2000 at 05:12:11PM +0100, David Wright wrote:
> Quoting Kenward Vaughan (kaynjay@igalaxy.net):
...
> > OK, but running with noauth gives a more simplified pppd message saying:
> >
> > LCP terminated by peer
> That suggests that LCP protocol is being exchanged because the peer
> (other end) is saying go away.
...
> I think you should add "debug" to your options file (either the master
...
I've attached syslog files for both diald and pon with debugging. I can see
some obvious differences in the two just in the "language" formatting, but
it's very Greek to me otherwise. Pap authorization was set for pon using
pppconfig.
Kenward
--
Hi! I'm a .signature virus! Copy me into your ~/.signature, please!
--
Jun 16 08:30:04 kaynjay diald[1458]: filter accepted rule 31 proto tcp len 60 seq e792fab7 ack 0 flags SYN packet 192.168.0.1,1175 => 63.196.172.20,110
Jun 16 08:30:04 kaynjay diald[1458]: Trigger: tcp 192.168.0.1/1175 63.196.172.20/110
Jun 16 08:30:04 kaynjay diald[1458]: new state CONNECT action 0x8050dc0 timeout 90
Jun 16 08:30:04 kaynjay diald[1458]: Calling site 194.109.2.10
Jun 16 08:30:05 kaynjay diald[1458]: running '/usr/sbin/chat -v -f /etc/chatscripts/provider'
Jun 16 08:30:05 kaynjay chat[1598]: abort on (BUSY)
Jun 16 08:30:05 kaynjay chat[1598]: abort on (NO CARRIER)
Jun 16 08:30:05 kaynjay chat[1598]: abort on (VOICE)
Jun 16 08:30:05 kaynjay chat[1598]: abort on (NO DIALTONE)
Jun 16 08:30:05 kaynjay chat[1598]: abort on (NO DIAL TONE)
Jun 16 08:30:05 kaynjay chat[1598]: abort on (NO ANSWER)
Jun 16 08:30:05 kaynjay chat[1598]: send (ATZ^M)
Jun 16 08:30:06 kaynjay chat[1598]: expect (OK)
Jun 16 08:30:06 kaynjay chat[1598]: ATZ^M^M
Jun 16 08:30:06 kaynjay chat[1598]: OK
Jun 16 08:30:06 kaynjay chat[1598]: -- got it
Jun 16 08:30:06 kaynjay chat[1598]: send (ATM0DT2822000^M)
Jun 16 08:30:06 kaynjay chat[1598]: expect (CONNECT)
Jun 16 08:30:06 kaynjay chat[1598]: ^M
Jun 16 08:30:25 kaynjay chat[1598]: ATM0DT2822000^M^M
Jun 16 08:30:25 kaynjay chat[1598]: CONNECT
Jun 16 08:30:25 kaynjay chat[1598]: -- got it
Jun 16 08:30:25 kaynjay chat[1598]: send (\d)
Jun 16 08:30:26 kaynjay chat[1598]: send (\d)
Jun 16 08:30:27 kaynjay diald[1458]: SIGCHLD[4]: pid 1598 dial, status 0
Jun 16 08:30:27 kaynjay diald[1458]: new state START_LINK action 0x8051114 timeout 60
Jun 16 08:30:27 kaynjay diald[1458]: Connected to site 194.109.2.10
Jun 16 08:30:27 kaynjay diald[1458]: Running pppd (pid = 1599).
Jun 16 08:30:27 kaynjay diald[1599]: Running pppd: /usr/sbin/pppd -defaultroute -detach modem crtscts mtu 1500 mru 1500 netmask 255.255.255.0 noauth nopersist
Jun 16 08:30:27 kaynjay pppd[1599]: pppd 2.3.11 started by root, uid 0
Jun 16 08:30:27 kaynjay pppd[1599]: Using interface ppp0
Jun 16 08:30:27 kaynjay pppd[1599]: Connect: ppp0 <--> /dev/ttyS1
Jun 16 08:30:27 kaynjay pppd[1599]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x6db55ddb> <pcomp> <accomp>]
Jun 16 08:30:28 kaynjay pppd[1599]: rcvd [LCP ConfReq id=0x1 <mru 1514> <asyncmap 0x0> <auth pap> <magic 0x1fbaa509> <pcomp> <accomp> < 11 04 05 ea> < 13 09 03 00 c0 49 11 04 fa>]
Jun 16 08:30:28 kaynjay pppd[1599]: sent [LCP ConfRej id=0x1 < 11 04 05 ea> < 13 09 03 00 c0 49 11 04 fa>]
Jun 16 08:30:28 kaynjay pppd[1599]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x6db55ddb> <pcomp> <accomp>]
Jun 16 08:30:28 kaynjay pppd[1599]: rcvd [LCP ConfReq id=0x2 <mru 1514> <asyncmap 0x0> <auth pap> <magic 0x1fbaa509> <pcomp> <accomp>]
Jun 16 08:30:28 kaynjay pppd[1599]: sent [LCP ConfAck id=0x2 <mru 1514> <asyncmap 0x0> <auth pap> <magic 0x1fbaa509> <pcomp> <accomp>]
Jun 16 08:30:28 kaynjay pppd[1599]: sent [LCP EchoReq id=0x0 magic=0x6db55ddb]
Jun 16 08:30:28 kaynjay pppd[1599]: sent [PAP AuthReq id=0x1 user="kaynjay" password=<hidden>]
Jun 16 08:30:28 kaynjay pppd[1599]: rcvd [LCP EchoRep id=0x0 magic=0x1fbaa509]
Jun 16 08:30:28 kaynjay pppd[1599]: rcvd [PAP AuthNak id=0x0 41 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65]
Jun 16 08:30:31 kaynjay pppd[1599]: sent [PAP AuthReq id=0x2 user="kaynjay" password=<hidden>]
Jun 16 08:30:31 kaynjay pppd[1599]: rcvd [PAP AuthNak id=0x0 41 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65]
Jun 16 08:30:34 kaynjay pppd[1599]: sent [PAP AuthReq id=0x3 user="kaynjay" password=<hidden>]
Jun 16 08:30:34 kaynjay pppd[1599]: rcvd [PAP AuthNak id=0x0 41 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65]
Jun 16 08:30:37 kaynjay pppd[1599]: sent [PAP AuthReq id=0x4 user="kaynjay" password=<hidden>]
Jun 16 08:30:37 kaynjay pppd[1599]: rcvd [PAP AuthNak id=0x0 41 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65]
Jun 16 08:30:40 kaynjay pppd[1599]: sent [PAP AuthReq id=0x5 user="kaynjay" password=<hidden>]
Jun 16 08:30:40 kaynjay pppd[1599]: rcvd [PAP AuthNak id=0x0 41 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65]
Jun 16 08:30:43 kaynjay pppd[1599]: sent [PAP AuthReq id=0x6 user="kaynjay" password=<hidden>]
Jun 16 08:30:43 kaynjay pppd[1599]: rcvd [PAP AuthNak id=0x0 41 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65]
Jun 16 08:30:43 kaynjay pppd[1599]: rcvd [LCP TermReq id=0x3]
Jun 16 08:30:43 kaynjay pppd[1599]: LCP terminated by peer
Jun 16 08:30:43 kaynjay pppd[1599]: sent [LCP TermAck id=0x3]
Jun 16 08:30:44 kaynjay pppd[1599]: Hangup (SIGHUP)
Jun 16 08:30:44 kaynjay pppd[1599]: Modem hangup
Jun 16 08:30:44 kaynjay pppd[1599]: Connection terminated.
Jun 16 08:30:44 kaynjay pppd[1599]: Exit.
Jun 16 08:34:23 kaynjay pppd[1622]: pppd 2.3.11 started by root, uid 0
Jun 16 08:34:24 kaynjay chat[1623]: abort on (BUSY)
Jun 16 08:34:24 kaynjay chat[1623]: abort on (NO CARRIER)
Jun 16 08:34:24 kaynjay chat[1623]: abort on (VOICE)
Jun 16 08:34:24 kaynjay chat[1623]: abort on (NO DIALTONE)
Jun 16 08:34:24 kaynjay chat[1623]: abort on (NO DIAL TONE)
Jun 16 08:34:24 kaynjay chat[1623]: abort on (NO ANSWER)
Jun 16 08:34:24 kaynjay chat[1623]: send (ATZ^M)
Jun 16 08:34:24 kaynjay chat[1623]: expect (OK)
Jun 16 08:34:24 kaynjay chat[1623]: ATZ^M^M
Jun 16 08:34:24 kaynjay chat[1623]: OK
Jun 16 08:34:24 kaynjay chat[1623]: -- got it
Jun 16 08:34:24 kaynjay chat[1623]: send (ATM0DT2822000^M)
Jun 16 08:34:24 kaynjay chat[1623]: expect (CONNECT)
Jun 16 08:34:24 kaynjay chat[1623]: ^M
Jun 16 08:34:44 kaynjay chat[1623]: ATM0DT2822000^M^M
Jun 16 08:34:44 kaynjay chat[1623]: CONNECT
Jun 16 08:34:44 kaynjay chat[1623]: -- got it
Jun 16 08:34:44 kaynjay chat[1623]: send (\d)
Jun 16 08:34:45 kaynjay chat[1623]: send (\d)
Jun 16 08:34:46 kaynjay pppd[1622]: Serial connection established.
Jun 16 08:34:46 kaynjay pppd[1622]: Using interface ppp0
Jun 16 08:34:46 kaynjay pppd[1622]: Connect: ppp0 <--> /dev/ttyS1
Jun 16 08:34:47 kaynjay pppd[1622]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xeb190524> <pcomp> <accomp>]
Jun 16 08:34:47 kaynjay pppd[1622]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xeb190524> <pcomp> <accomp>]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xeb190524> <pcomp> <accomp>]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [LCP ConfReq id=0x2 <mru 1514> <asyncmap 0x0> <auth pap> <magic 0xef2c8e6e> <pcomp> <accomp> < 11 04 05 ea> < 13 09 03 00 c0 49 11 04 fa>]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [LCP ConfRej id=0x2 < 11 04 05 ea> < 13 09 03 00 c0 49 11 04 fa>]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xeb190524> <pcomp> <accomp>]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [LCP ConfReq id=0x3 <mru 1514> <asyncmap 0x0> <auth pap> <magic 0xef2c8e6e> <pcomp> <accomp>]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [LCP ConfAck id=0x3 <mru 1514> <asyncmap 0x0> <auth pap> <magic 0xef2c8e6e> <pcomp> <accomp>]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [LCP EchoReq id=0x0 magic=0xeb190524]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [PAP AuthReq id=0x1 user="i421441" password=<hidden>]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [LCP EchoRep id=0x0 magic=0xef2c8e6e]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [PAP AuthAck id=0x1 ""]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <compress VJ 0f 01>]
Jun 16 08:34:50 kaynjay kernel: PPP Deflate Compression module registered
Jun 16 08:34:50 kaynjay pppd[1622]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [IPCP ConfReq id=0x4 <compress VJ 0f 00> <addr 63.196.172.5>]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [IPCP ConfAck id=0x4 <compress VJ 0f 00> <addr 63.196.172.5>]
Jun 16 08:34:50 kaynjay pppd[1622]: rcvd [IPCP ConfNak id=0x1 <addr 63.196.173.34> <compress VJ 0f 00>]
Jun 16 08:34:50 kaynjay pppd[1622]: sent [IPCP ConfReq id=0x2 <addr 63.196.173.34> <compress VJ 0f 00>]
Jun 16 08:34:51 kaynjay pppd[1622]: rcvd [CCP ConfRej id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Jun 16 08:34:51 kaynjay pppd[1622]: sent [CCP ConfReq id=0x2]
Jun 16 08:34:51 kaynjay pppd[1622]: rcvd [IPCP ConfAck id=0x2 <addr 63.196.173.34> <compress VJ 0f 00>]
Jun 16 08:34:51 kaynjay pppd[1622]: Cannot determine ethernet address for proxy ARP
Jun 16 08:34:51 kaynjay pppd[1622]: local IP address 63.196.173.34
Jun 16 08:34:51 kaynjay pppd[1622]: remote IP address 63.196.172.5
Jun 16 08:34:51 kaynjay kernel: Packet log: input DENY ppp0 PROTO=17 63.196.172.5:520 63.196.173.34:520 L=52 S=0x00 I=23566 F=0x0000 T=1 (#6)
Jun 16 08:34:51 kaynjay pppd[1622]: Script /etc/ppp/ip-up started (pid 1625)
Jun 16 08:34:51 kaynjay pppd[1622]: rcvd [CCP ConfNak id=0x2 < 12 06 00 00 00 01>]
Jun 16 08:34:51 kaynjay pppd[1622]: sent [CCP ConfReq id=0x3]
Jun 16 08:34:51 kaynjay kernel: Packet log: input DENY ppp0 PROTO=17 63.196.172.5:3000 63.196.173.34:3000 L=38 S=0x00 I=23567 F=0x0000 T=255 (#6)
Jun 16 08:34:51 kaynjay pppd[1622]: rcvd [CCP ConfNak id=0x3 < 12 06 00 00 00 01>]
Jun 16 08:34:51 kaynjay pppd[1622]: sent [CCP ConfReq id=0x4]
Jun 16 08:34:51 kaynjay pppd[1622]: rcvd [CCP ConfNak id=0x4 < 12 06 00 00 00 01>]
Jun 16 08:34:51 kaynjay pppd[1622]: sent [CCP ConfReq id=0x5]
Reply to: