Received: from maia.hub.org (unknown [200.46.204.183]) by mail.postgresql.org (Postfix) with ESMTP id B905C633923 for ; Mon, 3 Aug 2009 11:13:01 -0300 (ADT) Received: from mail.postgresql.org ([200.46.204.86]) by maia.hub.org (mx1.hub.org [200.46.204.183]) (amavisd-maia, port 10024) with ESMTP id 22324-08 for ; Mon, 3 Aug 2009 14:12:50 +0000 (UTC) X-Greylist: domain auto-whitelisted by SQLgrey-1.7.6 Received: from exprod7og105.obsmtp.com (exprod7og105.obsmtp.com [64.18.2.163]) by mail.postgresql.org (Postfix) with SMTP id CDB8463229C for ; Mon, 3 Aug 2009 11:12:50 -0300 (ADT) Received: from source ([209.85.200.174]) by exprod7ob105.postini.com ([64.18.6.12]) with SMTP ID DSNKSnbwYIFrvMVBk7s7Tp1+OKxll4BMl8Oj@postini.com; Mon, 03 Aug 2009 07:12:50 PDT Received: by wf-out-1314.google.com with SMTP id 25so980295wfc.25 for ; Mon, 03 Aug 2009 07:12:48 -0700 (PDT) MIME-Version: 1.0 Received: by 10.142.133.3 with SMTP id g3mr493807wfd.132.1249308768627; Mon, 03 Aug 2009 07:12:48 -0700 (PDT) In-Reply-To: <9837222c0908030656m6ed69a26gc90a6c94b41a4c47@mail.gmail.com> References: <200907311459.n6VExuSa036743@wwwmaster.postgresql.org> <20090731234901.GD11098@alvh.no-ip.org> <9837222c0908010828x7182494av3fd5909b64f4b2ad@mail.gmail.com> <9837222c0908030656m6ed69a26gc90a6c94b41a4c47@mail.gmail.com> Date: Mon, 3 Aug 2009 19:42:48 +0530 Message-ID: Subject: Re: BUG #4958: Stats collector hung on WaitForMultipleObjectsEx while attempting to recv a datagram From: Nikhil Sontakke To: Magnus Hagander Cc: Alvaro Herrera , Luke Koops , pgsql-bugs@postgresql.org Content-Type: text/plain; charset=ISO-8859-1 Content-Transfer-Encoding: quoted-printable X-Virus-Scanned: Maia Mailguard 1.0.1 X-Spam-Status: No, hits=-2.599 tagged_above=-10 required=5 tests=BAYES_00=-2.599 X-Spam-Level: X-Archive-Number: 200908/6 X-Sequence-Number: 23833 Hi, >>>> >>>>> ntdll.dll!NtWaitForMultipleObjects+0xc >>>>> kernel32.dll!WaitForMultipleObjectsEx+0x11a >>>>> postgres.exe!pgwin32_waitforsinglesocket+0x1ed >>>>> postgres.exe!pgwin32_recv+0x90 >>>>> postgres.exe!PgstatCollectorMain+0x17f >>>>> postgres.exe!SubPostmasterMain+0x33a >>>>> postgres.exe!main+0x168 >>>>> postgres.exe!__tmainCRTStartup+0x10f >>>>> kernel32.dll!BaseProcessStart+0x23 >>>> >>>> I have seen this problem too. =A0The process seems stuck for no good >>>> reason. =A0I wondered at the time if it could be a kernel issue. =A0I >>>> remember trying to send some data to the collector to verify whether >>>> it'd wake up, but no luck. =A0(I mean I couldn't find a way to do it o= n >>>> Windows). >>> >>> I have seen this as well, but only in cases where there has been >>> broken firewall software or such things involved. I have seen a couple >>> of reports from the field though. >>> >>> Anyway, this really is a should-never-happen thing. As soon as a new >>> packet is sent in, WaitForMultipleObjectsEx() should return right >>> away. And given that backends regularly send packets over, it >>> shouldn't be an issue even if we miss one... >>> >> >> And this fact should lend credence to Alvaro's (as well as mine) >> suspicions that it seems to be a Windows kernel issue. >> >> As a consequence, Magnus I was wondering if having a loop similar to >> the WRITE handling of waiting for a fixed timeout in a loop (rather >> than an INFINITE call to WaitForMultipleObjectsEx) inside the >> pgwin32_waitforsinglesocket() function will help for the READ case >> too? I believe Teogor Sigaev had raised a similar concern a while back >> about it: >> >> http://www.nabble.com/-GENERAL--Stats-collector-frozen--td8569977i20.htm= l > > Maybe. I'm unsure if it's enough to just try another > WaitForSingleObjectEx() on it, or if we need to actually issue a > WSARecv() on it as well. Maybe it would be enough to just change the > INIFINTE on line 318 of socket.c to a fixed value. That will loop down > to WSARecv() which should exit with WSAEWOULDBLOCK which will cause us > to do a short sleep and come back. But we'd have to change the limit > of 5 somehow then, since in theory we should wait forever. Maybe that > outer loop should just be a for(;;), what do you think? > Yes, line 318 seems to be a much better location to me. If Windows and it's socket logic behaves properly most of the times :), most of the calls should come out within the first few tries, so changing 5 to an infinite loop shouldn't hurt those normal use cases in theory. OTOH, I was wondering what if we kill the stats collector and on a restart the socket communication resumes properly. Would that conclusively mean that it is a flaw in our code? Regards, Nikhils > From what I understand, none of you have an environment where you can > reliably reproduce this? That means it's going to be a PITA to try to > figure out if we're actually fixing anything :S > > > -- > =A0Magnus Hagander > =A0Self: http://www.hagander.net/ > =A0Work: http://www.redpill-linpro.com/ > --=20 http://www.enterprisedb.com