Received: from malur.postgresql.org ([217.196.149.56]) by arkaria.postgresql.org with esmtp (Exim 4.84_2) (envelope-from ) id 1eCMjp-0005uD-LE for pgsql-performance@arkaria.postgresql.org; Wed, 08 Nov 2017 09:33:37 +0000 Received: from localhost ([127.0.0.1] helo=postgresql.org) by malur.postgresql.org with smtp (Exim 4.84_2) (envelope-from ) id 1eCMjo-0002LU-ML for pgsql-performance@arkaria.postgresql.org; Wed, 08 Nov 2017 09:33:36 +0000 Received: from magus.postgresql.org ([2a02:c0:301:0:ffff::29]) by malur.postgresql.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_CBC_SHA384:256) (Exim 4.84_2) (envelope-from ) id 1eCMi5-0007gQ-GX for pgsql-performance@postgresql.org; Wed, 08 Nov 2017 09:31:49 +0000 Received: from mail-lf0-x22c.google.com ([2a00:1450:4010:c07::22c]) by magus.postgresql.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_CBC_SHA1:256) (Exim 4.84_2) (envelope-from ) id 1eCMi0-0003rT-DG for pgsql-performance@postgresql.org; Wed, 08 Nov 2017 09:31:48 +0000 Received: by mail-lf0-x22c.google.com with SMTP id r135so2330478lfe.5 for ; Wed, 08 Nov 2017 01:31:43 -0800 (PST) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20161025; h=mime-version:in-reply-to:references:from:date:message-id:subject:to :cc; bh=EKAIWmdtcZtDikcq8QwmpH1kd73+p2d9rxMnibFpd5w=; b=q75Kwivz5P5w2RBck2IJ0c8Eaz5ZuR+456PTlMGu0OU33s/Q0JVDd6VufvNJwIDaOs l5NsRDhQ8E8XbJhOE9Cd+Cs7a+yRoJJlb0RwW0QmgV+6jPw03oKiNT07qSeyrskw0rmD r21mbQTXYjk8uRMhuwHYa2jZmrUJHKefvdHB5KtGh0bTXcJTqdXQ2BKJhs0wX9OMgrLD Au7pHNxZuzD/xNSazX98208R1B0u8wkHmHbtQDIdjrTaNB86YOT98amTQ3TUsAJjmUmO o1K7Ogif6HrTlwzBlbAjutFmW6bZ/CZQ+Rath21p8bGxQ3s8c0aFRkBJ6yyToLlTAUQ9 bB8w== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20161025; h=x-gm-message-state:mime-version:in-reply-to:references:from:date :message-id:subject:to:cc; bh=EKAIWmdtcZtDikcq8QwmpH1kd73+p2d9rxMnibFpd5w=; b=aMo3BtwRzJWNUiEkcgwqVmm8e39c76duDxUPIfBpD2gVqcGV6QElT/vRecmxfEGdJg 3Riq8oZgEZtg/l65DKj6hQsWrlj6MFQOa9UJeVyjqZyve/uRL3Z2Y8rnq43U4D7WCwPD 9uy3pvGOY/W7vwRUz3IqH5+k3PySAktDHIDf2rIz/HTBOWfd+T6RROzHgqthdChZMJh1 /CKe4vH5VBXyCSn+1MBtwLi/nTENwSEgh/6C3+RNX/5GkRLZbBnazmTOG0SSb6USSpdv Z8i0YMTx3tcfbcgrNA7PtDhLTuBFh1BG1WM4gwbnUHnYHuqy7VTabevvJP4w5mRDeieA Sq0g== X-Gm-Message-State: AJaThX4j+UJd/PhRFoFG30OSrmbMRf3a1M1un7PAwjk/V3+ffS4W5PTp ii2OsIqTYu7OWn/0iv4nhMznCxdefNPJ1OWEy+Q= X-Google-Smtp-Source: ABhQp+Ss+QmiAsF2pynZJDk8hveVP3P9qIzBvDsorcsjDkFUv/YDvMXV8HLBZ4KTt5sUHih2OhzCraZFB6YjcggaMtU= X-Received: by 10.46.67.25 with SMTP id q25mr695978lja.146.1510133503502; Wed, 08 Nov 2017 01:31:43 -0800 (PST) MIME-Version: 1.0 Received: by 10.25.74.202 with HTTP; Wed, 8 Nov 2017 01:31:42 -0800 (PST) In-Reply-To: <13706.1510098347@sss.pgh.pa.us> References: <20171107151108.3jtmta4xrgmuyrqf@alap3.anarazel.de> <20171107194517.pabhi4czbtiasb2f@alap3.anarazel.de> <13706.1510098347@sss.pgh.pa.us> From: =?UTF-8?Q?Ulf_Lohbr=C3=BCgge?= Date: Wed, 8 Nov 2017 10:31:42 +0100 Message-ID: Subject: Re: Slow execution of SET ROLE, SET search_path and RESET ROLE To: Tom Lane Cc: Scott Marlowe , Andres Freund , "pgsql-performance@postgresql.org" Content-Type: multipart/alternative; boundary="94eb2c184a660a2f57055d755b5d" List-Archive: List-Help: List-ID: List-Owner: List-Post: List-Subscribe: List-Unsubscribe: X-Mailing-List: pgsql-performance Precedence: bulk Sender: pgsql-performance-owner@postgresql.org --94eb2c184a660a2f57055d755b5d Content-Type: text/plain; charset="UTF-8" 2017-11-08 0:45 GMT+01:00 Tom Lane : > =?UTF-8?Q?Ulf_Lohbr=C3=BCgge?= writes: > > I just ran "check_postgres.pl --action=bloat" and got the following > output: > > ... > > Looks fine, doesn't it? > > A possible explanation is that something is taking an exclusive lock > on some system catalog and holding it for a second or two. If so, > turning on log_lock_waits might provide some useful info. > > regards, tom lane > I just checked my configuration and found out that "log_lock_waits" was already enabled. Unfortunately there is no log output of locks when those long running "SET ROLE" statements occur. Regards, Ulf --94eb2c184a660a2f57055d755b5d Content-Type: text/html; charset="UTF-8" Content-Transfer-Encoding: quoted-printable
2017= -11-08 0:45 GMT+01:00 Tom Lane <tgl@sss.pgh.pa.us>:
=3D?UTF-8?Q?Ulf_Lohbr=3DC3=3DBCg= ge?=3D <ulf.lohbruegge@gmail= .com> writes:
> I just ran "check_postgres.pl --action=3Dbloat" and got t= he following output:
> ...
> Looks fine, doesn't it?

A possible explanation is that something is taking an exclusive lock=
on some system catalog and holding it for a second or two.=C2=A0 If so,
turning on log_lock_waits might provide some useful info.

=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2= =A0 =C2=A0 regards, tom lane

I just che= cked my configuration and found out that "log_lock_waits" was alr= eady enabled.

Unfortunately there is no log output= of locks when those long running "SET ROLE" statements occur.

Regards,
Ulf

--94eb2c184a660a2f57055d755b5d--