Thread: BUG #11939: Missing "actual time" in auto_explain plans

BUG #11939: Missing "actual time" in auto_explain plans

From
robert.wysocki@essencedigital.com
Date:
The following bug has been logged on the website:

Bug reference:      11939
Logged by:          Robert Wysocki
Email address:      robert.wysocki@essencedigital.com
PostgreSQL version: 9.3.5
Operating system:   Debian GNU/Linux jessie/sid
Description:

Hello,

After loading auto_explain and configuring it to log "explain analyze" there
are no timings in logged plans.

         postgresql-9.3     9.3.5-1.pgdg70+1
 postgresql-contrib-9.3     9.3.5-1.pgdg70+1

# select version();
                                           version


──────────────────────────────────────────────────────────────────────────────────────────────
 PostgreSQL 9.3.5 on x86_64-unknown-linux-gnu, compiled by gcc (Debian
4.7.2-5) 4.7.2, 64-bit
(1 row)

console:
# load 'auto_explain';
LOAD
# set auto_explain.log_min_duration = 0;
SET
# set auto_explain.log_analyze = on;
SET
# set auto_explain.log_timing = on;
SET
# SELECT count(*)
           FROM pg_class, pg_index
           WHERE oid = indrelid AND indisunique;
 count
───────
   103
(1 row)

log file:
LOG:  duration: 0.139 ms  plan:
    Query Text: SELECT count(*)
               FROM pg_class, pg_index
               WHERE oid = indrelid AND indisunique;
    Aggregate  (cost=19.78..19.79 rows=1 width=0) (actual rows=1 loops=1)
      ->  Hash Join  (cost=5.40..19.52 rows=102 width=0) (actual rows=103
loops=1)
            Hash Cond: (pg_class.oid = pg_index.indrelid)
            ->  Seq Scan on pg_class  (cost=0.00..10.92 rows=292 width=4)
(actual rows=297 loops=1)
            ->  Hash  (cost=4.12..4.12 rows=102 width=4) (actual rows=103
loops=1)
                  Buckets: 1024  Batches: 1  Memory Usage: 4kB
                  ->  Seq Scan on pg_index  (cost=0.00..4.12 rows=102 width=4)
(actual rows=103 loops=1)
                        Filter: indisunique
                        Rows Removed by Filter: 11


Cheers,
Robert

Re: BUG #11939: Missing "actual time" in auto_explain plans

From
Tom Lane
Date:
robert.wysocki@essencedigital.com writes:
> After loading auto_explain and configuring it to log "explain analyze" there
> are no timings in logged plans.

Yeah, this was fixed a couple weeks ago, commit
9474c9d8107ba21ed9b8b9c1efde433f3d20e45f.  Will be in next releases.

            regards, tom lane

Re: BUG #11939: Missing "actual time" in auto_explain plans

From
Robert Wysocki
Date:
On 11 November 2014 20:59, Tom Lane <tgl@sss.pgh.pa.us> wrote:
> robert.wysocki@essencedigital.com writes:
>> After loading auto_explain and configuring it to log "explain analyze" t=
here
>> are no timings in logged plans.
>
> Yeah, this was fixed a couple weeks ago, commit
> 9474c9d8107ba21ed9b8b9c1efde433f3d20e45f.  Will be in next releases.

Good to know, thanks!

Cheers,
R.

--=20

Robert Wysocki
Essence

t: +44 207 758 0576
UK House =E2=80=A2 180 Oxford Street =E2=80=A2 London =E2=80=A2 W1D 1NN

--=20
-------------------------------------
essencedigital.com <http://www.essencedigital.com/>
Google+ <https://plus.google.com/102138558390623994587/about> =E2=80=A2 Fac=
ebook=20
<http://www.facebook.com/essencedigital> =E2=80=A2 Twitter=20
<https://twitter.com/essencedigital> =E2=80=A2 YouTube=20
<http://www.youtube.com/essencedigitalvideos>
-------------------------------------
Essence Digital Ltd Registered in England No. 5467689
Registered Office as above
-------------------------------------
This email may be confidential or privileged.  If you received this=20
communication by mistake, please don't forward it to anyone else, please=20
erase all copies and attachments and please let me know that it went to the=
=20
wrong person.  Thank you.