Date: Tue, 9 Jul 1996 20:07:05 -0400 (EDT) From: Dmitry Kohmanyuk <dk@dog.farm.org> To: freebsd-questions@freebsd.org Subject: iijppp on-demand to slirp-1.0c - reset requests? Message-ID: <199607100007.UAA22684@dog.farm.org>
next in thread | raw e-mail | index | archive | help
hi,
I hate to sound like a clueless newbie ;-), but anyway:
I am running FreeBSD 2.2-960501-SNAP . I want to setup on-demand ppp
from my machine to the other one which runs slirp 1.0c (in PPP mode).
The remote system is running SunOS 4.1.3_U1, and I am logging through
Annex terminal server (via telnet -s - does this ensure clean connection?).
I run ppp -auto ccs, then I ping to my remote slirp ppp address (10.0.2.2).
This starts dialing. Looking at modem lights and /var/log/ppp.log, I see that
it connects, then logins (my login script ends with `Ready' to ensure that
slirp is really started). After that, it starts some sort of PPP negotiation
(I know very little about ppp; I have used slip all my life and was happy
with it, but now I want to run ppp). Happily discovering its address,
ppp then prints infinite loop of these lines to the log file:
07-09 19:43:32 [22460] CCP: Received Reset Request (9) state = Opend (9)
07-09 19:43:32 [22460] CCP: RecvResetReq
07-09 19:43:32 [22460] CCP: SendResetAck
telnet to remote host address (slirp faked one, 10.0.2.2)
doesn't work after that ( I understand that ping shouldn't work over slirp ).
I get the following state information from ppp (by telnet localhost 3000):
PPP ON dog> show ccp
CCP [Opend]
myproto = OUI, hisproto = OUI
Input: 0 --> 0, Output: 0 --> 0
PPP ON dog> show escape
0xff
PPP ON dog> show lcp
LCP [Opend]
his side: MRU 552, ACCMAP ffffffff, PROTOCOMP 1, ACFCOMP 1 MAGIC 18684a83
my side: MRU 1500, ACCMAP ffffffff, PROTOCOMP 1, ACFCOMP 1 MAGIC 1c26acee
Defaults: MRU = 1500, ACCMAP = ffffffff Open Mode: passive
PPP ON dog> show hdlc
HDLC level errors
FCS: 2 ADDR: 0 COMMAND: 0 PROTO: 0
PPP ON dog> show ipcp
IPCP [Opend]
his side: 10.0.2.2, 2d0f01
my side: 10.0.2.15, 2d0f00
connected: 108 secs, idle: 107 secs
Defaults:
My Address: 0.0.0.0/0
His Address: 10.0.2.2/32
Negotiation: 0.0.0.0/0
PPP ON dog> show proto
Protocol in out Protocol in out
IP : 0, 1 VJ_UNCOMP: 0, 0
VJ_COMP : 0, 0 COMPD : 0, 0
LCP : 3, 3 IPCP : 4, 5
CCP : 3, 3 PAP : 0, 0
LQR : 0, 5 CHAP : 0, 0
Others : 0, 0
I must admit that all of these mean almost nothing to me (ok, I can
understand what LCP and VJ_COMP mean, and I know that PAP and CHAP
are some auth schemes which I don't use/need anyway, but what's these
FCS errors in HDLC section?)
It also seems strange that I see 1500 as local mtu, although ifconfig shows 552.
my configuration is as follows (only relevant lines are shown):
/etc/ppp/ppp.conf:
default:
set device /dev/cuaa1
set speed 19200
# disable lqr
# deny lqr
set debug chat phase lqr lcp
set dial "ABORT BUSY ABORT NO\\sCARRIER ABORT NO\\sDIALTONE TIMEOUT 5 \"\" ATE1
Q0 OK-AT-OK \\dATDT\\T TIMEOUT 40 CONNECT"
ccs:
set phone t5201000
set login "..."
set timeout 600
# set ifaddr 10.0.2.15 10.0.2.2
set ifaddr 0 10.0.2.2
set escape ff
set accmap ffffffff
#set openmode active
# add 0 255.0.0.0 10.0.2.2
/etc/ppp/ppp.linkup:
MYADDR:
add 0 0 HISADDR
I have tried to fiddle with openmode, lqr and ifaddr (see commented out line),
as well as with initiate-options and ipcp-accept-remote on the host side.
This doesn't help.
my remote slirp configuration is as follows:
.slirprc:
baudrate 9600
socket
shell /usr/local/bin/tcsh
mtu 552
mru 552
add exec tcsh:10.0.2.4:513
.slirprc-0:
baudrate 9600
ppp
debugppp
asyncmap ffffffff
escape ff
#escape 11,13
initiate-options
ipcp-accept-remote
ppp_exit
I start slirp as slirp -l 0 (for possible link-resumption capability).
As you see, I was paranoid enough to include all control chars, as
well as 255 (telnet cookie), into both configs.
I got the following in my remote slirp_pppdebug file:
slirppp: PPP is down now
ppp_set_xaccm: extended xmit asyncmap set to 80000000000000000000000000000000600
00000000000000000000000000000
ppp_send_config: mtu set to 552
ppp_send_config: (xmit) asyncmap set to ffffffff
ppp_recv_config: (recv) asyncmap set to 00000000
: mru set to 1500
Received a packet of 32 bytes, protocol = 0xc021
Received a packet of 24 bytes, protocol = 0xc021
Received a packet of 24 bytes, protocol = 0xc021
ppp_send_config: mtu set to 552
ppp_send_config: (xmit) asyncmap set to ffffffff
ppp_send_config: compressing the protocol field
ppp_send_config: compressing the address field
ppp_recv_config: (recv) asyncmap set to ffffffff
: mru set to 552
Received a packet of 16 bytes, protocol = 0x8021
Received a packet of 6 bytes, protocol = 0x80fd
Received a packet of 4 bytes, protocol = 0xc021
LCP terminated at peer's request
slirppp: PPP is down now
ppp_send_config: mtu set to 552
ppp_send_config: (xmit) asyncmap set to ffffffff
ppp_recv_config: (recv) asyncmap set to 00000000
: mru set to 1500
Received a packet of 10 bytes, protocol = 0x8021
Received a packet of 16 bytes, protocol = 0x8021
Connection terminated.
I got the following in my local /var/log/ppp.log:
07-09 19:41:15 [22459] Using interface: tun0
07-09 19:41:15 [22460] Listening at 3000.
07-09 19:41:15 [22460] PPP Started.
07-09 19:41:17 [22460] Dial attempt 1
07-09 19:41:17 [22460] Expecting
[... dial/login script skipped ]
07-09 19:41:58 [22460] Expecting Ready
07-09 19:41:58 [22460] Wait for (40): Ready --> Ready
07-09 19:42:00 [22460] LCP: state change Initial --> Closed
07-09 19:42:00 [22460] LCP: state change Closed --> Stopped
07-09 19:42:00 [22460] LCP: Received Configure Request (1) state = Stopped (3)
07-09 19:42:00 [22460] MRU 552
07-09 19:42:00 [22460] ACCMAP ffffffff
07-09 19:42:00 [22460] MAGICNUM 45ece2fa
07-09 19:42:00 [22460] PROTOCOMP
07-09 19:42:00 [22460] ACFCOMP
07-09 19:42:00 [22460] LCP: SendConfigReq
07-09 19:42:00 [22460] ACFCOMP
07-09 19:42:00 [22460] PROTOCOMP
07-09 19:42:00 [22460] ACCMAP [6] ffffffff
07-09 19:42:00 [22460] MRU [4] 1500
07-09 19:42:00 [22460] MAGICNUM [6] ce1f310c
07-09 19:42:00 [22460] QUALPROTO (3000)
07-09 19:42:00 [22460] LCP: SendConfigAck(Stopped)
07-09 19:42:00 [22460] MRU 552
07-09 19:42:00 [22460] ACCMAP ffffffff
07-09 19:42:00 [22460] MAGICNUM 45ece2fa
07-09 19:42:00 [22460] PROTOCOMP
07-09 19:42:00 [22460] ACFCOMP
07-09 19:42:00 [22460] LCP: state change Stopped --> Ack-Sent
07-09 19:42:01 [22460] LCP: Received Configure Reject (1) state = Ack-Sent (8)
07-09 19:42:01 [22460] LCP: RecvConfigRej.
07-09 19:42:01 [22460] QUALPROTO proto: c025, interval: 30000ms
07-09 19:42:01 [22460] LCP: SendConfigReq
07-09 19:42:01 [22460] ACFCOMP
07-09 19:42:01 [22460] PROTOCOMP
07-09 19:42:01 [22460] ACCMAP [6] ffffffff
07-09 19:42:01 [22460] MRU [4] 1500
07-09 19:42:01 [22460] MAGICNUM [6] ce1f310c
07-09 19:42:01 [22460] LCP: Received Configure Ack (2) state = Ack-Sent (8)
07-09 19:42:01 [22460] LCP: state change Ack-Sent --> Opend
07-09 19:42:01 [22460] LCP: LayerUp
07-09 19:42:01 [22460] Phase: Authenticate
07-09 19:42:01 [22460] his = 0, mine = 0
07-09 19:42:01 [22460] Phase: Network
07-09 19:42:01 [22460] IPCP: state change Initial --> Closed
07-09 19:42:01 [22460] IPCP Up event!!
07-09 19:42:01 [22460] IPCP: SendConfigReq
07-09 19:42:01 [22460] IPADDR [6] 0.0.0.0
07-09 19:42:01 [22460] COMPPROTO [6] 002d0f00
07-09 19:42:01 [22460] IPCP: state change Closed --> Req-Sent
07-09 19:42:01 [22460] CCP: state change Initial --> Closed
07-09 19:42:01 [22460] CCP Up event!!
07-09 19:42:01 [22460] CCP: SendConfigReq
07-09 19:42:01 [22460] CCP: state change Closed --> Req-Sent
07-09 19:42:01 [22460] IPCP: Received Configure Request (1) state = Req-Sent (6)
07-09 19:42:01 [22460] IPADDR[6] 134.117.1.17
07-09 19:42:01 [22460] COMPPROTO[6] 002d0f01
07-09 19:42:01 [22460] IPCP: SendConfigNak(Req-Sent)
07-09 19:42:01 [22460] IPADDR[6] 10.0.2.2
07-09 19:42:01 [22460] CCP: Received Configure Request (1) state = Req-Sent (6)
07-09 19:42:01 [22460] CCP: SendConfigAck(Req-Sent)
07-09 19:42:01 [22460] CCP: state change Req-Sent --> Ack-Sent
07-09 19:42:02 [22460] IPCP: Received Configure Nak (1) state = Req-Sent (6)
07-09 19:42:02 [22460] IPADDR[6] 10.0.2.15
07-09 19:42:02 [22460] IPADDR[6] changing address: 0.0.0.0 --> 10.0.2.15
07-09 19:42:02 [22460] IPCP: SendConfigReq
07-09 19:42:02 [22460] IPADDR [6] 10.0.2.15
07-09 19:42:02 [22460] COMPPROTO [6] 002d0f00
07-09 19:42:02 [22460] CCP: Received Configure Reject (1) state = Ack-Sent (8)
07-09 19:42:02 [22460] CCP: RecvConfigRej.
07-09 19:42:02 [22460] PRED1[2]
07-09 19:42:02 [22460] CCP: SendConfigReq
07-09 19:42:02 [22460] IPCP: Received Configure Request (2) state = Req-Sent (6)
07-09 19:42:02 [22460] IPADDR[6] 10.0.2.2
07-09 19:42:02 [22460] COMPPROTO[6] 002d0f01
07-09 19:42:02 [22460] IPCP: SendConfigAck(Req-Sent)
07-09 19:42:02 [22460] IPADDR[6] 10.0.2.2
07-09 19:42:02 [22460] COMPPROTO[6] 002d0f01
07-09 19:42:02 [22460] IPCP: state change Req-Sent --> Ack-Sent
07-09 19:42:02 [22460] IPCP: Received Configure Ack (2) state = Ack-Sent (8)
07-09 19:42:02 [22460] IPCP: state change Ack-Sent --> Opend
07-09 19:42:02 [22460] IPCP: LayerUp.
07-09 19:42:02 [22460] myaddr = 10.0.2.15 hisaddr = 10.0.2.2
07-09 19:42:02 [22460] OsLinkup: 10.0.2.2
07-09 19:42:02 [22460] CCP: Received Configure Ack (2) state = Ack-Sent (8)
07-09 19:42:02 [22460] CCP: state change Ack-Sent --> Opend
07-09 19:42:02 [22460] CCP: LayerUp.
07-09 19:42:02 [22460] myproto = 0, hisproto = 0
07-09 19:42:22 [22460] CCP: Received Reset Request (2) state = Opend (9)
07-09 19:42:22 [22460] CCP: RecvResetReq
07-09 19:42:22 [22460] CCP: SendResetAck
07-09 19:42:23 [22460] CCP: Received Reset Request (2) state = Opend (9)
07-09 19:42:23 [22460] CCP: RecvResetReq
07-09 19:42:23 [22460] CCP: SendResetAck
07-09 19:42:28 [22460] CCP: Received Reset Request (3) state = Opend (9)
07-09 19:42:28 [22460] CCP: RecvResetReq
07-09 19:42:28 [22460] CCP: SendResetAck
07-09 19:42:29 [22460] CCP: Received Reset Request (4) state = Opend (9)
07-09 19:42:29 [22460] CCP: RecvResetReq
07-09 19:42:29 [22460] CCP: SendResetAck
07-09 19:42:30 [22460] CCP: Received Reset Request (4) state = Opend (9)
07-09 19:42:30 [22460] CCP: RecvResetReq
07-09 19:42:30 [22460] CCP: SendResetAck
[... the same three lines continue, until I kill the ppp process or
close session ...]
sorry for this long mail, but I really really want to fix this and I hope
that at least some of the preceding information would help to sched
some light on this.
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?199607100007.UAA22684>