Date: Mon, 21 Jun 2004 02:11:12 -0700 (PDT) From: Yohan <yohanphilip@yahoo.com> To: freebsd-net@freebsd.org Subject: Re: PPPoE Message-ID: <20040621091112.87515.qmail@web60810.mail.yahoo.com> In-Reply-To: <20040620184858.GA68020@cell.sick.ru>
next in thread | previous in thread | raw e-mail | index | archive | help
Gleb,
I have enclosed another copy of ppp.log with slightly
different results. Thanks for the help.
regards
Yohann
ppp.log
Jun 21 14:00:53 chennai ppp[353]: Phase: Using
interface: tun0
Jun 21 14:00:53 chennai ppp[353]: Phase: deflink:
Created in closed state
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
ident user-ppp VERSION (built COMPILATIONDATE)
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set device PPPoE:rl1
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set mru 1492
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set mtu 1492
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set speed sync
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
enable lqr
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set cd off
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set dial
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set login
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set timeout 0
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set authname hddias33
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set authkey ********
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
delete all
Jun 21 14:00:53 chennai ppp[353]: tun0: Debug:
route_IfDelete (8)
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
add default HISADDR
Jun 21 14:00:53 chennai ppp[353]: tun0: ID0: 9 =
socket(17, 3, 0)
Jun 21 14:00:53 chennai ppp[353]: tun0: ID0: 140 =
write(9, data, 140)
Jun 21 14:00:53 chennai ppp[353]: tun0: Debug: wrote
140: cmd = Add, dst = 0.0.0.0/0, gateway = 10.0.0.2
Jun 21 14:00:53 chennai ppp[353]: tun0: Command: bsnl:
enable dns
Jun 21 14:00:53 chennai ppp[354]: tun0: ID0:
0x282948a0 = fopen("/var/run/tun0.pid", "w")
Jun 21 14:00:53 chennai ppp[354]: tun0: Phase: PPP
Started (ddial mode).
Jun 21 14:00:53 chennai ppp[354]: tun0: Phase: bundle:
Establish
Jun 21 14:00:53 chennai ppp[354]: tun0: Phase:
deflink: closed -> opening
Jun 21 14:00:53 chennai ppp[354]: tun0: ID0: 0 =
NgMkSockNode("", &cs, &ds)
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: List of
netgraph node ``rl1:'' (id 2) hooks:
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug:
Creating PPPoE netgraph node [2]:orphans -> ethernet
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug:
Connecting netgraph socket .:tun0 -> rl1:orphans:tun0
Jun 21 14:00:53 chennai ppp[354]: tun0: ID0: 2 =
socket(2, 2, 0)
Jun 21 14:00:53 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 3223349521, 0xbfbfed50)
Jun 21 14:00:53 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 2149607696, 0xbfbfed50)
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Sending
PPPOE_CONNECT to .:tun0
Jun 21 14:00:53 chennai ppp[354]: tun0: Warning:
deflink: Carrier must be set, using ``set cd 5!''
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Found
the following interfaces:
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
1, name "rl0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
2, name "rl1"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
3, name "lp0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
4, name "lo0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
5, name "ppp0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
6, name "sl0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
7, name "faith0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Index
8, name "tun0"
Jun 21 14:00:53 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:00:53 chennai ppp[354]: tun0: Phase:
deflink: Connected!
Jun 21 14:00:53 chennai ppp[354]: tun0: Phase:
deflink: opening -> dial
Jun 21 14:00:53 chennai ppp[354]: tun0: Phase:
deflink: dial -> carrier
Jun 21 14:00:53 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:00:54 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:00:54 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:00:54 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:00:54 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:00:54 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:00:54 chennai ppp[354]: tun0: Phase:
Received NGM_PPPOE_ACNAME (hook "BANYAN")
Jun 21 14:00:54 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:00:55 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:00:55 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:00:55 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:00:55 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:00:55 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:00:55 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:00:56 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:00:56 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:00:56 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:00:56 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:00:56 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:00:56 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:00:57 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:00:57 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:00:57 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:00:57 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:00:57 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:00:57 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:00:58 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:00:58 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:00:58 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:00:58 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:00:58 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase:
deflink: Disconnected!
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase:
deflink: carrier -> hangup
Jun 21 14:00:58 chennai ppp[354]: tun0: Debug:
deflink: Close
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase:
deflink: Connect time: 5 secs: 0 octets in, 0 octets
out
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase:
deflink: 0 packets in, 0 packets out
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase: total
0 bytes/sec, peak 0 bytes/sec on Mon Jun 21 14:00:53
2004
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase:
deflink: hangup -> opening
Jun 21 14:00:58 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting dial timer[0x80b7d44]
Jun 21 14:00:58 chennai ppp[354]: tun0: Phase:
deflink: Enter pause (30) for redialing.
Jun 21 14:01:28 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:01:28 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:01:28 chennai ppp[354]: tun0: Timer: dial
timer[0x80b7d44]: freq = 30.00s, next = 0.00s, state =
running
Jun 21 14:01:28 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:01:28 chennai ppp[354]: tun0: Chat: deflink:
Redial timer expired.
Jun 21 14:01:28 chennai ppp[354]: tun0: ID0: 0 =
NgMkSockNode("", &cs, &ds)
Jun 21 14:01:28 chennai ppp[354]: tun0: Debug: List of
netgraph node ``rl1:'' (id 2) hooks:
Jun 21 14:01:28 chennai ppp[354]: tun0: Debug: Found
orphans -> ethernet
Jun 21 14:01:28 chennai ppp[354]: tun0: Debug:
Connecting netgraph socket .:tun0 -> [4]::tun0
Jun 21 14:01:28 chennai ppp[354]: tun0: ID0: 2 =
socket(2, 2, 0)
Jun 21 14:01:28 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 3223349521, 0xbfbfed50)
Jun 21 14:01:28 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 2149607696, 0xbfbfed50)
Jun 21 14:01:28 chennai ppp[354]: tun0: Debug: Sending
PPPOE_CONNECT to .:tun0
Jun 21 14:01:28 chennai ppp[354]: tun0: Warning:
deflink: Carrier must be set, using ``set cd 5!''
Jun 21 14:01:28 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:01:28 chennai ppp[354]: tun0: Phase:
deflink: Connected!
Jun 21 14:01:28 chennai ppp[354]: tun0: Phase:
deflink: opening -> dial
Jun 21 14:01:28 chennai ppp[354]: tun0: Phase:
deflink: dial -> carrier
Jun 21 14:01:28 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:01:29 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:01:29 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:01:29 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:01:29 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:01:29 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:01:29 chennai ppp[354]: tun0: Phase:
Received NGM_PPPOE_ACNAME (hook "BANYAN")
Jun 21 14:01:29 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:01:30 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:01:30 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:01:30 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:01:30 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:01:30 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:01:30 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:01:31 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:01:31 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:01:31 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:01:31 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:01:31 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:01:31 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:01:32 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:01:32 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:01:32 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:01:32 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:01:32 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:01:32 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:01:33 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:01:33 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:01:33 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:01:33 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:01:33 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase:
deflink: Disconnected!
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase:
deflink: carrier -> hangup
Jun 21 14:01:33 chennai ppp[354]: tun0: Debug:
deflink: Close
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase:
deflink: Connect time: 5 secs: 0 octets in, 0 octets
out
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase:
deflink: 0 packets in, 0 packets out
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase: total
0 bytes/sec, peak 0 bytes/sec on Mon Jun 21 14:01:28
2004
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase:
deflink: hangup -> opening
Jun 21 14:01:33 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting dial timer[0x80b7d44]
Jun 21 14:01:33 chennai ppp[354]: tun0: Phase:
deflink: Enter pause (30) for redialing.
Jun 21 14:02:03 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:03 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:03 chennai ppp[354]: tun0: Timer: dial
timer[0x80b7d44]: freq = 30.00s, next = 0.00s, state =
running
Jun 21 14:02:03 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:03 chennai ppp[354]: tun0: Chat: deflink:
Redial timer expired.
Jun 21 14:02:03 chennai ppp[354]: tun0: ID0: 0 =
NgMkSockNode("", &cs, &ds)
Jun 21 14:02:03 chennai ppp[354]: tun0: Debug: List of
netgraph node ``rl1:'' (id 2) hooks:
Jun 21 14:02:03 chennai ppp[354]: tun0: Debug: Found
orphans -> ethernet
Jun 21 14:02:03 chennai ppp[354]: tun0: Debug:
Connecting netgraph socket .:tun0 -> [4]::tun0
Jun 21 14:02:03 chennai ppp[354]: tun0: ID0: 2 =
socket(2, 2, 0)
Jun 21 14:02:03 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 3223349521, 0xbfbfed50)
Jun 21 14:02:03 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 2149607696, 0xbfbfed50)
Jun 21 14:02:03 chennai ppp[354]: tun0: Debug: Sending
PPPOE_CONNECT to .:tun0
Jun 21 14:02:03 chennai ppp[354]: tun0: Warning:
deflink: Carrier must be set, using ``set cd 5!''
Jun 21 14:02:03 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:03 chennai ppp[354]: tun0: Phase:
deflink: Connected!
Jun 21 14:02:03 chennai ppp[354]: tun0: Phase:
deflink: opening -> dial
Jun 21 14:02:03 chennai ppp[354]: tun0: Phase:
deflink: dial -> carrier
Jun 21 14:02:03 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:04 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:04 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:04 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:04 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:04 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:04 chennai ppp[354]: tun0: Phase:
Received NGM_PPPOE_ACNAME (hook "BANYAN")
Jun 21 14:02:04 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:05 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:05 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:05 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:05 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:05 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:05 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:06 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:06 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:06 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:06 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:06 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:06 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:07 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:07 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:07 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:07 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:07 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:07 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:08 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:08 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:08 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:08 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:08 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase:
deflink: Disconnected!
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase:
deflink: carrier -> hangup
Jun 21 14:02:08 chennai ppp[354]: tun0: Debug:
deflink: Close
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase:
deflink: Connect time: 5 secs: 0 octets in, 0 octets
out
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase:
deflink: 0 packets in, 0 packets out
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase: total
0 bytes/sec, peak 0 bytes/sec on Mon Jun 21 14:02:03
2004
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase:
deflink: hangup -> opening
Jun 21 14:02:08 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting dial timer[0x80b7d44]
Jun 21 14:02:08 chennai ppp[354]: tun0: Phase:
deflink: Enter pause (30) for redialing.
Jun 21 14:02:38 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:38 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:38 chennai ppp[354]: tun0: Timer: dial
timer[0x80b7d44]: freq = 30.00s, next = 0.00s, state =
running
Jun 21 14:02:38 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:38 chennai ppp[354]: tun0: Chat: deflink:
Redial timer expired.
Jun 21 14:02:38 chennai ppp[354]: tun0: ID0: 0 =
NgMkSockNode("", &cs, &ds)
Jun 21 14:02:38 chennai ppp[354]: tun0: Debug: List of
netgraph node ``rl1:'' (id 2) hooks:
Jun 21 14:02:38 chennai ppp[354]: tun0: Debug: Found
orphans -> ethernet
Jun 21 14:02:38 chennai ppp[354]: tun0: Debug:
Connecting netgraph socket .:tun0 -> [4]::tun0
Jun 21 14:02:38 chennai ppp[354]: tun0: ID0: 2 =
socket(2, 2, 0)
Jun 21 14:02:38 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 3223349521, 0xbfbfed50)
Jun 21 14:02:38 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 2149607696, 0xbfbfed50)
Jun 21 14:02:38 chennai ppp[354]: tun0: Debug: Sending
PPPOE_CONNECT to .:tun0
Jun 21 14:02:38 chennai ppp[354]: tun0: Warning:
deflink: Carrier must be set, using ``set cd 5!''
Jun 21 14:02:38 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:38 chennai ppp[354]: tun0: Phase:
deflink: Connected!
Jun 21 14:02:38 chennai ppp[354]: tun0: Phase:
deflink: opening -> dial
Jun 21 14:02:38 chennai ppp[354]: tun0: Phase:
deflink: dial -> carrier
Jun 21 14:02:38 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:39 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:39 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:39 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:39 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:39 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:39 chennai ppp[354]: tun0: Phase:
Received NGM_PPPOE_ACNAME (hook "BANYAN")
Jun 21 14:02:39 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:40 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:40 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:40 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:40 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:40 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:40 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:41 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:41 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:41 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:41 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:41 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:41 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:42 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:42 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:42 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:42 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:42 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:42 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:02:43 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:02:43 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:02:43 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:02:43 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:02:43 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase:
deflink: Disconnected!
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase:
deflink: carrier -> hangup
Jun 21 14:02:43 chennai ppp[354]: tun0: Debug:
deflink: Close
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase:
deflink: Connect time: 5 secs: 0 octets in, 0 octets
out
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase:
deflink: 0 packets in, 0 packets out
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase: total
0 bytes/sec, peak 0 bytes/sec on Mon Jun 21 14:02:38
2004
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase:
deflink: hangup -> opening
Jun 21 14:02:43 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting dial timer[0x80b7d44]
Jun 21 14:02:43 chennai ppp[354]: tun0: Phase:
deflink: Enter pause (30) for redialing.
Jun 21 14:03:13 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:13 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:13 chennai ppp[354]: tun0: Timer: dial
timer[0x80b7d44]: freq = 30.00s, next = 0.00s, state =
running
Jun 21 14:03:13 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:13 chennai ppp[354]: tun0: Chat: deflink:
Redial timer expired.
Jun 21 14:03:13 chennai ppp[354]: tun0: ID0: 0 =
NgMkSockNode("", &cs, &ds)
Jun 21 14:03:13 chennai ppp[354]: tun0: Debug: List of
netgraph node ``rl1:'' (id 2) hooks:
Jun 21 14:03:13 chennai ppp[354]: tun0: Debug: Found
orphans -> ethernet
Jun 21 14:03:13 chennai ppp[354]: tun0: Debug:
Connecting netgraph socket .:tun0 -> [4]::tun0
Jun 21 14:03:13 chennai ppp[354]: tun0: ID0: 2 =
socket(2, 2, 0)
Jun 21 14:03:13 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 3223349521, 0xbfbfed50)
Jun 21 14:03:13 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 2149607696, 0xbfbfed50)
Jun 21 14:03:13 chennai ppp[354]: tun0: Debug: Sending
PPPOE_CONNECT to .:tun0
Jun 21 14:03:13 chennai ppp[354]: tun0: Warning:
deflink: Carrier must be set, using ``set cd 5!''
Jun 21 14:03:13 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:13 chennai ppp[354]: tun0: Phase:
deflink: Connected!
Jun 21 14:03:13 chennai ppp[354]: tun0: Phase:
deflink: opening -> dial
Jun 21 14:03:13 chennai ppp[354]: tun0: Phase:
deflink: dial -> carrier
Jun 21 14:03:13 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:14 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:14 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:14 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:14 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:14 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:14 chennai ppp[354]: tun0: Phase:
Received NGM_PPPOE_ACNAME (hook "BANYAN")
Jun 21 14:03:14 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:15 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:15 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:15 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:15 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:15 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:15 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:16 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:16 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:16 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:16 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:16 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:16 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:17 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:17 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:17 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:17 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:17 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:17 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:18 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:18 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:18 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:18 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:18 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase:
deflink: Disconnected!
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase:
deflink: carrier -> hangup
Jun 21 14:03:18 chennai ppp[354]: tun0: Debug:
deflink: Close
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase:
deflink: Connect time: 5 secs: 0 octets in, 0 octets
out
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase:
deflink: 0 packets in, 0 packets out
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase: total
0 bytes/sec, peak 0 bytes/sec on Mon Jun 21 14:03:13
2004
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase:
deflink: hangup -> opening
Jun 21 14:03:18 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting dial timer[0x80b7d44]
Jun 21 14:03:18 chennai ppp[354]: tun0: Phase:
deflink: Enter pause (30) for redialing.
Jun 21 14:03:48 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:48 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:48 chennai ppp[354]: tun0: Timer: dial
timer[0x80b7d44]: freq = 30.00s, next = 0.00s, state =
running
Jun 21 14:03:48 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:48 chennai ppp[354]: tun0: Chat: deflink:
Redial timer expired.
Jun 21 14:03:48 chennai ppp[354]: tun0: ID0: 0 =
NgMkSockNode("", &cs, &ds)
Jun 21 14:03:48 chennai ppp[354]: tun0: Debug: List of
netgraph node ``rl1:'' (id 2) hooks:
Jun 21 14:03:48 chennai ppp[354]: tun0: Debug: Found
orphans -> ethernet
Jun 21 14:03:48 chennai ppp[354]: tun0: Debug:
Connecting netgraph socket .:tun0 -> [4]::tun0
Jun 21 14:03:48 chennai ppp[354]: tun0: ID0: 2 =
socket(2, 2, 0)
Jun 21 14:03:48 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 3223349521, 0xbfbfed50)
Jun 21 14:03:48 chennai ppp[354]: tun0: ID0: 0 =
ioctl(2, 2149607696, 0xbfbfed50)
Jun 21 14:03:48 chennai ppp[354]: tun0: Debug: Sending
PPPOE_CONNECT to .:tun0
Jun 21 14:03:48 chennai ppp[354]: tun0: Warning:
deflink: Carrier must be set, using ``set cd 5!''
Jun 21 14:03:48 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:48 chennai ppp[354]: tun0: Phase:
deflink: Connected!
Jun 21 14:03:48 chennai ppp[354]: tun0: Phase:
deflink: opening -> dial
Jun 21 14:03:48 chennai ppp[354]: tun0: Phase:
deflink: dial -> carrier
Jun 21 14:03:48 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:49 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:49 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:49 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:49 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:49 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:49 chennai ppp[354]: tun0: Phase:
Received NGM_PPPOE_ACNAME (hook "BANYAN")
Jun 21 14:03:49 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:50 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:50 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:50 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:50 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:50 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:50 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:51 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:51 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:51 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:51 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:51 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:51 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:52 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:52 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:52 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:52 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:52 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:52 chennai ppp[354]: tun0: Debug: Waiting
for carrier
Jun 21 14:03:53 chennai ppp[354]: tun0: Timer: Select
returns -1
Jun 21 14:03:53 chennai ppp[354]: tun0: Timer: ----
Begin of Timer Service List---
Jun 21 14:03:53 chennai ppp[354]: tun0: Timer:
physical throughput timer[0x80ba068]: freq = 1.00s,
next = 0.00s, state = running
Jun 21 14:03:53 chennai ppp[354]: tun0: Timer: ----
End of Timer Service List ---
Jun 21 14:03:53 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting physical throughput
timer[0x80ba068]
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase:
deflink: Disconnected!
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase:
deflink: carrier -> hangup
Jun 21 14:03:53 chennai ppp[354]: tun0: Debug:
deflink: Close
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase:
deflink: Connect time: 5 secs: 0 octets in, 0 octets
out
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase:
deflink: 0 packets in, 0 packets out
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase: total
0 bytes/sec, peak 0 bytes/sec on Mon Jun 21 14:03:48
2004
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase:
deflink: hangup -> opening
Jun 21 14:03:53 chennai ppp[354]: tun0: Timer:
timer_Start: Inserting dial timer[0x80b7d44]
Jun 21 14:03:53 chennai ppp[354]: tun0: Phase:
deflink: Enter pause (30) for redialing.
--- Gleb Smirnoff <glebius@cell.sick.ru> wrote:
> On Sun, Jun 20, 2004 at 09:05:19AM -0700, Yohan
> wrote:
> Y> Im using PPPoE / FreeBSD 4.9 with a DSL line
> provided by my ISP. The same modem / line works fine
> / connects to the internet on a Windows 2000
> machine. But when i use it with my FreeBSD machine
> using ppp i get the following message in my ppp.log
> "-> Waiting for carrier" - "Last message repeated n
> times". I have followed the FreeBSD handbook
> instructions for setting up PPPoE. Have also tried
> various other articles related to PPPoE setup on
> FreeBSD. I have tried various other options like
> disabling carrier and others but i am unable to get
> past the "no carrier" problem. Any help will be
> greatly apreciated.
>
> Please show full ppp.log starting from the moment
> when you started dailing.
> Please also show your ppp.conf
>
> --
> Totus tuus, Glebius.
> GLEBIUS-RIPN GLEB-RIPE
>
__________________________________
Do you Yahoo!?
Yahoo! Mail - 50x more storage than other providers!
http://promotions.yahoo.com/new_mail
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20040621091112.87515.qmail>