From owner-freebsd-net@FreeBSD.ORG Mon Jun 21 16:06:15 2004 Return-Path: Delivered-To: freebsd-net@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 84D5716A4CE for ; Mon, 21 Jun 2004 16:06:15 +0000 (GMT) Received: from rwcrmhc13.comcast.net (rwcrmhc13.comcast.net [204.127.198.39]) by mx1.FreeBSD.org (Postfix) with ESMTP id 4FEA143D5C for ; Mon, 21 Jun 2004 16:06:13 +0000 (GMT) (envelope-from julian@elischer.org) Received: from interjet.elischer.org ([24.7.73.28]) by comcast.net (rwcrmhc13) with ESMTP id <2004062116060101500t01dle>; Mon, 21 Jun 2004 16:06:01 +0000 Received: from localhost (localhost.elischer.org [127.0.0.1]) by InterJet.elischer.org (8.9.1a/8.9.1) with ESMTP id JAA36516; Mon, 21 Jun 2004 09:05:59 -0700 (PDT) Date: Mon, 21 Jun 2004 09:05:58 -0700 (PDT) From: Julian Elischer To: Yohan In-Reply-To: <20040621091112.87515.qmail@web60810.mail.yahoo.com> Message-ID: MIME-Version: 1.0 Content-Type: TEXT/PLAIN; charset=US-ASCII cc: freebsd-net@freebsd.org Subject: Re: PPPoE X-BeenThere: freebsd-net@freebsd.org X-Mailman-Version: 2.1.1 Precedence: list List-Id: Networking and TCP/IP with FreeBSD List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Mon, 21 Jun 2004 16:06:15 -0000 a tcpdump of the ethernet interface can be useful too.. On Mon, 21 Jun 2004, Yohan wrote: > 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 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 > _______________________________________________ > freebsd-net@freebsd.org mailing list > http://lists.freebsd.org/mailman/listinfo/freebsd-net > To unsubscribe, send any mail to "freebsd-net-unsubscribe@freebsd.org" >