Date: Thu, 17 Jan 2002 21:51:48 +0200 From: =?utf-8?B?0J3QuNC60L7Qu9Cw0Lkg0JTQtdGA0LbQsNC6?= <derja@mail.ru> To: freebsd-questions@FreeBSD.org Subject: Problem with callback (CBCP) in ppp Message-ID: <20020117195148.GA586@dhost.local.domain>
next in thread | raw e-mail | index | archive | help
[-- Attachment #1 --]
Good day.
I have problem:
my ISP allow to use CBCP (Microsoft callback protocol)
i edit ppp.conf (ppp.conf in attachment)
but after PAP SUCCESS, ppp log this (ppp.log in attachment)
unexpected IPCP in phase Authenticate ... and close connection.
What you think about this ? (please read attached files).
Derja.
P.S. mail to kderja@mail.ru
[-- Attachment #2 --]
#################################################################
# PPP Sample Configuration File
# Originally written by Toshiharu OHNO
# Simplified 5/14/1999 by wself@cdrom.com
#
# See /usr/share/examples/ppp/ for some examples
#
# $FreeBSD: src/etc/ppp/ppp.conf,v 1.2.2.5 2001/07/13 10:55:23 brian Exp $
#################################################################
default:
set log Phase Chat LCP IPCP CCP CBCP tun command
ident user-ppp VERSION (built COMPILATIONDATE)
# Ensure that "device" references the correct serial port
# for your modem. (cuaa0 = COM1, cuaa1 = COM2)
#
set device /dev/cuaa1
set speed 115200
set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \
\"\" AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT"
set timeout 180 # 3 minute idle timer (the default)
enable dns # request DNS info (for resolv.conf)
papchap:
#
# edit the next three lines and replace the items in caps with
# the values which have been assigned by your ISP.
#
set phone 585447
set authname derja
set authkey mypassword
set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
add default HISADDR # Add a (sticky) default route
set callback cbcp
set cbcp * # admin. spec. phone number
[-- Attachment #3 --]
Jan 17 19:31:17 ppp[250]: Phase: Using interface: tun0
Jan 17 19:31:17 ppp[250]: Phase: deflink: Created in closed state
Jan 17 19:31:17 ppp[250]: tun0: Command: default: ident user-ppp VERSION (built COMPILATIONDATE)
Jan 17 19:31:17 ppp[250]: tun0: Command: default: set device /dev/cuaa1
Jan 17 19:31:17 ppp[250]: tun0: Command: default: set speed 115200
Jan 17 19:31:17 ppp[250]: tun0: Command: default: set dial ABORT BUSY ABORT NO\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK \dATDT\T TIMEOUT 40 CONNECT
Jan 17 19:31:17 ppp[250]: tun0: Command: default: set timeout 180
Jan 17 19:31:17 ppp[250]: tun0: Command: default: enable dns
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: set phone 585447
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: set authname derja
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: set authkey ********
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: add default HISADDR
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: set callback cbcp
Jan 17 19:31:17 ppp[250]: tun0: Command: papchap: set cbcp *
Jan 17 19:31:17 ppp[250]: tun0: Phase: PPP Started (interactive mode).
Jan 17 19:31:19 ppp[250]: tun0: Command: /dev/tty: open
Jan 17 19:31:19 ppp[250]: tun0: Phase: bundle: Establish
Jan 17 19:31:19 ppp[250]: tun0: Phase: deflink: closed -> opening
Jan 17 19:31:19 ppp[250]: tun0: Phase: deflink: Connected!
Jan 17 19:31:19 ppp[250]: tun0: Phase: deflink: opening -> dial
Jan 17 19:31:19 ppp[250]: tun0: Chat: Phone: 585447
Jan 17 19:31:19 ppp[250]: tun0: Chat: deflink: Dial attempt 1 of 1
Jan 17 19:31:19 ppp[250]: tun0: Chat: Send: AT^M
Jan 17 19:31:19 ppp[250]: tun0: Chat: Expect(5): OK
Jan 17 19:31:19 ppp[250]: tun0: Chat: Received: AT^M^M
Jan 17 19:31:19 ppp[250]: tun0: Chat: Received: OK^M
Jan 17 19:31:19 ppp[250]: tun0: Chat: Send: ATE1Q0^M
Jan 17 19:31:19 ppp[250]: tun0: Chat: Expect(5): OK
Jan 17 19:31:19 ppp[250]: tun0: Chat: Received: ATE1Q0^M^M
Jan 17 19:31:19 ppp[250]: tun0: Chat: Received: OK^M
Jan 17 19:31:19 ppp[250]: tun0: Chat: Send: ATDT585447^M
Jan 17 19:31:21 ppp[250]: tun0: Chat: Expect(40): CONNECT
Jan 17 19:31:43 ppp[250]: tun0: Chat: Received: ATDT585447^M^M
Jan 17 19:31:43 ppp[250]: tun0: Chat: Received: CONNECT 115200^M
Jan 17 19:31:43 ppp[250]: tun0: Phase: deflink: dial -> carrier
Jan 17 19:31:44 ppp[250]: tun0: Phase: deflink: /dev/cuaa1: CD detected
Jan 17 19:31:44 ppp[250]: tun0: Phase: deflink: carrier -> login
Jan 17 19:31:44 ppp[250]: tun0: Phase: deflink: login -> lcp
Jan 17 19:31:44 ppp[250]: tun0: LCP: FSM: Using "deflink" as a transport
Jan 17 19:31:44 ppp[250]: tun0: LCP: deflink: State change Initial --> Closed
Jan 17 19:31:44 ppp[250]: tun0: LCP: deflink: State change Closed --> Stopped
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: LayerStart
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACFCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: PROTOCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACCMAP[6] 0x00000000
Jan 17 19:31:45 ppp[250]: tun0: LCP: MRU[4] 1500
Jan 17 19:31:45 ppp[250]: tun0: LCP: MAGICNUM[6] 0x5404e95d
Jan 17 19:31:45 ppp[250]: tun0: LCP: CALLBACK[3] CBCP
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: State change Stopped --> Req-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACCMAP[6] 0x00000000
Jan 17 19:31:45 ppp[250]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP)
Jan 17 19:31:45 ppp[250]: tun0: LCP: CALLBACK[3] CBCP
Jan 17 19:31:45 ppp[250]: tun0: LCP: MAGICNUM[6] 0x394cddff
Jan 17 19:31:45 ppp[250]: tun0: LCP: PROTOCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACFCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: SendConfigRej(1) state = Req-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: CALLBACK[3] CBCP
Jan 17 19:31:45 ppp[250]: tun0: LCP: Sending ident magic 5404e95d text user-ppp 3.0.1 (built Jan 17 2002)
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: SendIdent(0) state = Req-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: RecvConfigReq(2) state = Req-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACCMAP[6] 0x00000000
Jan 17 19:31:45 ppp[250]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP)
Jan 17 19:31:45 ppp[250]: tun0: LCP: MAGICNUM[6] 0x394cddff
Jan 17 19:31:45 ppp[250]: tun0: LCP: PROTOCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACFCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: SendConfigAck(2) state = Req-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACCMAP[6] 0x00000000
Jan 17 19:31:45 ppp[250]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP)
Jan 17 19:31:45 ppp[250]: tun0: LCP: MAGICNUM[6] 0x394cddff
Jan 17 19:31:45 ppp[250]: tun0: LCP: PROTOCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: ACFCOMP[2]
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: State change Req-Sent --> Ack-Sent
Jan 17 19:31:45 ppp[250]: tun0: LCP: deflink: RecvCodeRej(3) state = Ack-Sent
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: SendConfigReq(1) state = Ack-Sent
Jan 17 19:31:48 ppp[250]: tun0: LCP: ACFCOMP[2]
Jan 17 19:31:48 ppp[250]: tun0: LCP: PROTOCOMP[2]
Jan 17 19:31:48 ppp[250]: tun0: LCP: ACCMAP[6] 0x00000000
Jan 17 19:31:48 ppp[250]: tun0: LCP: MRU[4] 1500
Jan 17 19:31:48 ppp[250]: tun0: LCP: MAGICNUM[6] 0x5404e95d
Jan 17 19:31:48 ppp[250]: tun0: LCP: CALLBACK[3] CBCP
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: RecvConfigAck(1) state = Ack-Sent
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: State change Ack-Sent --> Opened
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: LayerUp
Jan 17 19:31:48 ppp[250]: tun0: LCP: Sending ident magic 5404e95d text user-ppp 3.0.1 (built Jan 17 2002)
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: SendIdent(1) state = Opened
Jan 17 19:31:48 ppp[250]: tun0: Phase: bundle: Authenticate
Jan 17 19:31:48 ppp[250]: tun0: Phase: deflink: his = PAP, mine = none
Jan 17 19:31:48 ppp[250]: tun0: Phase: Pap Output: derja ********
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: RecvEchoRequest(0) state = Opened
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: SendEchoReply(0) state = Opened
Jan 17 19:31:48 ppp[250]: tun0: LCP: deflink: RecvCodeRej(4) state = Opened
Jan 17 19:31:48 ppp[250]: tun0: Phase: Pap Input: SUCCESS (Login ok)
Jan 17 19:31:48 ppp[250]: tun0: Phase: deflink: lcp -> cbcp
Jan 17 19:31:48 ppp[250]: tun0: CBCP: deflink: State change closed --> stopped
Jan 17 19:31:48 ppp[250]: tun0: IPCP: deflink: Error: Unexpected IPCP in phase Authenticate (ignored)
Jan 17 19:32:15 last message repeated 9 times
Jan 17 19:32:18 ppp[250]: tun0: LCP: deflink: RecvTerminateReq(5) state = Opened
Jan 17 19:32:18 ppp[250]: tun0: LCP: deflink: LayerDown
Jan 17 19:32:18 ppp[250]: tun0: CBCP: deflink: State change stopped --> closed
Jan 17 19:32:18 ppp[250]: tun0: LCP: deflink: SendTerminateAck(5) state = Opened
Jan 17 19:32:18 ppp[250]: tun0: LCP: deflink: State change Opened --> Stopping
Jan 17 19:32:18 ppp[250]: tun0: Phase: deflink: cbcp -> lcp
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: Carrier lost
Jan 17 19:32:19 ppp[250]: tun0: LCP: deflink: State change Stopping --> Starting
Jan 17 19:32:19 ppp[250]: tun0: LCP: deflink: LayerFinish
Jan 17 19:32:19 ppp[250]: tun0: LCP: deflink: State change Starting --> Initial
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: Disconnected!
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: lcp -> logout
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: Disconnected!
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: logout -> hangup
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: Connect time: 60 secs: 694 octets in, 371 octets out
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: : 27 packets in, 9 packets out
Jan 17 19:32:19 ppp[250]: tun0: Phase: total 17 bytes/sec, peak 160 bytes/sec on Thu Jan 17 19:32:19 2002
Jan 17 19:32:19 ppp[250]: tun0: Phase: deflink: hangup -> closed
Jan 17 19:32:19 ppp[250]: tun0: Phase: bundle: Dead
Jan 17 19:32:23 ppp[250]: tun0: Command: /dev/tty: q
Jan 17 19:32:23 ppp[250]: tun0: Phase: PPP Terminated (normal).
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20020117195148.GA586>