ppp connection drops because of a flood of LCP Req
ml-vic
ml-vic at de-martino.it
Fri Mar 23 21:13:47 UTC 2007
For a very long time I've being using a umts pcmcia card so it was easy to me
modify a bit ppp.conf file as below to connect my pc thru bluetooth and my
cell phone used as modem:
#################################################################
# PPP Sample Configuration File
#################################################################
default:
set log Phase Chat LCP IPCP CCP tun command
ident user-ppp VERSION (built COMPILATIONDATE)
rfcomm-dialup:
set device /dev/ubt0
enable force-scripts
set phone *99\#
set mtu 300
set mru 300
enable dns
disable mppe
enable lqr
set dial "ABORT BUSY ABORT NO\sCARRIER TIMEOUT 5 \
\"\" ATZ OK-AT-OK ATE1Q0 OK \
AT+CGDCONT=1,\\\"IP\\\",\\\"web.omnitel.it\\\",\\\"0.0.0.0\\\" OK \
\\dATDT\\T TIMEOUT 40 CONNECT"
set authname # those can be usually chosen at will
set authkey
disable vjcomp
disable deflate
disable protocomp
set dns 83.224.66.134 83.224.65.134
set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
add default HISADDR
##################################
And then launch
# rfcomm_pppd -a 00:12:d2:65:c2:03 -c -C dun -l rfcomm-dialup
ppp starts, chats, tries to connect to the provider but drops after a while
issuing a flood of LCP requests (see below ppp.log)
Any idea?
Ciao
Vittorio
Mar 23 14:06:24 NbBSD ppp[1093]: Phase: Using interface: tun0
Mar 23 14:06:24 NbBSD ppp[1093]: Phase: deflink: Created in closed state
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: ident user-ppp
VERSION (built COMPILATIONDATE)
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: set device /dev/cuad0
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: set speed 115200
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: set dial ABORT BUSY
ABORT NO\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK \dATDT\T
TIMEOUT 40 CONNECT
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: set timeout 180
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: enable dns
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: set log Phase Chat
LCP IPCP CCP tun command
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: default: ident user-ppp
VERSION (built COMPILATIONDATE)
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set
device /dev/ubt0
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: enable
force-scripts
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set phone *99#
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set mtu 300
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set mru 300
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: enable dns
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: disable mppe
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: enable lqr
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set dial ABORT
BUSY ABORT NOsCARRIER TIMEOUT 5 "" ATZ OK-AT-OK ATE1Q0 OK AT+CGDCONT=1,
\"IP\",\"web.omnitel.it\",\"0.0.0.0\" OK \dATDT\T TIMEOUT 40 CONNECT
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set authname
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set authkey
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: disable vjcomp
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: disable deflate
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: disable
protocomp
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set dns
83.224.66.134 83.224.65.134
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: set ifaddr
10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Command: rfcomm-dialup: add default
HISADDR
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Phase: PPP Started (direct mode).
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Phase: bundle: Establish
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Phase: deflink: closed -> opening
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Phase: deflink: Connected!
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Phase: deflink: opening -> dial
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Phone: *99#
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: deflink: Dial attempt 1 of 1
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Send: ATZ^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Expect(5): OK
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Received: ATZ^M^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Received: OK^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Send: ATE1Q0^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Expect(5): OK
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Received: ATE1Q0^M^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Received: OK^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Send:
AT+CGDCONT=1,"IP","web.omnitel.it","0.0.0.0"^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Expect(5): OK
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Received:
AT+CGDCONT=1,"IP","web.omnitel.it","0.0.0.0"^M^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Received: OK^M
Mar 23 14:06:24 NbBSD ppp[1093]: tun0: Chat: Send: ATDT*99#^M
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: Chat: Expect(40): CONNECT
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: Chat: Received: ATDT*99#^M^M
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: Chat: Received: CONNECT^M
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: Phase: deflink: dial -> carrier
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: Phase: deflink: carrier -> login
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: Phase: deflink: login -> lcp
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: LCP: FSM: Using "deflink" as a
transport
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: LCP: deflink: State change Initial -->
Closed
Mar 23 14:06:26 NbBSD ppp[1093]: tun0: LCP: deflink: State change Closed -->
Stopped
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: LayerStart
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(1) state =
Stopped
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACFCOMP[2]
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MAGICNUM[6] 0xc9837379
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: QUALPROTO[8] proto c025, interval
30000ms
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: State change Stopped -->
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigRej(1) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendIdent(0) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MAGICNUM c9837379
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: TEXT user-ppp 3.4.2 (built Jan 15
2007)
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACFCOMP[2]
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MAGICNUM[6] 0xc9837379
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: Magic 0xc9837379 is REJected!
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: QUALPROTO[8] proto c025, interval
30000ms
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(2) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvCodeRej(0) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(2) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(3) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(3) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(4) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(4) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(5) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(5) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(6) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(6) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(7) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(7) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(8) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(8) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(9) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(9) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(10) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(10) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(11) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(11) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(12) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(12) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(13) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(13) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(14) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(14) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendConfigReq(15) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 300
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvConfigNak(15) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MRU[4] 1500
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: Too many LCP REQs
sent - abandoning negotiation
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendIdent(1) state =
Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: MAGICNUM 00000000
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: TEXT user-ppp 3.4.2 (built Jan 15
2007)
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: SendTerminateReq(16)
state = Req-Sent
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: State change Req-Sent -->
Closing
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvCodeRej(1) state =
Closing
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: RecvTerminateAck(16)
state = Closing
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: LayerFinish
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: State change Closing -->
Closed
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: LCP: deflink: State change Closed -->
Initial
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: Disconnected!
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: lcp -> logout
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: logout -> hangup
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: Disconnected!
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: Connect time: 3 secs:
525 octets in, 699 octets out
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: 16 packets in, 18
packets out
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: total 408 bytes/sec, peak 0
bytes/sec on Fri Mar 23 14:06:24 2007
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: deflink: hangup -> closed
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: bundle: Dead
Mar 23 14:06:27 NbBSD ppp[1093]: tun0: Phase: PPP Terminated (normal).
Mar 23 17:08:29 NbBSD ppp[1465]: Phase: Using interface: tun0
Mar 23 17:08:29 NbBSD ppp[1465]: Phase: deflink: Created in closed state
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: ident user-ppp
VERSION (built COMPILATIONDATE)
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: set device /dev/cuad0
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: set speed 115200
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: set dial ABORT BUSY
ABORT NO\sCARRIER TIMEOUT 5 "" AT OK-AT-OK ATE1Q0 OK \dATDT\T
TIMEOUT 40 CONNECT
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: set timeout 180
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: enable dns
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: set log Phase Chat
LCP IPCP CCP tun command
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: default: ident user-ppp
VERSION (built COMPILATIONDATE)
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set
device /dev/ubt0
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: enable
force-scripts
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set phone *99#
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set mtu 300
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set mru 300
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: enable dns
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: disable mppe
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: enable lqr
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set dial ABORT
BUSY ABORT NOsCARRIER TIMEOUT 5 "" ATZ OK-AT-OK ATE1Q0 OK AT+CGDCONT=1,
\"IP\",\"web.omnitel.it\",\"0.0.0.0\" OK \dATDT\T TIMEOUT 40 CONNECT
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set authname
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set authkey
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: disable vjcomp
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: disable deflate
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: disable
protocomp
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set dns
83.224.66.134 83.224.65.134
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: set ifaddr
10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Command: rfcomm-dialup: add default
HISADDR
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Warning: Add route failed: 0.0.0.0/0
already exists
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Phase: PPP Started (direct mode).
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Phase: bundle: Establish
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Phase: deflink: closed -> opening
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Phase: deflink: Connected!
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Phase: deflink: opening -> dial
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Phone: *99#
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: deflink: Dial attempt 1 of 1
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Send: ATZ^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Expect(5): OK
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Received: ATZ^M^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Received: OK^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Send: ATE1Q0^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Expect(5): OK
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Received: ATE1Q0^M^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Received: OK^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Send:
AT+CGDCONT=1,"IP","web.omnitel.it","0.0.0.0"^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Expect(5): OK
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Received:
AT+CGDCONT=1,"IP","web.omnitel.it","0.0.0.0"^M^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Received: OK^M
Mar 23 17:08:29 NbBSD ppp[1465]: tun0: Chat: Send: ATDT*99#^M
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: Chat: Expect(40): CONNECT
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: Chat: Received: ATDT*99#^M^M
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: Chat: Received: CONNECT^M
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: Phase: deflink: dial -> carrier
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: Phase: deflink: carrier -> login
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: Phase: deflink: login -> lcp
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: LCP: FSM: Using "deflink" as a
transport
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: LCP: deflink: State change Initial -->
Closed
Mar 23 17:08:31 NbBSD ppp[1465]: tun0: LCP: deflink: State change Closed -->
Stopped
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: LayerStart
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(1) state =
Stopped
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACFCOMP[2]
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MAGICNUM[6] 0x40377ea4
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: QUALPROTO[8] proto c025, interval
30000ms
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: State change Stopped -->
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigRej(1) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendIdent(0) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MAGICNUM 40377ea4
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: TEXT user-ppp 3.4.2 (built Jan 15
2007)
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACFCOMP[2]
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MAGICNUM[6] 0x40377ea4
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: Magic 0x40377ea4 is REJected!
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: QUALPROTO[8] proto c025, interval
30000ms
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(2) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvCodeRej(0) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(2) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(3) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(3) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(4) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(4) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(5) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(5) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(6) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(6) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(7) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(7) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(8) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(8) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(9) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(9) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(10) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(10) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(11) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(11) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(12) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(12) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(13) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(13) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(14) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(14) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendConfigReq(15) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: ACCMAP[6] 0x00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 300
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvConfigNak(15) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MRU[4] 1500
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: Too many LCP REQs
sent - abandoning negotiation
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendIdent(1) state =
Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: MAGICNUM 00000000
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: TEXT user-ppp 3.4.2 (built Jan 15
2007)
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: SendTerminateReq(16)
state = Req-Sent
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: State change Req-Sent -->
Closing
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvCodeRej(1) state =
Closing
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: RecvTerminateAck(16)
state = Closing
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: LayerFinish
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: State change Closing -->
Closed
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: LCP: deflink: State change Closed -->
Initial
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: Disconnected!
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: lcp -> logout
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: logout -> hangup
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: Disconnected!
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: Connect time: 3 secs:
527 octets in, 700 octets out
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: 17 packets in, 18
packets out
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: total 409 bytes/sec, peak 0
bytes/sec on Fri Mar 23 17:08:29 2007
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: deflink: hangup -> closed
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: bundle: Dead
Mar 23 17:08:32 NbBSD ppp[1465]: tun0: Phase: PPP Terminated (normal).
More information about the freebsd-bluetooth
mailing list