From owner-freebsd-questions Tue Jul 9 17:46:35 1996 Return-Path: owner-questions Received: (from root@localhost) by freefall.freebsd.org (8.7.5/8.7.3) id RAA21365 for questions-outgoing; Tue, 9 Jul 1996 17:46:35 -0700 (PDT) Received: from clipper.cs.kiev.ua (root@cs-demon-64k.cs.kiev.ua [193.124.48.251]) by freefall.freebsd.org (8.7.5/8.7.3) with SMTP id RAA21332 for ; Tue, 9 Jul 1996 17:46:00 -0700 (PDT) Received: from dog by clipper.cs.kiev.ua with uucp id m0udn9Y-0004xRC; Wed, 10 Jul 96 03:29 WET DST Received: (from dk@localhost) by dog.farm.org (8.7.5/dk#3) id UAA22684 for freebsd-questions@freebsd.org; Tue, 9 Jul 1996 20:07:06 -0400 (EDT) From: Dmitry Kohmanyuk Message-Id: <199607100007.UAA22684@dog.farm.org> Subject: iijppp on-demand to slirp-1.0c - reset requests? To: freebsd-questions@freebsd.org Date: Tue, 9 Jul 1996 20:07:05 -0400 (EDT) Reply-To: dk+@ua.net X-Class: Fast X-OS-Of-Choice: FreeBSD 2.2-960501-SNAP X-NIC-Handle: DK379 X-Mailer: ELM [version 2.4ME+ PL13 (25)] MIME-Version: 1.0 Content-Type: text/plain; charset=US-ASCII Content-Transfer-Encoding: 7bit Sender: owner-questions@freebsd.org X-Loop: FreeBSD.org Precedence: bulk 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.