Date: Sat, 7 Oct 2006 08:35:38 +0900 From: Stepan Zastupov <redchrom@gmail.com> To: freebsd-current@freebsd.org Cc: redchrom@gmail.com Subject: gprs dosen't works in current Message-ID: <20061007083538.fdd869f8.redchrom@gmail.com>
next in thread | raw e-mail | index | archive | help
Hello, I'm using freebsd 7 current and gprs dosen't works for me. Here i s the ppp.conf: default: set log Phase Chat LCP IPCP CCP tun command ident user-ppp VERSION (built COMPILATIONDATE) set timeout 180 # 3 minute idle timer (the default) enable dns # request DNS info (for resolv.conf) gprs: set device "!/usr/bin/rfcomm_sppd -a t630" set speed 115200 set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \"\" AT \ OK-AT-OK ATE1Q0 OK \ AT+CGDCONT=1,\\\"IP\\\",\\\"internet.mts.ru\\\" OK \ AT+CGATT=1 OK \\dATDT\\T TIMEOUT 40 CONNECT" set authname "mts" set authkey "mts" set phone "*99***1#" disable ipv6cp add default HISADDR As you see I use bluetooth to connect the phone but I don't think that the problem in it. obexapp works fine in current. ppp -ddial gprs && tail -f /var/log/ppp.log shom me the next lines: Oct 6 14:02:02 stepan ppp[3614]: Phase: Using interface: tun0 Oct 6 14:02:02 stepan ppp[3614]: Phase: deflink: Created in closed state Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: default: ident user-ppp VERSION (built COMPILATIONDATE) Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: default: set timeout 180 Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: default: enable dns Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: set device !/usr/bin/rfcomm_sppd -a t630 Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: set speed 115200 Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: set dial ABORT BUSY ABORT NO\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK AT+CGDCONT=1,\"IP\",\"internet.mts.ru\" OK AT+CGATT=1 OK \dATDT\T TIMEOUT 40 CONNECT Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: set authname mts Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: set authkey ******** Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: set phone *99***1# Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: disable ipv6cp Oct 6 14:02:02 stepan ppp[3614]: tun0: Command: gprs: add default HISADDR Oct 6 14:02:02 stepan ppp[3615]: tun0: Phase: PPP Started (ddial mode). Oct 6 14:02:02 stepan ppp[3615]: tun0: Phase: bundle: Establish Oct 6 14:02:02 stepan ppp[3615]: tun0: Phase: deflink: closed -> opening Oct 6 14:02:02 stepan ppp[3615]: tun0: Phase: deflink: Connected! Oct 6 14:02:02 stepan ppp[3615]: tun0: Phase: deflink: opening -> dial Oct 6 14:02:02 stepan ppp[3615]: tun0: Chat: Phone: *99***1# Oct 6 14:02:02 stepan ppp[3615]: tun0: Chat: Send: AT^M Oct 6 14:02:02 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: rfcomm_sppd[3618]: Starting on stdin/stdout... Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: AT^M^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Send: ATE1Q0^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: ATE1Q0^M^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Send: AT+CGDCONT=1,"IP","internet.mts.ru"^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: AT+CGDCONT=1,"IP","internet.mts.ru"^M^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Send: AT+CGATT=1^M Oct 6 14:02:04 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:05 stepan ppp[3615]: tun0: Chat: Received: AT+CGATT=1^M^M Oct 6 14:02:05 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:05 stepan ppp[3615]: tun0: Chat: Send: ATDT*99***1#^M Oct 6 14:02:07 stepan ppp[3615]: tun0: Chat: Expect(40): CONNECT Oct 6 14:02:07 stepan ppp[3615]: tun0: Chat: Received: ATDT*99***1#^M^M Oct 6 14:02:07 stepan ppp[3615]: tun0: Chat: Received: CONNECT^M Oct 6 14:02:07 stepan ppp[3615]: tun0: Phase: deflink: dial -> carrier Oct 6 14:02:07 stepan ppp[3615]: tun0: Phase: deflink: carrier -> login Oct 6 14:02:07 stepan ppp[3615]: tun0: Phase: deflink: login -> lcp Oct 6 14:02:07 stepan ppp[3615]: tun0: LCP: FSM: Using "deflink" as a transport Oct 6 14:02:07 stepan ppp[3615]: tun0: LCP: deflink: State change Initial --> Closed Oct 6 14:02:07 stepan ppp[3615]: tun0: LCP: deflink: State change Closed --> Stopped Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: LayerStart Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MRU[4] 1500 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MAGICNUM[6] 0xaa5135f3 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: State change Stopped --> Req-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: SendConfigAck(1) state = Req-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: State change Req-Sent --> Ack-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: RecvConfigRej(1) state = Ack-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(0) state = Ack-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MAGICNUM aa5135f3 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MAGICNUM[6] 0xaa5135f3 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: Magic 0xaa5135f3 is REJected! Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: SendConfigReq(2) state = Ack-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MRU[4] 1500 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(3) state = Ack-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: RecvConfigAck(2) state = Ack-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MRU[4] 1500 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: State change Ack-Sent --> Opened Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: LayerUp Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(1) state = Opened Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:08 stepan ppp[3615]: tun0: Phase: bundle: Authenticate Oct 6 14:02:08 stepan ppp[3615]: tun0: Phase: deflink: his = PAP, mine = none Oct 6 14:02:08 stepan ppp[3615]: tun0: Phase: Pap Output: mts ******** Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(4) state = Opened Oct 6 14:02:08 stepan ppp[3615]: tun0: Phase: Pap Input: SUCCESS () Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: FSM: Using "deflink" as a transport Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: deflink: State change Initial --> Closed Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: deflink: LayerStart. Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: MPPE: Not usable without CHAP81 Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: deflink: SendConfigReq(1) state = Closed Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: DEFLATE[4] win 15 Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: PRED1[2] Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: deflink: State change Closed --> Req-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: Phase: deflink: lcp -> open Oct 6 14:02:08 stepan ppp[3615]: tun0: Phase: bundle: Network Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: FSM: Using "deflink" as a transport Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: deflink: State change Initial --> Closed Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: deflink: LayerStart. Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(1) state = Closed Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: PRIDNS[6] 195.46.96.1 Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: SECDNS[6] 255.255.255.255 Oct 6 14:02:08 stepan ppp[3615]: tun0: IPCP: deflink: State change Closed --> Req-Sent Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: RecvProtocolRej(5) state = Opened Oct 6 14:02:08 stepan ppp[3615]: tun0: LCP: deflink: -- Protocol 0x80fd (Compression Control Protocol) was rejected! Oct 6 14:02:08 stepan ppp[3615]: tun0: CCP: deflink: State change Req-Sent --> Stopped Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(1) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: [EMPTY] Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(1) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(1) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(2) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: PRIDNS[6] 195.46.96.1 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: SECDNS[6] 255.255.255.255 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(2) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(2) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(2) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(6) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(2) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(3) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(3) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(3) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(3) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(7) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(3) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(4) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(4) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(4) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(4) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(8) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(4) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(5) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(5) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(5) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(5) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(9) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(5) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(6) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(6) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(6) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(6) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(10) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(6) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(7) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(7) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(7) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(7) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(11) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(7) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(8) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(8) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(8) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(8) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(12) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(8) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(9) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(9) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(9) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(9) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(13) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(9) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(10) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(10) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(10) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(10) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(14) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(10) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(11) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(11) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(11) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(11) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(15) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(11) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(12) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(12) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(12) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(12) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(16) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(12) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(13) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(13) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(13) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(13) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(17) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(13) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(14) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(14) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(14) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(14) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(18) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(14) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(15) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(15) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(15) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigNak(15) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: Phase: deflink: Too many IPCP NAKs sent - abandoning negotiation Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(16) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: SendTerminateReq(15) state = Req-Sent Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: State change Req-Sent --> Closing Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(19) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigRej(15) state = Closing Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(17) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvConfigReq(16) state = Closing Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 0.0.0.0 Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: Error: Got ConfigReq while state = Closing Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(20) state = Opened Oct 6 14:02:09 stepan ppp[3615]: tun0: IPCP: deflink: RecvTerminateAck(15), dropped (expected 16) Oct 6 14:02:09 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(21) state = Opened Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: deflink: SendTerminateReq(16) state = Closing Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: deflink: RecvTerminateAck(16) state = Closing Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: deflink: LayerFinish. Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: Connect time: 4 secs: 0 octets in, 0 octets out Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: 0 packets in, 0 packets out Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: total 0 bytes/sec, peak 0 bytes/sec on Fri Oct 6 14:02:08 2006 Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: deflink: State change Closing --> Closed Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: bundle: Terminate Oct 6 14:02:12 stepan ppp[3615]: tun0: CCP: deflink: State change Stopped --> Closed Oct 6 14:02:12 stepan ppp[3615]: tun0: CCP: deflink: State change Closed --> Initial Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: LayerDown Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: SendTerminateReq(3) state = Opened Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: State change Opened --> Closing Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: open -> lcp Oct 6 14:02:12 stepan ppp[3615]: tun0: IPCP: deflink: State change Closed --> Initial Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: RecvTerminateAck(3) state = Closing Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: LayerFinish Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: State change Closing --> Closed Oct 6 14:02:12 stepan ppp[3615]: tun0: LCP: deflink: State change Closed --> Initial Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: Disconnected! Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: lcp -> logout Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: logout -> hangup Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: Disconnected! Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: Connect time: 10 secs: 1740 octets in, 1825 octets out Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: 41 packets in, 56 packets out Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: total 356 bytes/sec, peak 702 bytes/sec on Fri Oct 6 14:02:10 2006 Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: HUPing 3618 Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: hangup -> opening Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: bundle: Establish Oct 6 14:02:12 stepan ppp[3615]: tun0: Phase: deflink: Enter pause (3) for redialing. Oct 6 14:02:12 stepan ppp[3615]: tun0: Chat: deflink: Reconnect try 1 of 0 Oct 6 14:02:15 stepan ppp[3615]: tun0: Chat: deflink: Redial timer expired. Oct 6 14:02:15 stepan ppp[3615]: tun0: Phase: deflink: Connected! Oct 6 14:02:15 stepan ppp[3615]: tun0: Phase: deflink: opening -> dial Oct 6 14:02:15 stepan ppp[3615]: tun0: Chat: Phone: *99***1# Oct 6 14:02:15 stepan ppp[3615]: tun0: Chat: Send: AT^M Oct 6 14:02:15 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: rfcomm_sppd[3621]: Starting on stdin/stdout... Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: AT^M^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Send: ATE1Q0^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: ATE1Q0^M^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Send: AT+CGDCONT=1,"IP","internet.mts.ru"^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: AT+CGDCONT=1,"IP","internet.mts.ru"^M^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Send: AT+CGATT=1^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Expect(5): OK Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: AT+CGATT=1^M^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Received: OK^M Oct 6 14:02:16 stepan ppp[3615]: tun0: Chat: Send: ATDT*99***1#^M Oct 6 14:02:18 stepan ppp[3615]: tun0: Chat: Expect(40): CONNECT Oct 6 14:02:18 stepan ppp[3615]: tun0: Chat: Received: ATDT*99***1#^M^M Oct 6 14:02:18 stepan ppp[3615]: tun0: Chat: Received: CONNECT^M Oct 6 14:02:18 stepan ppp[3615]: tun0: Phase: deflink: dial -> carrier Oct 6 14:02:18 stepan ppp[3615]: tun0: Phase: deflink: carrier -> login Oct 6 14:02:18 stepan ppp[3615]: tun0: Phase: deflink: login -> lcp Oct 6 14:02:18 stepan ppp[3615]: tun0: LCP: FSM: Using "deflink" as a transport Oct 6 14:02:18 stepan ppp[3615]: tun0: LCP: deflink: State change Initial --> Closed Oct 6 14:02:18 stepan ppp[3615]: tun0: LCP: deflink: State change Closed --> Stopped Oct 6 14:02:18 stepan ppp[3615]: tun0: Phase: Signal 15, terminate. Oct 6 14:02:18 stepan ppp[3615]: tun0: LCP: deflink: State change Stopped --> Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: LayerStart Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: SendConfigReq(4) state = Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MRU[4] 1500 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MAGICNUM[6] 0xcbd825b6 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: State change Closed --> Req-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: SendConfigAck(1) state = Req-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: State change Req-Sent --> Ack-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvConfigRej(4) state = Ack-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(18) state = Ack-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MAGICNUM cbd825b6 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MAGICNUM[6] 0xcbd825b6 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: Magic 0xcbd825b6 is REJected! Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: SendConfigReq(5) state = Ack-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MRU[4] 1500 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(3) state = Ack-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvConfigAck(5) state = Ack-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACFCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: PROTOCOMP[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: ACCMAP[6] 0x00000000 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MRU[4] 1500 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: State change Ack-Sent --> Opened Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: LayerUp Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: SendIdent(19) state = Opened Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: MAGICNUM 00000000 Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: TEXT user-ppp 3.4.2 (built COMPILATIONDATE) Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: bundle: Authenticate Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: his = PAP, mine = none Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: Pap Output: mts ******** Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvCodeRej(4) state = Opened Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: Pap Input: SUCCESS () Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: FSM: Using "deflink" as a transport Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: State change Initial --> Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: LayerStart. Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: MPPE: Not usable without CHAP81 Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: SendConfigReq(1) state = Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: DEFLATE[4] win 15 Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: PRED1[2] Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: State change Closed --> Req-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: lcp -> open Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: bundle: Network Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: FSM: Using "deflink" as a transport Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: State change Initial --> Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: LayerStart. Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: SendConfigReq(17) state = Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: IPADDR[6] 192.168.0.2 Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: COMPPROTO[6] 16 VJ slots with slot compression Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: PRIDNS[6] 195.46.96.1 Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: SECDNS[6] 255.255.255.255 Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: State change Closed --> Req-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvProtocolRej(5) state = Opened Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: -- Protocol 0x80fd (Compression Control Protocol) was rejected! Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: State change Req-Sent --> Stopped Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: Signal 15, terminate. Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: SendTerminateReq(17) state = Req-Sent Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: State change Req-Sent --> Closing Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: RecvTerminateAck(17) state = Closing Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: LayerFinish. Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: Connect time: 0 secs: 0 octets in, 0 octets out Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: 0 packets in, 0 packets out Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: total 0 bytes/sec, peak 0 bytes/sec on Fri Oct 6 14:02:19 2006 Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: State change Closing --> Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: bundle: Terminate Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: State change Stopped --> Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: CCP: deflink: State change Closed --> Initial Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: LayerDown Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: SendTerminateReq(6) state = Opened Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: State change Opened --> Closing Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: open -> lcp Oct 6 14:02:19 stepan ppp[3615]: tun0: IPCP: deflink: State change Closed --> Initial Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: RecvTerminateAck(6) state = Closing Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: LayerFinish Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: State change Closing --> Closed Oct 6 14:02:19 stepan ppp[3615]: tun0: LCP: deflink: State change Closed --> Initial Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: Disconnected! Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: lcp -> logout Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: logout -> hangup Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: Disconnected! Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: Connect time: 4 secs: 294 octets in, 356 octets out Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: 50 packets in, 66 packets out Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: total 162 bytes/sec, peak 114 bytes/sec on Fri Oct 6 14:02:19 2006 Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: HUPing 3621 Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: deflink: hangup -> closed Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: bundle: Dead Oct 6 14:02:19 stepan ppp[3615]: tun0: Phase: PPP Terminated (normal). -- Best regards, Stepan Zastupov aka RedChrom ISPSystem
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20061007083538.fdd869f8.redchrom>