From owner-freebsd-stable@FreeBSD.ORG Fri Dec 7 16:06:40 2007 Return-Path: Delivered-To: freebsd-stable@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 8DB2116A46E; Fri, 7 Dec 2007 16:06:40 +0000 (UTC) (envelope-from cpghost@cordula.ws) Received: from fw.farid-hajji.net (fw.farid-hajji.net [213.146.115.42]) by mx1.freebsd.org (Postfix) with ESMTP id B642F13C4CE; Fri, 7 Dec 2007 16:06:38 +0000 (UTC) (envelope-from cpghost@cordula.ws) Received: from epia-2.farid-hajji.net (epia-2 [192.168.254.11]) by fw.farid-hajji.net (Postfix) with ESMTP id 1D51BE08DC; Fri, 7 Dec 2007 17:06:37 +0100 (CET) Date: Fri, 7 Dec 2007 17:06:34 +0100 From: cpghost To: Alexander Motin Message-ID: <20071207170634.4693a7f5@epia-2.farid-hajji.net> In-Reply-To: <4757E39C.8020009@FreeBSD.org> References: <20071206030500.746c782d@epia-2.farid-hajji.net> <4757E39C.8020009@FreeBSD.org> Organization: Cordula's Web X-Mailer: Claws Mail 3.0.2 (GTK+ 2.12.1; i386-portbld-freebsd6.2) Mime-Version: 1.0 Content-Type: text/plain; charset=US-ASCII Content-Transfer-Encoding: 7bit Cc: Julian Elischer , freebsd-stable@freebsd.org Subject: Re: "no matching session" in ng_pppoe.c 1.74.2.4? (RELENG_6) X-BeenThere: freebsd-stable@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Production branch of FreeBSD source code List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Fri, 07 Dec 2007 16:06:40 -0000 On Thu, 06 Dec 2007 13:57:16 +0200 Alexander Motin wrote: > cpghost wrote: > > The problem is that the last mile carrier of the PPP provider > > that this router is attached to disconnects the ppp session > > forcibly once every 24h. Before the update, ppp would detect > > this and reconnect immediately. After the update, ppp doesn't > > recover gracefully from this anymore, but spits out on the > > console: > > > > ng_pppoe[5]: no matching session > > > > for hours, and tries to connect again every two minutes without > > success, until I manually stop and restart the userland ppp daemon > > (and then the connection is immediately restored with a new > > session). I've tried this for a few days now, and it is always the > > same: it's definitely not a problem on the provider's side: As soon > > as ppp restarts, it gets a new session without any problems and > > connects again. > > > > Since the last working sources were from 2007/09/25, and > > ng_pppoe.c was at rev. 1.74.2.3; and the new revision of > > ng_pppoe.c is now at 1.74.2.4; I'm suspecting that whatever > > was changed there could be the cause (because this "no matching > > session" is being logged from there). > > I have tested and unable to reproduce that myself with ppp -> mpd or > mpd > - -> mpd PPPoE connections. Actually I am not sure about any > difference between reconnect and ppp restart. From the ng_pppoe node > point of view it should be the same. > > Could you provide tcpdump output for connection tries from your > Ethernet interface? Use "-pes 0" options please. Hi again, no luck this time: I just went through the 24h disconnect with tcpdump watching, but this time, ppp did reconnect flawlessly: [... packets belonging to ses 0x1d06 ..., then:] 16:03:28.367734 00:90:1a:a0:15:b7 > 00:00:24:c2:45:74, ethertype PPPoE D (0x8863), length 64: PPPoE PADT [ses 0x1d06] 16:03:28.368035 00:00:24:c2:45:74 > 00:90:1a:a0:15:b7, ethertype PPPoE D (0x8863), length 38: PPPoE PADT [ses 0x1d06] [Generic-Error "session closed"] 16:06:22.211545 00:00:24:c2:45:74 > ff:ff:ff:ff:ff:ff, ethertype PPPoE D (0x8863), length 32: PPPoE PADI [Host-Uniq 0x405B1AC1] [Service-Name] 16:06:22.383675 00:90:1a:a0:15:b7 > 00:00:24:c2:45:74, ethertype PPPoE D (0x8863), length 66: PPPoE PADO [AC-Name "DSSX43-erx"] [Host-Uniq 0x405B1AC1] [Service-Name] [AC-Cookie "..7\t.K.,.!y.y.E"] 16:06:22.383871 00:00:24:c2:45:74 > 00:90:1a:a0:15:b7, ethertype PPPoE D (0x8863), length 66: PPPoE PADR [Host-Uniq 0x405B1AC1] [AC-Cookie "..7\t.K.,.!y.y.E"] [AC-Name "DSSX43-erx"] [Service-Name] 16:06:22.503154 00:90:1a:a0:15:b7 > 00:00:24:c2:45:74, ethertype PPPoE D (0x8863), length 66: PPPoE PADS [ses 0xb6b] [Service-Name] [Host-Uniq 0x405B1AC1] [AC-Name "DSSX43-erx"] [AC-Cookie "..7\t.K.,.!y.y.E"] 16:06:24.243677 00:00:24:c2:45:74 > 00:90:1a:a0:15:b7, ethertype PPPoE S (0x8864), length 36: PPPoE [ses 0xb6b] LCP (0xc021), length 16: LCP, Conf-Request (0x01), id 4, length 16 [... more LCP packets belonging to ses 0xb6b ...] So the PADT/PADI/PADO/PADR/PADS sequence is correct. Maybe the PADT got lost on its way to this box the last times? Would ng_pppoe.c handle this case gracefully? Anyway, I will monitor this a few more days with tcpdump and report back should a "no matching session" come up again. Thanks, -cpghost. -- Cordula's Web. http://www.cordula.ws/