From owner-freebsd-net@FreeBSD.ORG Thu Jan 21 12:45:40 2010 Return-Path: Delivered-To: freebsd-net@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 8E4CB106566C for ; Thu, 21 Jan 2010 12:45:40 +0000 (UTC) (envelope-from gorec2005@gmail.com) Received: from fg-out-1718.google.com (fg-out-1718.google.com [72.14.220.155]) by mx1.freebsd.org (Postfix) with ESMTP id 1957B8FC1E for ; Thu, 21 Jan 2010 12:45:39 +0000 (UTC) Received: by fg-out-1718.google.com with SMTP id 19so8134fgg.13 for ; Thu, 21 Jan 2010 04:45:39 -0800 (PST) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=gamma; h=domainkey-signature:mime-version:received:date:message-id:subject :from:to:content-type; bh=ia8Zl6KuEJSaLUb5926snL8s51ySDAGa+7Hz6nq7RYs=; b=hzlLFND9hfgXLzrbb6/OUp2YrK4Nd9A1lN60IHU2mGaHVsLMFReiPksqDZ4n0AvTJ5 VFeF6T0FMbFcOywpTSZNgzFGQ2OTRrsQ9hQFHDNG16Ymlh0OMFgB89+e2dLH6RbvaTB7 AjvIxHmiWIL7qUbSDa9nURocV2TU6b9Lo0tBA= DomainKey-Signature: a=rsa-sha1; c=nofws; d=gmail.com; s=gamma; h=mime-version:date:message-id:subject:from:to:content-type; b=hbub3z0VqeW9hFQIfst/32DB1g3b+n3ksKgu4aJKKSyFMRmeZ9v5oLMQmTg9uEb4LV Vg20IGEOsJ/6mYYKmFchDrD3VHHWfV8i9jrD9jBPTdudoOVTc8xxy18LVzDB1qEpJbFH w4AyL8tGgWeNr8Kz8OmctuvvTmAYwSIciisNY= MIME-Version: 1.0 Received: by 10.87.62.1 with SMTP id p1mr2279183fgk.42.1264076258460; Thu, 21 Jan 2010 04:17:38 -0800 (PST) Date: Thu, 21 Jan 2010 15:17:38 +0300 Message-ID: <789b279c1001210417t62ed014ah2d47cb8cfe74e119@mail.gmail.com> From: gorec2005 gorec2005 To: freebsd-net@freebsd.org X-Mailman-Approved-At: Thu, 21 Jan 2010 12:52:21 +0000 Content-Type: text/plain; charset=ISO-8859-1 X-Content-Filtered-By: Mailman/MimeDel 2.1.5 Subject: Freebsd 8 (cvs_21.01.2010 12:00) + mpd5.4(CVS) FSM Repeated timeout X-BeenThere: freebsd-net@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Networking and TCP/IP with FreeBSD List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 21 Jan 2010 12:45:40 -0000 Log from mpd with enabled debug: Jan 21 13:30:01 vpn9 mpd: [PoE10-5] LCP: rec'd Configure Request #0 (Req-Sent) Jan 21 13:30:01 vpn9 mpd: [PoE10-5] MRU 1480 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] MAGICNUM 6b911a4b Jan 21 13:30:01 vpn9 mpd: [PoE10-5] CALLBACK 6 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] LCP: SendConfigRej #0 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] CALLBACK 6 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] xmit frame to link proto=0xc021 Jan 21 13:30:01 vpn9 mpd: ff 03 c0 21 04 00 00 07 0d 03 06 ...!....... Jan 21 13:30:01 vpn9 mpd: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Jan 21 13:30:01 vpn9 mpd: EVENT: Processing event EVENT_READ LinkNgDataEvent() Jan 21 13:30:01 vpn9 mpd: [PoE10-5] rec'd 16 bytes frame from link proto=0xc021 Jan 21 13:30:01 vpn9 mpd: c0 21 01 01 00 0e 01 04 05 c8 05 06 6b 91 1a 4b .!..........k..K Jan 21 13:30:01 vpn9 mpd: [PoE10-5] LCP: rec'd Configure Request #1 (Req-Sent) Jan 21 13:30:01 vpn9 mpd: [PoE10-5] MRU 1480 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] MAGICNUM 6b911a4b Jan 21 13:30:01 vpn9 mpd: [PoE10-5] LCP: SendConfigAck #1 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] MRU 1480 Jan 21 13:30:01 vpn9 mpd: [PoE10-5] MAGICNUM 6b911a4b Jan 21 13:30:01 vpn9 mpd: [PoE10-5] xmit frame to link proto=0xc021 Jan 21 13:30:01 vpn9 mpd: ff 03 c0 21 02 01 00 0e 01 04 05 c8 05 06 6b 91 ...!..........k. Jan 21 13:30:01 vpn9 mpd: 1a 4b .K Jan 21 13:30:01 vpn9 mpd: [PoE10-5] LCP: state change Req-Sent --> Ack-Sent Jan 21 13:30:01 vpn9 mpd: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Jan 21 13:30:04 vpn9 mpd: EVENT: Processing event EVENT_TIMEOUT TimerExpires() Jan 21 13:30:04 vpn9 mpd: EVENT: Processing timer "LCP" FsmTimeout() Jan 21 13:30:04 vpn9 mpd: [PoE10-5] LCP: SendConfigReq #2 Jan 21 13:30:04 vpn9 mpd: [PoE10-5] PROTOCOMP Jan 21 13:30:04 vpn9 mpd: [PoE10-5] MRU 1492 Jan 21 13:30:04 vpn9 mpd: [PoE10-5] MAGICNUM 5074160b Jan 21 13:30:04 vpn9 mpd: [PoE10-5] AUTHPROTO CHAP MSOFTv2 Jan 21 13:30:04 vpn9 mpd: [PoE10-5] xmit frame to link proto=0xc021 Jan 21 13:30:04 vpn9 mpd: ff 03 c0 21 01 02 00 15 07 02 01 04 05 d4 05 06 ...!............ Jan 21 13:30:04 vpn9 mpd: 50 74 16 0b 03 05 c2 23 81 Pt.....#. Jan 21 13:30:04 vpn9 mpd: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426 Jan 21 13:30:04 vpn9 mpd: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Jan 21 13:30:04 vpn9 mpd: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Jan 21 13:30:04 vpn9 mpd: EVENT: Processing timer "LCP" FsmTimeout() done Jan 21 13:30:04 vpn9 mpd: EVENT: Processing event EVENT_TIMEOUT TimerExpires() done Jan 21 13:30:04 vpn9 mpd: EVENT: Processing event EVENT_READ LinkNgDataEvent() Jan 21 13:30:04 vpn9 mpd: [PoE10-5] rec'd 8 bytes frame from link proto=0xc021 At position between Jan 21 13:30:01 vpn9 mpd: EVENT: Processing event EVENT_READ LinkNgDataEvent() done and Jan 21 13:30:04 vpn9 mpd: EVENT: Processing event EVENT_TIMEOUT TimerExpires() process stops - for a client it looks like the usual delay, but the appearance of such a clear and pleasant ... - Recommend that this can do?