explain.depesz.com

PostgreSQL's explain analyze made readable

Result: DLNe

Settings
# exclusive inclusive rows x rows loops node
1. 0.003 54.990 ↓ 10.0 10 1

Limit (cost=0.86..109,864.35 rows=1 width=1,751) (actual time=3.992..54.99 rows=10 loops=1)

  • Buffers: shared hit=5,862
2. 6.552 54.987 ↓ 10.0 10 1

Nested Loop (cost=0.86..109,864.35 rows=1 width=1,751) (actual time=3.991..54.987 rows=10 loops=1)

  • Buffers: shared hit=5,862
3. 0.011 43.655 ↓ 10.0 10 1

Nested Loop (cost=0.86..109,443.98 rows=1 width=1,783) (actual time=3.618..43.655 rows=10 loops=1)

  • Buffers: shared hit=5,032
4. 0.021 43.604 ↓ 1.4 10 1

Nested Loop (cost=0.57..109,441.6 rows=7 width=1,767) (actual time=3.606..43.604 rows=10 loops=1)

  • Buffers: shared hit=5,009
5. 41.603 43.403 ↑ 4.6 60 1

Index Scan using cms_item_ancestor_ids_index on cms_item cms_item (cost=0.29..108,971.66 rows=275 width=1,751) (actual time=3.598..43.403 rows=60 loops=1)

  • Index Cond: (ancestor_ids OPERATOR(extensions.~) '*.cfc3f4ed_810e_4247_9e06_6feaa500047f@.*'::extensions.lquery)
  • Filter: (latest AND (SubPlan 6))
  • Buffers: shared hit=4,885
6.          

SubPlan (for Index Scan)

7. 0.000 1.800 ↑ 1.0 1 60

Nested Loop (cost=186.05..194.11 rows=1 width=0) (actual time=0.03..0.03 rows=1 loops=60)

  • Buffers: shared hit=324
8.          

CTE user_ids

9. 0.013 0.013 ↑ 25.0 4 1

Function Scan on unnest t (cost=0..1.5 rows=100 width=32) (actual time=0.01..0.013 rows=4 loops=1)

10.          

CTE user_grp_subq

11. 0.384 0.384 ↑ 1.1 2,500 1

Index Only Scan using cms_group_membership_user_identity_id_group_id_key on cms_group_membership cms_group_membership (cost=0.42..119.44 rows=2,662 width=16) (actual time=0.019..0.384 rows=2,500 loops=1)

  • Index Cond: (user_identity_id = ANY ('{fc32e09e-ffa4-41f7-9992-19087d54b38c,a8e70d48-6f03-45c5-af9e-1e6e14501332}'::uuid[]))
  • Buffers: shared hit=22
12. 0.120 0.120 ↑ 1.0 1 60

Index Only Scan using cms_acl_pkey on cms_acl acl (cost=0.29..4.31 rows=1 width=16) (actual time=0.002..0.002 rows=1 loops=60)

  • Index Cond: (id = cms_item.acl_id)
  • Buffers: shared hit=121
13. 0.803 1.680 ↑ 1.0 1 60

Index Only Scan using cms_acl_permit_pkey on cms_acl_permit acl_permit (cost=64.82..68.85 rows=1 width=16) (actual time=0.028..0.028 rows=1 loops=60)

  • Index Cond: ((acl_id = cms_item.acl_id) AND (permission = 'browse'::text))
  • Filter: ((hashed SubPlan 3) OR ((identity_id = 'eeffa80a-2644-11e8-b467-0ed5f89f718b'::uuid) AND (hashed SubPlan 4)) OR (hashed SubPlan 5))
  • Buffers: shared hit=203
14.          

SubPlan (for Index Only Scan)

15. 0.015 0.015 ↑ 25.0 4 1

CTE Scan on user_ids user_ids (cost=0..2 rows=100 width=16) (actual time=0.011..0.015 rows=4 loops=1)

16. 0.000 0.000 ↓ 0.0 0 0

CTE Scan on user_ids user_ids_1 (cost=0..2 rows=100 width=16) (never executed)

17. 0.862 0.862 ↑ 1.1 2,500 1

CTE Scan on user_grp_subq user_grp_subq (cost=0..53.24 rows=2,662 width=16) (actual time=0.019..0.862 rows=2,500 loops=1)

  • Buffers: shared hit=22
18. 0.180 0.180 ↓ 0.0 0 60

Index Only Scan using xecmsf_sf_document_table_pkey on xecmsf_sf_document_table xecmsf_sf_document_table (cost=0.29..1.7 rows=1 width=16) (actual time=0.003..0.003 rows=0 loops=60)

  • Index Cond: (id = cms_item.id)
  • Heap Fetches: 2
  • Buffers: shared hit=124
19. 0.040 0.040 ↑ 1.0 1 10

Index Only Scan using xecmsf_document_table_pkey on xecmsf_document_table xecmsf_document_table (cost=0.29..0.33 rows=1 width=16) (actual time=0.003..0.004 rows=1 loops=10)

  • Index Cond: (id = xecmsf_sf_document_table.id)
  • Heap Fetches: 2
  • Buffers: shared hit=23
20. 4.780 4.780 ↑ 2.0 7,617 10

Seq Scan on cms_file_table cms_file_table (cost=0..232.94 rows=14,994 width=16) (actual time=0.002..0.478 rows=7,617 loops=10)

  • Buffers: shared hit=830
Planning time : 1.467 ms
Execution time : 55.169 ms