From owner-freebsd-net Tue Apr 2 23: 7: 6 2002 Delivered-To: freebsd-net@freebsd.org Received: from melchior.cuivre.fr.eu.org (melchior.enst.fr [137.194.161.6]) by hub.freebsd.org (Postfix) with ESMTP id ED26437B417 for ; Tue, 2 Apr 2002 23:07:01 -0800 (PST) Received: from melusine.cuivre.fr.eu.org (melusine.enst.fr [137.194.160.34]) by melchior.cuivre.fr.eu.org (Postfix) with ESMTP id D1FF2762D for ; Wed, 3 Apr 2002 09:06:59 +0200 (CEST) Received: by melusine.cuivre.fr.eu.org (Postfix, from userid 1000) id C9C4D2C3D1; Wed, 3 Apr 2002 09:06:58 +0200 (CEST) Date: Wed, 3 Apr 2002 09:06:58 +0200 From: Thomas Quinot To: freebsd-net@freebsd.org Subject: Userland ppp hung in Ack-Rcvd Message-ID: <20020403090658.A65499@melusine.cuivre.fr.eu.org> Mime-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline User-Agent: Mutt/1.2.5i Sender: owner-freebsd-net@FreeBSD.ORG Precedence: bulk List-ID: List-Archive: (Web Archive) List-Help: (List Instructions) List-Subscribe: List-Unsubscribe: X-Loop: FreeBSD.org I observed a peculiar situation today on an ADSL link using pptpclient and the userland ppp daemon: the LCP negociation hunk in state Ack-Rcvd for almost 3 hours (until I killed it) without any progress, but without timing out, either. Here is an excerpt from the log: Apr 3 05:25:02 melusine ppp[53064]: tun0: LCP: deflink: State change Initial --> Closed Apr 3 05:25:02 melusine ppp[53064]: tun0: LCP: deflink: State change Closed --> Stopped Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: deflink: LayerStart Apr 3 05:25:03 melusine ppp[53064]: tun0: Warning: deflink: Reducing configured MRU from 1500 to 1480 Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: ACFCOMP[2] Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: PROTOCOMP[2] Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: ACCMAP[6] 0x00000000 Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: MRU[4] 1480 Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: MAGICNUM[6] 0x91e371fe Apr 3 05:25:03 melusine ppp[53064]: tun0: LCP: deflink: State change Stopped --> Req-Sent Apr 3 05:25:06 melusine ppp[53064]: tun0: LCP: deflink: SendConfigReq(1) state = Req-Sent Apr 3 05:25:06 melusine ppp[53064]: tun0: LCP: ACFCOMP[2] Apr 3 05:25:06 melusine ppp[53064]: tun0: LCP: PROTOCOMP[2] Apr 3 05:25:06 melusine ppp[53064]: tun0: LCP: ACCMAP[6] 0x00000000 Apr 3 05:25:06 melusine ppp[53064]: tun0: LCP: MRU[4] 1480 Apr 3 05:25:06 melusine ppp[53064]: tun0: LCP: MAGICNUM[6] 0x91e371fe Apr 3 05:25:09 melusine ppp[53064]: tun0: LCP: deflink: SendConfigReq(1) state = Req-Sent Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: ACFCOMP[2] Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: PROTOCOMP[2] Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: ACCMAP[6] 0x00000000 Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: MRU[4] 1480 Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: MAGICNUM[6] 0x91e371fe Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: deflink: RecvConfigAck(1) state = Req-Sent Apr 3 05:25:10 melusine ppp[53064]: tun0: LCP: deflink: State change Req-Sent --> Ack-Rcvd Apr 3 08:11:27 melusine ppp[53064]: tun0: Phase: Signal 15, terminate. In other sessions that I have a trace of, I never enter Ack-Recvd, but instead: Apr 3 08:12:07 melusine ppp[61776]: tun0: LCP: deflink: RecvConfigReq(224) state = Req-Sent This box is running 4.5-STABLE kernel and world cvsuppsed 10 days or so ago. Any idea why it did not time out? Thomas. -- Thomas.Quinot@Cuivre.FR.EU.ORG To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-net" in the body of the message