explain.depesz.com

PostgreSQL's explain analyze made readable

Result: sckt1

Settings
# exclusive inclusive rows x rows loops node
1. 0.000 6,641.654 ↓ 31.9 14,550 1

Nested Loop (cost=1,795.96..4,953.43 rows=456 width=16) (actual time=4,247.345..6,641.654 rows=14,550 loops=1)

  • Buffers: shared hit=42,925 read=22,985 written=7,150
2. 231.156 4,353.350 ↓ 32.0 14,550 1

HashAggregate (cost=1,795.53..1,800.08 rows=455 width=8) (actual time=4,245.317..4,353.350 rows=14,550 loops=1)

  • Group Key: prop_1.node_id
  • Buffers: shared read=12,337 written=6,426
3. 3,995.437 4,122.194 ↓ 31.9 14,550 1

Bitmap Heap Scan on alf_node_properties prop_1 (cost=29.23..1,794.39 rows=456 width=8) (actual time=128.399..4,122.194 rows=14,550 loops=1)

  • Recheck Cond: ((238 = qname_id) AND ((string_value)::text = 'Action and Adventure'::text))
  • Heap Blocks: exact=12,137
  • Buffers: shared read=12,337 written=6,426
4. 126.757 126.757 ↓ 31.9 14,550 1

Bitmap Index Scan on idx_alf_nprop_s (cost=0.00..29.12 rows=456 width=0) (actual time=126.751..126.757 rows=14,550 loops=1)

  • Index Cond: ((238 = qname_id) AND ((string_value)::text = 'Action and Adventure'::text))
  • Buffers: shared read=200
5. 1,978.800 1,978.800 ↑ 1.0 1 14,550

Index Only Scan using alf_node_pkey on alf_node node (cost=0.42..6.93 rows=1 width=8) (actual time=0.136..0.136 rows=1 loops=14,550)

  • Index Cond: (id = prop_1.node_id)
  • Heap Fetches: 9,882
  • Buffers: shared hit=42,925 read=10,648 written=724
6. 6,896.700 6,896.700 ↓ 0.0 0 14,550

Index Scan using alf_node_properties_pkey on alf_node_properties prop (cost=0.56..2.35 rows=1 width=8) (actual time=0.474..0.474 rows=0 loops=14,550)

  • Index Cond: ((node_id = node.id) AND (239 = qname_id))
  • Filter: ((string_value)::text = 'Hachette Livre'::text)
  • Rows Removed by Filter: 1
  • Buffers: shared hit=46,012 read=26,925 written=2,134
Planning time : 22.656 ms
Execution time : 13,797.735 ms