ppp problem over bluetooth

coool v cuuulboy at gmail.com
Tue Aug 25 17:37:21 UTC 2009


hello i am on freesd 6 , i am trying to connect to internet  using my
nokia phone. so far i got paired it with my pc and able to dialup to
my isp, problem is i get connected for sometime and gets disconnected.
i cant browse, only one dsn server gets assigned in resolv.conf,
infact there must be two.

this is how i do it :

# /etc/rc.bluetooth start ubt0
BD_ADDR: 00:11:67:0e:04:85
Features: 0xff 0xff 0x8d 0x78 0x8 0x18 00 00
<3-Slot> <5-Slot> <Encryption> <Slot offset>
<Timing accuracy> <Switch> <Hold mode> <Sniff mode>
<Park mode> <RSSI> <Channel quality> <SCO link>
<HV2 packets> <HV3 packets> <u-law log> <A-law log> <CVSD>
<Power control> <Transparent SCO data> <Unknown2.7>
Max. ACL packet size: 678 bytes
Number of ACL packets: 8
Max. SCO packet size: 48 bytes
Number of SCO packets: 10

# rfcomm_pppd -a BD_ADDR -c -C dun -l rfcomm-dialup

my ppp.conf -

default:
 set log Phase Chat LCP IPCP CCP tun command
 ident user-ppp VERSION (built COMPILATIONDATE)
 set device /dev/cuad1
 set speed 115200
 set dial "ABORT ERROR ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \
           \"\" ATZ OK-ATZ-OK
AT+CGDCONT=1,\\\"IP\\\",\\\"airtelgprs.com\\\" OK \\dATD\\T TIMEOUT 40
CONNECT"
 set timeout 120
 enable force-scripts
 enable dns
 accept dns
 enable lqr
 accept lqr
 set dial
 set timeout 0
rfcomm-dialup:
 set phone "*99***1#"
 set authname
 set authkey
 accept pap
 accept chap
 set timeout 300
 add default HISADDR
#set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
#set dial "ABORT ERROR ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5
\\"\"AT+CGDCONT=1,\\\"IP\\\",\\\"airtelgprs.com \\\" OK #\\dATD\\T
TIMEOUT 40 CONNECT"
#set dial "ABORT ERROR ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \
           \"\" ATZ OK-ATZ-OK
AT+CGDCONT=1,\\\"IP\\\",\\\"airtelgprs.com\\\" OK \\dATD\\T TIMEOUT 40
CONNECT"
# Ensure that "device" references the correct serial port
# for your modem. (cuad0 = COM1, cuad1 = COM2)
#PAPorCHAPpmdemand:
#set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \
#         \"\" AT OK-AT-OK ATE1Q0 OK \\dATDT\\T TIMEOUT 40 CONNECT"
# edit the next three lines and replace the items in caps with
# the values which have been assigned by your ISP.

my ppp.log

Aug 25 21:00:51  ppp[787]: Phase: Using interface: tun0
Aug 25 21:00:51  ppp[787]: Phase: deflink: Created in closed state
Aug 25 21:00:51  ppp[787]: tun0: Command: default: ident user-ppp
VERSION (built COMPILATIONDATE)
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set device /dev/cuad1
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set speed 115200
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set dial ABORT
ERROR ABORT BUSY ABORT NO\sCARRIER TIMEOUT 5            ""
AT+CGDCONT=1,\"IP\",\"airtelgprs.com\" OK \dATD\T TIMEOUT 40 CONNECT
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set timeout 120
Aug 25 21:00:51  ppp[787]: tun0: Command: default: enable force-scripts
Aug 25 21:00:51  ppp[787]: tun0: Command: default: enable dns
Aug 25 21:00:51  ppp[787]: tun0: Command: default: enable lqr
Aug 25 21:00:51  ppp[787]: tun0: Command: default: accept lqr
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set dial
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set timeout 0
Aug 25 21:00:51  ppp[787]: tun0: Command: default: set ifaddr
10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: set phone *99***1#
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: set authname
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: set authkey
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: accept pap
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: accept chap
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: set timeout 300
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: add default HISADDR
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: resolv rewrite
Aug 25 21:00:51  ppp[787]: tun0: IPCP: Primary nameserver set to xxx.xx.250.6
Aug 25 21:00:51  ppp[787]: tun0: Command: rfcomm-dialup: set ifaddr
10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Aug 25 21:00:51  ppp[787]: tun0: Phase: PPP Started (direct mode).
Aug 25 21:00:51  ppp[787]: tun0: Phase: bundle: Establish
Aug 25 21:00:51  ppp[787]: tun0: Phase: deflink: closed -> opening
Aug 25 21:00:51  ppp[787]: tun0: Phase: deflink: Connected!
Aug 25 21:00:51  ppp[787]: tun0: Phase: deflink: opening -> dial
Aug 25 21:00:51  ppp[787]: tun0: Chat: deflink: Dial attempt 1 of 1
Aug 25 21:00:51  ppp[787]: tun0: Phase: deflink: dial -> carrier
Aug 25 21:00:51  ppp[787]: tun0: Phase: deflink: carrier -> login
Aug 25 21:00:51  ppp[787]: tun0: Phase: deflink: login -> lcp
Aug 25 21:00:51  ppp[787]: tun0: LCP: FSM: Using "deflink" as a transport
Aug 25 21:00:51  ppp[787]: tun0: LCP: deflink: State change Initial --> Closed
Aug 25 21:00:51  ppp[787]: tun0: LCP: deflink: State change Closed --> Stopped
Aug 25 21:00:52  ppp[787]: tun0: LCP: deflink: LayerStart
Aug 25 21:00:52  ppp[787]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped
Aug 25 21:00:52  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:52  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:52  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:52  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:52  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x9dd40950
Aug 25 21:00:52  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:52  ppp[787]: tun0: LCP: deflink: State change Stopped --> Req-Sent
Aug 25 21:00:52  ppp[787]: tun0: LCP: deflink: RecvConfigReq(1) state = Req-Sent
Aug 25 21:00:52  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:52  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:52  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:52  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:52  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x9dd40950
Aug 25 21:00:52  ppp[787]: tun0: LCP: Magic is same (9dd40950) - 1 times
Aug 25 21:00:53  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:53  ppp[787]: tun0: LCP: deflink: SendConfigNak(1) state = Req-Sent
Aug 25 21:00:53  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x9dd40950
Aug 25 21:00:53  ppp[787]: tun0: LCP: deflink: RecvConfigNak(1) state = Req-Sent
Aug 25 21:00:53  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x9dd40950
Aug 25 21:00:53  ppp[787]: tun0: LCP:  Magic 0x9dd40950 is NAKed!
Aug 25 21:00:53  ppp[787]: tun0: LCP: deflink: SendConfigReq(2) state = Req-Sent
Aug 25 21:00:53  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:53  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:53  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:53  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:53  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x2931b31e
Aug 25 21:00:53  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:53  ppp[787]: tun0: LCP: deflink: RecvConfigReq(2) state = Req-Sent
Aug 25 21:00:53  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:53  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:53  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:53  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:53  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x2931b31e
Aug 25 21:00:53  ppp[787]: tun0: LCP: Magic is same (2931b31e) - 2 times
Aug 25 21:00:54  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:54  ppp[787]: tun0: LCP: deflink: SendConfigNak(2) state = Req-Sent
Aug 25 21:00:54  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x2931b31e
Aug 25 21:00:54  ppp[787]: tun0: LCP: deflink: RecvConfigNak(2) state = Req-Sent
Aug 25 21:00:54  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x2931b31e
Aug 25 21:00:54  ppp[787]: tun0: LCP:  Magic 0x2931b31e is NAKed!
Aug 25 21:00:54  ppp[787]: tun0: LCP: deflink: SendConfigReq(3) state = Req-Sent
Aug 25 21:00:54  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:54  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:54  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:54  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:54  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xbddba679
Aug 25 21:00:54  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:54  ppp[787]: tun0: LCP: deflink: RecvConfigReq(3) state = Req-Sent
Aug 25 21:00:54  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:54  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:54  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:54  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:54  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xbddba679
Aug 25 21:00:54  ppp[787]: tun0: LCP: Magic is same (bddba679) - 3 times
Aug 25 21:00:56  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:56  ppp[787]: tun0: LCP: deflink: SendConfigNak(3) state = Req-Sent
Aug 25 21:00:56  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xbddba679
Aug 25 21:00:56  ppp[787]: tun0: LCP: deflink: RecvConfigNak(3) state = Req-Sent
Aug 25 21:00:56  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xbddba679
Aug 25 21:00:56  ppp[787]: tun0: LCP:  Magic 0xbddba679 is NAKed!
Aug 25 21:00:56  ppp[787]: tun0: LCP: deflink: SendConfigReq(4) state = Req-Sent
Aug 25 21:00:56  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:56  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:56  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:56  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:56  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x3d3daaeb
Aug 25 21:00:56  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:56  ppp[787]: tun0: LCP: deflink: RecvConfigReq(4) state = Req-Sent
Aug 25 21:00:56  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:56  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:56  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:56  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:56  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x3d3daaeb
Aug 25 21:00:56  ppp[787]: tun0: LCP: Magic is same (3d3daaeb) - 4 times
Aug 25 21:00:58  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:58  ppp[787]: tun0: LCP: deflink: SendConfigNak(4) state = Req-Sent
Aug 25 21:00:58  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x3d3daaeb
Aug 25 21:00:58  ppp[787]: tun0: LCP: deflink: RecvConfigNak(4) state = Req-Sent
Aug 25 21:00:58  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x3d3daaeb
Aug 25 21:00:58  ppp[787]: tun0: LCP:  Magic 0x3d3daaeb is NAKed!
Aug 25 21:00:58  ppp[787]: tun0: LCP: deflink: SendConfigReq(5) state = Req-Sent
Aug 25 21:00:58  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:58  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:58  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:58  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:58  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x009e7774
Aug 25 21:00:58  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:00:58  ppp[787]: tun0: LCP: deflink: RecvConfigReq(5) state = Req-Sent
Aug 25 21:00:58  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:00:58  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:00:58  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:00:58  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:00:58  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x009e7774
Aug 25 21:00:58  ppp[787]: tun0: LCP: Magic is same (009e7774) - 5 times
Aug 25 21:01:00  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:00  ppp[787]: tun0: LCP: deflink: SendConfigNak(5) state = Req-Sent
Aug 25 21:01:00  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x009e7774
Aug 25 21:01:00  ppp[787]: tun0: LCP: deflink: RecvConfigNak(5) state = Req-Sent
Aug 25 21:01:00  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x009e7774
Aug 25 21:01:00  ppp[787]: tun0: LCP:  Magic 0x009e7774 is NAKed!
Aug 25 21:01:00  ppp[787]: tun0: LCP: deflink: SendConfigReq(6) state = Req-Sent
Aug 25 21:01:00  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:00  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:00  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:00  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:00  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x8759ffc3
Aug 25 21:01:00  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:00  ppp[787]: tun0: LCP: deflink: RecvConfigReq(6) state = Req-Sent
Aug 25 21:01:00  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:00  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:00  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:00  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:00  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x8759ffc3
Aug 25 21:01:00  ppp[787]: tun0: LCP: Magic is same (8759ffc3) - 6 times
Aug 25 21:01:03  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:03  ppp[787]: tun0: LCP: deflink: SendConfigNak(6) state = Req-Sent
Aug 25 21:01:03  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x8759ffc3
Aug 25 21:01:03  ppp[787]: tun0: LCP: deflink: RecvConfigNak(6) state = Req-Sent
Aug 25 21:01:03  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x8759ffc3
Aug 25 21:01:03  ppp[787]: tun0: LCP:  Magic 0x8759ffc3 is NAKed!
Aug 25 21:01:03  ppp[787]: tun0: LCP: deflink: SendConfigReq(7) state = Req-Sent
Aug 25 21:01:03  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:03  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:03  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:03  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:03  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xcd5a9184
Aug 25 21:01:03  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:03  ppp[787]: tun0: LCP: deflink: RecvConfigReq(7) state = Req-Sent
Aug 25 21:01:03  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:03  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:03  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:03  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:03  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xcd5a9184
Aug 25 21:01:03  ppp[787]: tun0: LCP: Magic is same (cd5a9184) - 7 times
Aug 25 21:01:06  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:06  ppp[787]: tun0: LCP: deflink: SendConfigNak(7) state = Req-Sent
Aug 25 21:01:06  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xcd5a9184
Aug 25 21:01:06  ppp[787]: tun0: LCP: deflink: RecvConfigNak(7) state = Req-Sent
Aug 25 21:01:06  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xcd5a9184
Aug 25 21:01:06  ppp[787]: tun0: LCP:  Magic 0xcd5a9184 is NAKed!
Aug 25 21:01:06  ppp[787]: tun0: LCP: deflink: SendConfigReq(8) state = Req-Sent
Aug 25 21:01:06  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:06  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:06  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:06  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:06  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc69b0864
Aug 25 21:01:06  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:06  ppp[787]: tun0: LCP: deflink: RecvConfigReq(8) state = Req-Sent
Aug 25 21:01:06  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:06  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:06  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:06  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:06  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc69b0864
Aug 25 21:01:06  ppp[787]: tun0: LCP: Magic is same (c69b0864) - 8 times
Aug 25 21:01:10  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:10  ppp[787]: tun0: LCP: deflink: SendConfigNak(8) state = Req-Sent
Aug 25 21:01:10  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc69b0864
Aug 25 21:01:10  ppp[787]: tun0: LCP: deflink: RecvConfigNak(8) state = Req-Sent
Aug 25 21:01:10  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc69b0864
Aug 25 21:01:10  ppp[787]: tun0: LCP:  Magic 0xc69b0864 is NAKed!
Aug 25 21:01:10  ppp[787]: tun0: LCP: deflink: SendConfigReq(9) state = Req-Sent
Aug 25 21:01:10  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:10  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:10  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:10  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:10  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x6cd929d0
Aug 25 21:01:10  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:10  ppp[787]: tun0: LCP: deflink: RecvConfigReq(9) state = Req-Sent
Aug 25 21:01:10  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:10  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:10  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:10  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:10  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x6cd929d0
Aug 25 21:01:10  ppp[787]: tun0: LCP: Magic is same (6cd929d0) - 9 times
Aug 25 21:01:14  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:14  ppp[787]: tun0: LCP: deflink: SendConfigNak(9) state = Req-Sent
Aug 25 21:01:14  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x6cd929d0
Aug 25 21:01:14  ppp[787]: tun0: LCP: deflink: RecvConfigNak(9) state = Req-Sent
Aug 25 21:01:14  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x6cd929d0
Aug 25 21:01:14  ppp[787]: tun0: LCP:  Magic 0x6cd929d0 is NAKed!
Aug 25 21:01:14  ppp[787]: tun0: LCP: deflink: SendConfigReq(10) state
= Req-Sent
Aug 25 21:01:14  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:14  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:14  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:14  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:14  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc3bab09b
Aug 25 21:01:14  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:14  ppp[787]: tun0: LCP: deflink: RecvConfigReq(10) state
= Req-Sent
Aug 25 21:01:14  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:14  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:14  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:14  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:14  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc3bab09b
Aug 25 21:01:14  ppp[787]: tun0: LCP: Magic is same (c3bab09b) - 10 times
Aug 25 21:01:18  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:18  ppp[787]: tun0: LCP: deflink: SendConfigNak(10) state
= Req-Sent
Aug 25 21:01:18  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc3bab09b
Aug 25 21:01:18  ppp[787]: tun0: LCP: deflink: RecvConfigNak(10) state
= Req-Sent
Aug 25 21:01:18  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xc3bab09b
Aug 25 21:01:18  ppp[787]: tun0: LCP:  Magic 0xc3bab09b is NAKed!
Aug 25 21:01:18  ppp[787]: tun0: LCP: deflink: SendConfigReq(11) state
= Req-Sent
Aug 25 21:01:18  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:18  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:18  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:18  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:18  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x77b54c0b
Aug 25 21:01:18  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:18  ppp[787]: tun0: LCP: deflink: RecvConfigReq(11) state
= Req-Sent
Aug 25 21:01:18  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:18  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:18  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:18  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:18  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x77b54c0b
Aug 25 21:01:18  ppp[787]: tun0: LCP: Magic is same (77b54c0b) - 11 times
Aug 25 21:01:23  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:23  ppp[787]: tun0: LCP: deflink: SendConfigNak(11) state
= Req-Sent
Aug 25 21:01:23  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x77b54c0b
Aug 25 21:01:23  ppp[787]: tun0: LCP: deflink: RecvConfigNak(11) state
= Req-Sent
Aug 25 21:01:23  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x77b54c0b
Aug 25 21:01:23  ppp[787]: tun0: LCP:  Magic 0x77b54c0b is NAKed!
Aug 25 21:01:23  ppp[787]: tun0: LCP: deflink: SendConfigReq(12) state
= Req-Sent
Aug 25 21:01:23  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:23  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:23  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:23  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:23  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x13eaeaa3
Aug 25 21:01:23  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:23  ppp[787]: tun0: LCP: deflink: RecvConfigReq(12) state
= Req-Sent
Aug 25 21:01:23  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:23  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:23  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:23  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:23  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x13eaeaa3
Aug 25 21:01:23  ppp[787]: tun0: LCP: Magic is same (13eaeaa3) - 12 times
Aug 25 21:01:28  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:28  ppp[787]: tun0: LCP: deflink: SendConfigNak(12) state
= Req-Sent
Aug 25 21:01:28  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x13eaeaa3
Aug 25 21:01:28  ppp[787]: tun0: LCP: deflink: RecvConfigNak(12) state
= Req-Sent
Aug 25 21:01:28  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x13eaeaa3
Aug 25 21:01:28  ppp[787]: tun0: LCP:  Magic 0x13eaeaa3 is NAKed!
Aug 25 21:01:28  ppp[787]: tun0: LCP: deflink: SendConfigReq(13) state
= Req-Sent
Aug 25 21:01:28  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:28  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:28  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:28  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:28  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x7752d6eb
Aug 25 21:01:28  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:28  ppp[787]: tun0: LCP: deflink: RecvConfigReq(13) state
= Req-Sent
Aug 25 21:01:28  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:28  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:28  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:28  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:28  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x7752d6eb
Aug 25 21:01:28  ppp[787]: tun0: LCP: Magic is same (7752d6eb) - 13 times
Aug 25 21:01:34  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:34  ppp[787]: tun0: LCP: deflink: SendConfigNak(13) state
= Req-Sent
Aug 25 21:01:34  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x7752d6eb
Aug 25 21:01:34  ppp[787]: tun0: LCP: deflink: RecvConfigNak(13) state
= Req-Sent
Aug 25 21:01:34  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x7752d6eb
Aug 25 21:01:34  ppp[787]: tun0: LCP:  Magic 0x7752d6eb is NAKed!
Aug 25 21:01:34  ppp[787]: tun0: LCP: deflink: SendConfigReq(14) state
= Req-Sent
Aug 25 21:01:34  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:34  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:34  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:34  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:34  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x442d30a0
Aug 25 21:01:34  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:34  ppp[787]: tun0: LCP: deflink: RecvConfigReq(14) state
= Req-Sent
Aug 25 21:01:34  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:34  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:34  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:34  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:34  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x442d30a0
Aug 25 21:01:34  ppp[787]: tun0: LCP: Magic is same (442d30a0) - 14 times
Aug 25 21:01:40  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:40  ppp[787]: tun0: LCP: deflink: SendConfigNak(14) state
= Req-Sent
Aug 25 21:01:40  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x442d30a0
Aug 25 21:01:40  ppp[787]: tun0: LCP: deflink: RecvConfigNak(14) state
= Req-Sent
Aug 25 21:01:40  ppp[787]: tun0: LCP:  MAGICNUM[6] 0x442d30a0
Aug 25 21:01:40  ppp[787]: tun0: LCP:  Magic 0x442d30a0 is NAKed!
Aug 25 21:01:40  ppp[787]: tun0: LCP: deflink: SendConfigReq(15) state
= Req-Sent
Aug 25 21:01:40  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:40  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:40  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:40  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:40  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xf5901a72
Aug 25 21:01:40  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:40  ppp[787]: tun0: LCP: deflink: RecvConfigReq(15) state
= Req-Sent
Aug 25 21:01:40  ppp[787]: tun0: LCP:  ACFCOMP[2]
Aug 25 21:01:40  ppp[787]: tun0: LCP:  PROTOCOMP[2]
Aug 25 21:01:40  ppp[787]: tun0: LCP:  ACCMAP[6] 0x00000000
Aug 25 21:01:40  ppp[787]: tun0: LCP:  MRU[4] 1500
Aug 25 21:01:40  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xf5901a72
Aug 25 21:01:40  ppp[787]: tun0: LCP: Magic is same (f5901a72) - 15 times
Aug 25 21:01:46  ppp[787]: tun0: LCP:  QUALPROTO[8] proto c025, interval 30000ms
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: SendConfigNak(15) state
= Req-Sent
Aug 25 21:01:46  ppp[787]: tun0: LCP:  MAGICNUM[6] 0xf5901a72
Aug 25 21:01:46  ppp[787]: tun0: Phase: deflink: Too many LCP NAKs
sent - abandoning negotiation
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: SendIdent(0) state = Req-Sent
Aug 25 21:01:46  ppp[787]: tun0: LCP:  MAGICNUM 9ac2c342
Aug 25 21:01:46  ppp[787]: tun0: LCP:  TEXT user-ppp 3.4.2 (built May  7 2006)
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: SendTerminateReq(15)
state = Req-Sent
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: State change Req-Sent --> Closing
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: RecvConfigNak(15) state = Closing
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: RecvIdent(0) state = Closing
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: RecvIdent: magic
0x9ac2c342 is wrong, expecting 0x00000000
Aug 25 21:01:46  ppp[787]: tun0: LCP:  MAGICNUM 00000000
Aug 25 21:01:46  ppp[787]: tun0: LCP:  TEXT user-ppp 3.4.2 (built May
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: RecvTerminateReq(15)
state = Closing
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: SendTerminateAck(15)
state = Closing
Aug 25 21:01:46  ppp[787]: tun0: LCP: deflink: RecvTerminateAck(15),
dropped (expected 16)
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: SendTerminateReq(16)
state = Closing
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: RecvTerminateReq(16)
state = Closing
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: SendTerminateAck(16)
state = Closing
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: RecvTerminateAck(16)
state = Closing
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: LayerFinish
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: State change Closing --> Closed
Aug 25 21:01:49  ppp[787]: tun0: LCP: deflink: State change Closed --> Initial
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: Disconnected!
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: lcp -> logout
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: logout -> hangup
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: Disconnected!
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: Connect time: 58
secs: 1479 octets in, 1479 octets out
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: 35 packets in, 35 packets out
Aug 25 21:01:49  ppp[787]: tun0: Phase:  total 51 bytes/sec, peak 194
bytes/sec on Tue Aug 25 21:01:46 2009
Aug 25 21:01:49  ppp[787]: tun0: Phase: deflink: hangup -> closed
Aug 25 21:01:49  ppp[787]: tun0: Phase: bundle: Dead
Aug 25 21:01:49  ppp[787]: tun0: Phase: PPP Terminated (normal).

any help will be appreciated thanks :)


More information about the freebsd-questions mailing list