URL: https://www.opennet.me/cgi-bin/openforum/vsluhboard.cgi
Форум: vsluhforumID1
Нить номер: 82823
[ Назад ]

Исходное сообщение
"Не коннектит PPPoE из-под FreeBSD7.0"

Отправлено PhoeniX , 12-Ноя-08 12:28 
Из FreeBSD по ppp пользовательского уровня пытаюсь подконнектиться к провайдеру (wi-fi), у которого стоит линуха. На стадии аутентификации провайдер рубит после отправки логина. У провайдера MSChapV2, MPPE40 или 128. Chap81 включил, MPPE и так дозволяется по умолчанию. Люди знающие, почитайте пожалуйста лог, почему меня рубит провайдер? Сам провайдер этого понять не может.
Из-под форточек коннект устанавливается без проблем, с той же машины, на том же оборудовании, с тем же логином/паролем.

Лог:
Nov 10 11:30:06 skynet ppp[1213]: Phase: Using interface: tun0
Nov 10 11:30:06 skynet ppp[1213]: Phase: deflink: Created in closed state
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: enable MSChapV2
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: set mppe
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: set mtu 1492
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: set mru 1492
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: set ifaddr 0 0
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: set device PPPoE:an0
Nov 10 11:30:21 skynet ppp[1213]: tun0: Command: default: enable dns
Nov 10 11:30:21 skynet ppp[1213]: tun0: Phase: PPP Started (interactive mode).
Nov 10 11:30:21 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:24 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:30:24 skynet ppp[1213]: tun0: Command: /dev/ttyp0: dial megalog
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 0x28389e78 = fopen("/etc/ppp/ppp.conf", "r")
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: ReadSystem: Checking default (/etc/ppp/ppp.conf).
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 0x28389e78 = fopen("/etc/ppp/ppp.conf", "r")
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: ReadSystem: Checking megalog (/etc/ppp/ppp.conf).
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 0x28389e78 = fopen("/etc/ppp/ppp.conf", "r")
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: ReadSystem: Checking megalog (/etc/ppp/ppp.conf).
Nov 10 11:30:24 skynet ppp[1213]: tun0: Command: megalog: set authname polyservice
Nov 10 11:30:24 skynet ppp[1213]: tun0: Command: megalog: set authkey ********
Nov 10 11:30:24 skynet ppp[1213]: tun0: Command: megalog: set dial
Nov 10 11:30:24 skynet ppp[1213]: tun0: Command: megalog: set login
Nov 10 11:30:24 skynet ppp[1213]: tun0: Command: megalog: add default HISADDR
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 3 = socket(17, 3, 0)
Nov 10 11:30:24 skynet ppp[1213]: tun0: Phase: bundle: Establish
Nov 10 11:30:24 skynet ppp[1213]: tun0: Phase: deflink: closed -> opening
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 0 = NgMkSockNode("", &cs, &ds)
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: List of netgraph node ``an0:'' (id 2) hooks:
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug:   Found orphans -> ethernet
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: Connecting netgraph socket .:tun0 -> [4]::tun0
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 4 = socket(2, 2, 0)
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 0 = ioctl(4, 3223349521, 0xbfbfdf7c)
Nov 10 11:30:24 skynet ppp[1213]: tun0: ID0: 0 = ioctl(4, 2149607696, 0xbfbfdf7c)
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: Sending PPPOE_CONNECT to .:tun0
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: Found the following interfaces:
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug:  Index 1, name "sis0"
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug:  Index 2, name "an0"
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug:  Index 3, name "plip0"
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug:  Index 4, name "lo0"
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug:  Index 5, name "tun0"
Nov 10 11:30:24 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:30:24 skynet ppp[1213]: tun0: Phase: deflink: Connected!
Nov 10 11:30:24 skynet ppp[1213]: tun0: Phase: deflink: opening -> dial
Nov 10 11:30:24 skynet ppp[1213]: tun0: Chat: deflink: Dial attempt 1 of 1
Nov 10 11:30:24 skynet ppp[1213]: tun0: Phase: deflink: dial -> carrier
Nov 10 11:30:24 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:30:24 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:25 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:30:25 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:30:25 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:30:25 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:30:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:30:25 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:30:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:26 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:30:26 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:30:26 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:30:26 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:30:26 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:30:26 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:30:26 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:27 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:30:27 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:30:27 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:30:27 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:30:27 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:30:27 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:30:27 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:28 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:30:28 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:30:28 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:30:28 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:30:28 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:30:28 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:30:28 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase: deflink: Disconnected!
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase: deflink: carrier -> hangup
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: deflink: Close
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase: deflink: Connect time: 5 secs: 0 octets in, 0 octets out
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase: deflink: 0 packets in, 0 packets out
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase:  total 0 bytes/sec, peak 0 bytes/sec on Mon Nov 10 11:30:24 2008
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase: deflink: hangup -> closed
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: route_IfDelete (5)
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: Found ff01:5::/32 <AF_UNSPEC>
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: route_IfDelete: Skip it (pass 0)
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: Found ff02:5::/32 fe80:5::20a:e6ff:fe13:86b3
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: route_IfDelete: Skip it (pass 0)
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: Found ff01:5::/32 <AF_UNSPEC>
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 2 = socket(17, 3, 0)
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 148 = write(2, data, 148)
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: wrote 148: cmd = Delete, dst = ff01:5::/32, gateway = <none>
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: Found ff02:5::/32 fe80:5::20a:e6ff:fe13:86b3
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 2 = socket(17, 3, 0)
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 148 = write(2, data, 148)
Nov 10 11:30:29 skynet ppp[1213]: tun0: Debug: wrote 148: cmd = Delete, dst = ff02:5::/32, gateway = <none>
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 2 = socket(2, 2, 0)
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 0 = ioctl(2, 3223349521, 0xbfbfeb0c)
Nov 10 11:30:29 skynet ppp[1213]: tun0: ID0: 0 = ioctl(2, 2149607696, 0xbfbfeb0c)
Nov 10 11:30:29 skynet ppp[1213]: tun0: Phase: bundle: Dead
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting dial timer[0x2840dd44]
Nov 10 11:30:29 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:30:59 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:30:59 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:30:59 skynet ppp[1213]: tun0: Timer: dial timer[0x2840dd44]: freq = 30.00s, next = 0.00s, state = running
Nov 10 11:30:59 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:30:59 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:15 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:15 skynet ppp[1213]: tun0: Command: /dev/ttyp0: ^[[A
Nov 10 11:31:15 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:21 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:21 skynet ppp[1213]: tun0: Command: /dev/ttyp0: dial megalog
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 0x28389e78 = fopen("/etc/ppp/ppp.conf", "r")
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: ReadSystem: Checking default (/etc/ppp/ppp.conf).
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 0x28389e78 = fopen("/etc/ppp/ppp.conf", "r")
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: ReadSystem: Checking megalog (/etc/ppp/ppp.conf).
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 0x28389e78 = fopen("/etc/ppp/ppp.conf", "r")
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: ReadSystem: Checking megalog (/etc/ppp/ppp.conf).
Nov 10 11:31:21 skynet ppp[1213]: tun0: Command: megalog: set authname polyservice
Nov 10 11:31:21 skynet ppp[1213]: tun0: Command: megalog: set authkey ********
Nov 10 11:31:21 skynet ppp[1213]: tun0: Command: megalog: set dial
Nov 10 11:31:21 skynet ppp[1213]: tun0: Command: megalog: set login
Nov 10 11:31:21 skynet ppp[1213]: tun0: Command: megalog: add default HISADDR
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 3 = socket(17, 3, 0)
Nov 10 11:31:21 skynet ppp[1213]: tun0: Phase: bundle: Establish
Nov 10 11:31:21 skynet ppp[1213]: tun0: Phase: deflink: closed -> opening
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 0 = NgMkSockNode("", &cs, &ds)
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: List of netgraph node ``an0:'' (id 2) hooks:
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug:   Found orphans -> ethernet
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: Connecting netgraph socket .:tun0 -> [4]::tun0
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 4 = socket(2, 2, 0)
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 0 = ioctl(4, 3223349521, 0xbfbfdf7c)
Nov 10 11:31:21 skynet ppp[1213]: tun0: ID0: 0 = ioctl(4, 2149607696, 0xbfbfdf7c)
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: Sending PPPOE_CONNECT to .:tun0
Nov 10 11:31:21 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:31:21 skynet ppp[1213]: tun0: Phase: deflink: Connected!
Nov 10 11:31:21 skynet ppp[1213]: tun0: Phase: deflink: opening -> dial
Nov 10 11:31:21 skynet ppp[1213]: tun0: Chat: deflink: Dial attempt 1 of 1
Nov 10 11:31:21 skynet ppp[1213]: tun0: Phase: deflink: dial -> carrier
Nov 10 11:31:21 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:31:21 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:22 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:31:22 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:31:22 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:31:22 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:31:22 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:31:22 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:31:22 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:23 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:31:23 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:31:23 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:31:23 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:31:23 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:31:23 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:31:23 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:24 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:31:24 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:31:24 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:31:24 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:31:24 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:31:24 skynet ppp[1213]: tun0: Debug: Waiting for carrier
Nov 10 11:31:24 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: physical throughput timer[0x2840f068]: freq = 1.00s, next = 0.00s, state = running
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting physical throughput timer[0x2840f068]
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: Received NGM_PPPOE_ACNAME (hook "RULEZZZ")
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: Received NGM_PPPOE_SESSIONID
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: Received NGM_PPPOE_SUCCESS
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: deflink: carrier -> login
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: deflink: login -> lcp
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: FSM: Using "deflink" as a transport
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: State change Initial --> Closed
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: State change Closed --> Stopped
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting LCP openmode timer[0x2840f15c] before physical throughput timer[0x2840f068], delta = 10
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c0 21 01 01 00 13 01 04 05 d4 03 05 c2 23 81 05  .!...........#..
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  06 1f 74 39 ab                                   ..t9.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorRead: read 21/2048 from 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c0 21 01 01 00 13 01 04 05 d4 03 05 c2 23 81 05  .!...........#..
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  06 1f 74 39 ab                                   ..t9.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPull: unknown -> 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PullPacket: Despatch proto 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: RecvConfigReq(1) state = Stopped
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MRU[4] 1492
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x81)
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MAGICNUM[6] 0x1f7439ab
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  ACFCOMP[2]
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  PROTOCOMP[2]
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  ACCMAP[6] 0x00000000
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MRU[4] 1492
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MAGICNUM[6] 0x4ff6c893
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x81)


Содержание

Сообщения в этом обсуждении
"Не коннектит PPPoE из-под FreeBSD7.0"
Отправлено PhoeniX , 12-Ноя-08 12:29 
лог дальше:
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: fsm_Output
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  01 01 00 1d 08 02 07 02 02 06 00 00 00 00 01 04  ................
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  05 d4 05 06 4f f6 c8 93 03 05 c2 23 81           ....O......#.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPush: Using 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c0 21 01 01 00 1d 08 02 07 02 02 06 00 00 00 00  .!..............
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  01 04 05 d4 05 06 4f f6 c8 93 03 05 c2 23 81     ......O......#.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PushPacket: Transmit proto 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_enqueue: len = 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting LCP restart timer[0x2840f13c]
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: SendConfigAck(1) state = Stopped
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MRU[4] 1492
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x81)
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MAGICNUM[6] 0x1f7439ab
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: fsm_Output
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  02 01 00 13 01 04 05 d4 03 05 c2 23 81 05 06 1f  ...........#....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  74 39 ab                                         t9.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPush: Using 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c0 21 02 01 00 13 01 04 05 d4 03 05 c2 23 81 05  .!...........#..
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  06 1f 74 39 ab                                   ..t9.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PushPacket: Transmit proto 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_enqueue: len = 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: LayerStart
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: State change Stopped --> Ack-Sent
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(w) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_dequeue: queue len = 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_Dequeue: Dequeued from queue 1, containing 1 more packets
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c0 21 01 01 00 1d 08 02 07 02 02 06 00 00 00 00  .!..............
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  01 04 05 d4 05 06 4f f6 c8 93 03 05 c2 23 81     ......O......#.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorWrite: wrote 31(31) to 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(w) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_dequeue: queue len = 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_Dequeue: Dequeued from queue 1, containing 0 more packets
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c0 21 02 01 00 13 01 04 05 d4 03 05 c2 23 81 05  .!...........#..
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  06 1f 74 39 ab                                   ..t9.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorWrite: wrote 21(21) to 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c0 21 02 01 00 1d 08 02 07 02 02 06 00 00 00 00  .!..............
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  01 04 05 d4 05 06 4f f6 c8 93 03 05 c2 23 81     ......O......#.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorRead: read 31/2048 from 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c0 21 02 01 00 1d 08 02 07 02 02 06 00 00 00 00  .!..............
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  01 04 05 d4 05 06 4f f6 c8 93 03 05 c2 23 81     ......O......#.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPull: unknown -> 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PullPacket: Despatch proto 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: RecvConfigAck(1) state = Ack-Sent
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  ACFCOMP[2]
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  PROTOCOMP[2]
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  ACCMAP[6] 0x00000000
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MRU[4] 1492
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  MAGICNUM[6] 0x4ff6c893
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP:  AUTHPROTO[5] 0xc223 (CHAP 0x81)
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: State change Ack-Sent --> Opened
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: LayerUp
Nov 10 11:31:25 skynet ppp[1213]: tun0: LQM: deflink: LQR/LCP ECHO not negotiated
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting hdlc timer[0x28411db0]
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: bundle: Authenticate
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: deflink: his = CHAP 0x81, mine = CHAP 0x81
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: CHAP81: Challenge
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: ChapOutput
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  01 01 00 15 10 e3 34 18 f1 27 f4 12 e4 bb de 68  ......4..'.....h
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  7b 78 a3 f5 ee                                   {x...
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: Chap Output: CHALLENGE
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPush: Using 0xc223
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c2 23 01 01 00 15 10 e3 34 18 f1 27 f4 12 e4 bb  .#......4..'....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  de 68 7b 78 a3 f5 ee                             .h{x...
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PushPacket: Transmit proto 0xc223
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_enqueue: len = 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting auth timer[0x2840e034] before hdlc timer[0x28411db0], delta = 20
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(w) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c2 23 01 01 00 1c 10 32 07 ba 51 93 e9 54 da 84  .#.....2..Q..T..
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  2c 9b 29 3a 4b 9b cd 52 55 4c 45 5a 5a 5a        ,.):K..RULEZZZ
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorRead: read 30/2048 from 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c2 23 01 01 00 1c 10 32 07 ba 51 93 e9 54 da 84  .#.....2..Q..T..
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  2c 9b 29 3a 4b 9b cd 52 55 4c 45 5a 5a 5a        ,.):K..RULEZZZ
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPull: unknown -> 0xc223
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PullPacket: Despatch proto 0xc223
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: Chap Input: CHALLENGE (16 bytes from RULEZZZ)
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: ChapOutput
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  02 01 00 41 31 e3 34 18 f1 27 f4 12 e4 bb de 68  ...A1.4..'.....h
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  7b 78 a3 f5 ee 00 00 00 00 00 00 00 00 fb 54 f7  {x............T.
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  0c 5e 91 f1 83 83 9d 09 74 0b 72 f0 29 ac ff 52  .^......t.r.)..R
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  11 78 bf ce c0 00 70 6f 6c 79 73 65 72 76 69 63  .x....polyservic
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  65                                               e
Nov 10 11:31:25 skynet ppp[1213]: tun0: Phase: Chap Output: RESPONSE (polyservice)
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPush: Using 0xc223
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c2 23 02 01 00 41 31 e3 34 18 f1 27 f4 12 e4 bb  .#...A1.4..'....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  de 68 7b 78 a3 f5 ee 00 00 00 00 00 00 00 00 fb  .h{x............
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  54 f7 0c 5e 91 f1 83 83 9d 09 74 0b 72 f0 29 ac  T..^......t.r.).
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  ff 52 11 78 bf ce c0 00 70 6f 6c 79 73 65 72 76  .R.x....polyserv
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  69 63 65                                         ice
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PushPacket: Transmit proto 0xc223
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_enqueue: len = 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_dequeue: queue len = 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_Dequeue: Dequeued from queue 1, containing 1 more packets
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c2 23 01 01 00 15 10 e3 34 18 f1 27 f4 12 e4 bb  .#......4..'....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  de 68 7b 78 a3 f5 ee                             .h{x...
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorWrite: wrote 23(23) to 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(w) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_dequeue: queue len = 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_Dequeue: Dequeued from queue 1, containing 0 more packets
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c2 23 02 01 00 41 31 e3 34 18 f1 27 f4 12 e4 bb  .#...A1.4..'....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  de 68 7b 78 a3 f5 ee 00 00 00 00 00 00 00 00 fb  .h{x............
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  54 f7 0c 5e 91 f1 83 83 9d 09 74 0b 72 f0 29 ac  T..^......t.r.).
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  ff 52 11 78 bf ce c0 00 70 6f 6c 79 73 65 72 76  .R.x....polyserv
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  69 63 65                                         ice
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorWrite: wrote 67(67) to 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c0 21 05 02 00 04                                .!....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorRead: read 6/2048 from 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Read
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c0 21 05 02 00 04                                .!....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPull: unknown -> 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PullPacket: Despatch proto 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: RecvTerminateReq(2) state = Opened
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: LayerDown
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: SendTerminateAck(2) state = Opened
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: fsm_Output
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug:  06 02 00 04                                      ....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: proto_LayerPush: Using 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync: Write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Sync:  c0 21 06 02 00 04                                .!....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_PushPacket: Transmit proto 0xc021
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_enqueue: len = 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting LCP restart timer[0x2840f13c] before auth timer[0x2840e034], delta = 20
Nov 10 11:31:25 skynet ppp[1213]: tun0: LCP: deflink: State change Opened --> Stopping
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(w) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: m_dequeue: queue len = 1
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: link_Dequeue: Dequeued from queue 1, containing 0 more packets
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical: write
Nov 10 11:31:25 skynet ppp[1213]: tun0: Physical:  c0 21 06 02 00 04                                .!....
Nov 10 11:31:25 skynet ppp[1213]: tun0: Debug: deflink: DescriptorWrite: wrote 6(6) to 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink(ctrl): fdset(r) 2
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(r) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: deflink: fdset(e) 3
Nov 10 11:31:25 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:26 skynet ppp[1213]: tun0: Timer: Select returns 1
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: Received NGM_PPPOE_CLOSE
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: Device disconnected
Nov 10 11:31:26 skynet ppp[1213]: tun0: LCP: deflink: State change Stopping --> Starting
Nov 10 11:31:26 skynet ppp[1213]: tun0: LCP: deflink: LayerFinish
Nov 10 11:31:26 skynet ppp[1213]: tun0: LCP: deflink: State change Starting --> Initial
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: Disconnected!
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: lcp -> logout
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: Disconnected!
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: logout -> hangup
Nov 10 11:31:26 skynet ppp[1213]: tun0: Debug: deflink: Close
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: Connect time: 5 secs: 88 octets in, 148 octets out
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: 4 packets in, 5 packets out
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase:  total 47 bytes/sec, peak 0 bytes/sec on Mon Nov 10 11:31:21 2008
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: deflink: hangup -> closed
Nov 10 11:31:26 skynet ppp[1213]: tun0: Debug: route_IfDelete (5)
Nov 10 11:31:26 skynet ppp[1213]: tun0: ID0: 2 = socket(2, 2, 0)
Nov 10 11:31:26 skynet ppp[1213]: tun0: ID0: 0 = ioctl(2, 3223349521, 0xbfbfeb0c)
Nov 10 11:31:26 skynet ppp[1213]: tun0: ID0: 0 = ioctl(2, 2149607696, 0xbfbfeb0c)
Nov 10 11:31:26 skynet ppp[1213]: tun0: Phase: bundle: Dead
Nov 10 11:31:26 skynet ppp[1213]: tun0: Timer: timer_Start: Inserting dial timer[0x2840dd44]
Nov 10 11:31:26 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0
Nov 10 11:31:56 skynet ppp[1213]: tun0: Timer: Select returns -1
Nov 10 11:31:56 skynet ppp[1213]: tun0: Timer: ---- Begin of Timer Service List---
Nov 10 11:31:56 skynet ppp[1213]: tun0: Timer: dial timer[0x2840dd44]: freq = 30.00s, next = 0.00s, state = running
Nov 10 11:31:56 skynet ppp[1213]: tun0: Timer: ---- End of Timer Service List ---
Nov 10 11:31:56 skynet ppp[1213]: tun0: Timer: prompt /dev/ttyp0: fdset(r) 0