explain.depesz.com

PostgreSQL's explain analyze made readable

Result: Ak85

Settings
# exclusive inclusive rows x rows loops node
1. 0.001 301,523.110 ↓ 0.0 0 1

Unique (cost=29,015.48..29,015.53 rows=2 width=8) (actual time=301,523.110..301,523.110 rows=0 loops=1)

  • Output: pageorderparent.object_id
  • Buffers: shared hit=10148122 read=681627
  • I/O Timings: read=275647.591
2. 0.004 301,523.109 ↓ 0.0 0 1

Merge Semi Join (cost=29,015.48..29,015.52 rows=2 width=8) (actual time=301,523.109..301,523.109 rows=0 loops=1)

  • Output: pageorderparent.object_id
  • Merge Cond: (pageorderparent.object_id = pageorderparent_2.object_id)
  • Buffers: shared hit=10148122 read=681627
  • I/O Timings: read=275647.591
3. 0.746 4,872.630 ↑ 2.0 1 1

Sort (cost=62.15..62.16 rows=2 width=8) (actual time=4,872.630..4,872.630 rows=1 loops=1)

  • Output: pageorderparent.object_id
  • Sort Key: pageorderparent.object_id
  • Sort Method: quicksort Memory: 116kB
  • Buffers: shared hit=131622 read=3794
  • I/O Timings: read=4569.963
4. 0.406 4,871.884 ↓ 725.0 1,450 1

Append (cost=21.92..62.14 rows=2 width=8) (actual time=4,510.547..4,871.884 rows=1,450 loops=1)

  • Buffers: shared hit=131622 read=3794
  • I/O Timings: read=4569.963
5. 1.508 4,759.604 ↓ 796.0 796 1

Nested Loop Semi Join (cost=21.92..35.46 rows=1 width=8) (actual time=4,510.544..4,759.604 rows=796 loops=1)

  • Output: pageorderparent.object_id
  • Buffers: shared hit=64529 read=3791
  • I/O Timings: read=4534.007
6. 1.847 4,666.746 ↓ 1,450.0 1,450 1

Nested Loop (cost=21.64..25.69 rows=1 width=16) (actual time=4,385.488..4,666.746 rows=1,450 loops=1)

  • Output: pageorderparent.object_id, pageorderparent.parent_id
  • Buffers: shared hit=58450 read=3785
  • I/O Timings: read=4456.409
7. 3.892 4,345.899 ↓ 1,450.0 1,450 1

HashAggregate (cost=21.21..21.22 rows=1 width=8) (actual time=4,345.230..4,345.899 rows=1,450 loops=1)

  • Output: l0.lobj_id
  • Group Key: l0.lobj_id
  • Buffers: shared hit=54186 read=3690
  • I/O Timings: read=4142.995
8. 4.296 4,342.007 ↓ 1,450.0 1,450 1

Nested Loop (cost=2.40..21.21 rows=1 width=8) (actual time=131.759..4,342.007 rows=1,450 loops=1)

  • Output: l0.lobj_id
  • Buffers: shared hit=54186 read=3690
  • I/O Timings: read=4142.995
9. 9.437 354.096 ↓ 5,765.0 5,765 1

Nested Loop (cost=1.83..15.42 rows=1 width=16) (actual time=71.354..354.096 rows=5,765 loops=1)

  • Output: l0.lobj_id, ln1.childlobj_id
  • Buffers: shared hit=28901 read=75
  • I/O Timings: read=261.776
10. 8.094 275.479 ↓ 5,765.0 5,765 1

Nested Loop (cost=1.55..13.10 rows=1 width=32) (actual time=71.273..275.479 rows=5,765 loops=1)

  • Output: l0.lobj_id, ln1.parentlobj_id, ln1.childlobj_id, ln2.childlobj_id
  • Buffers: shared hit=17375 read=70
  • I/O Timings: read=215.291
11. 3.064 134.790 ↓ 5,765.0 5,765 1

Nested Loop (cost=1.12..10.59 rows=1 width=24) (actual time=45.451..134.790 rows=5,765 loops=1)

  • Output: ln1.parentlobj_id, ln1.childlobj_id, ln2.childlobj_id
  • Buffers: shared hit=101 read=8
  • I/O Timings: read=125.406
12. 0.020 20.402 ↓ 12.0 12 1

Nested Loop (cost=0.56..6.00 rows=1 width=8) (actual time=20.331..20.402 rows=12 loops=1)

  • Output: ln2.childlobj_id
  • Buffers: shared hit=8 read=3
  • I/O Timings: read=20.146
13. 0.024 0.024 ↑ 1.0 1 1

Seq Scan on dalimes.o_customer p2 (cost=0.00..1.41 rows=1 width=8) (actual time=0.009..0.024 rows=1 loops=1)

  • Output: p2.lobj_id, p2.ts_creation, p2.lobj_isroot, p2.ostt_list, p2.syshierarchy, p2.lobj_name, p2.creationuser_code, p2.ts_deletion, p2.lobj_version, p2.commentulong, p2.defaultproduct_productid, p2.ostt_value, p2.node_id, p2.lastchangeuser_code, p2.ts_lastchange, p2.defaultsite_siteid, p2.parent_node_id, p2.commentushort
  • Filter: ((p2.ts_deletion = 0) AND ((p2.lobj_name)::text = 'Lana Jewelry'::text))
  • Rows Removed by Filter: 26
  • Buffers: shared hit=1
14. 20.358 20.358 ↓ 12.0 12 1

Index Only Scan using pk_objectlink on dalimes.objectlink ln2 (cost=0.56..4.58 rows=1 width=16) (actual time=20.315..20.358 rows=12 loops=1)

  • Output: ln2.parentotpl_id, ln2.parentlobj_id, ln2.ts_deletion, ln2.childotpl_id, ln2.childlobj_id, ln2.olnk_id
  • Index Cond: ((ln2.parentotpl_id = 8) AND (ln2.parentlobj_id = p2.lobj_id) AND (ln2.ts_deletion = 0) AND (ln2.childotpl_id = 35))
  • Heap Fetches: 0
  • Buffers: shared hit=7 read=3
  • I/O Timings: read=20.146
15. 111.324 111.324 ↓ 480.0 480 12

Index Only Scan using pk_objectlink on dalimes.objectlink ln1 (cost=0.56..4.58 rows=1 width=16) (actual time=8.849..9.277 rows=480 loops=12)

  • Output: ln1.parentotpl_id, ln1.parentlobj_id, ln1.ts_deletion, ln1.childotpl_id, ln1.childlobj_id, ln1.olnk_id
  • Index Cond: ((ln1.parentotpl_id = 35) AND (ln1.parentlobj_id = ln2.childlobj_id) AND (ln1.ts_deletion = 0) AND (ln1.childotpl_id = 53))
  • Heap Fetches: 0
  • Buffers: shared hit=93 read=5
  • I/O Timings: read=105.260
16. 132.595 132.595 ↑ 1.0 1 5,765

Index Only Scan using ixu_o_pageorder_idlist on dalimes.o_pageorder l0 (cost=0.43..2.50 rows=1 width=8) (actual time=0.022..0.023 rows=1 loops=5,765)

  • Output: l0.ts_deletion, l0.lobj_id
  • Index Cond: ((l0.ts_deletion = 0) AND (l0.lobj_id = ln1.childlobj_id))
  • Heap Fetches: 0
  • Buffers: shared hit=17274 read=62
  • I/O Timings: read=89.885
17. 69.180 69.180 ↑ 1.0 1 5,765

Index Only Scan using ixu_o_job_id on dalimes.o_job p1 (cost=0.29..2.31 rows=1 width=8) (actual time=0.012..0.012 rows=1 loops=5,765)

  • Output: p1.lobj_id, p1.ts_deletion, p1.syshierarchy, p1.lobj_name
  • Index Cond: ((p1.lobj_id = ln1.parentlobj_id) AND (p1.ts_deletion = 0))
  • Heap Fetches: 0
  • Buffers: shared hit=11526 read=5
  • I/O Timings: read=46.485
18. 3,983.615 3,983.615 ↓ 0.0 0 5,765

Index Scan using ixu_mdt_pageorder_lobjidkey on dalimes.mdt_pageorder mtd0 (cost=0.56..5.78 rows=1 width=8) (actual time=0.690..0.691 rows=0 loops=5,765)

  • Output: mtd0.val_id, mtd0.lobj_id, mtd0.ns_id, mtd0.data_key, mtd0.data_value, mtd0.data_extid, mtd0.data_type, mtd0.ts_deletion
  • Index Cond: ((mtd0.ts_deletion = 0) AND (mtd0.lobj_id = l0.lobj_id) AND ((mtd0.data_key)::text = 'Comp_Layer'::text) AND (mtd0.ns_id = 101))
  • Filter: ((mtd0.data_value)::text = '0'::text)
  • Rows Removed by Filter: 1
  • Buffers: shared hit=25285 read=3615
  • I/O Timings: read=3881.219
19. 319.000 319.000 ↑ 1.0 1 1,450

Index Only Scan using pk_pageorderparent on dalimes.pageorderparent (cost=0.43..4.45 rows=1 width=16) (actual time=0.220..0.220 rows=1 loops=1,450)

  • Output: pageorderparent.object_id, pageorderparent.parent_id
  • Index Cond: (pageorderparent.object_id = l0.lobj_id)
  • Heap Fetches: 0
  • Buffers: shared hit=4264 read=95
  • I/O Timings: read=313.414
20. 57.918 91.350 ↑ 1.0 1 1,450

Index Scan using ixu_o_folder_id on dalimes.o_folder f (cost=0.28..5.03 rows=1 width=8) (actual time=0.063..0.063 rows=1 loops=1,450)

  • Output: f.ss_useversioningfolder, f.settings_template, f.node_id, f.ts_deletion, f.ts_lastchange, f.ts_creation, f.lobj_id, f.settings_uuid, f.settings_folderregexp, f.commentushort, f.settings_folderexclregexp, f.lobj_name, f.settings_volumeid, f.commentulong, f.ostt_list, f.settings_objectid, f.lastchangeuser_code, f.settings_category, f.settings_color, f.ostt_value, f.settings_productname, f.creationuser_code, f.settings_depth, f.settings_insertmetadata, f.settings_rgroupname, f.syshierarchy, f.settings_path, f.lobj_isroot, f.settings_fileexclregexp, f.settings_smartviewname, f.settings_fileregexp, f.lobj_version, f.parent_node_id, f.settings_wgroupname, f.settings_filepattern
  • Index Cond: ((f.lobj_id = pageorderparent.parent_id) AND (f.ts_deletion = 0))
  • Filter: (f.settings_depth = (SubPlan 1))
  • Buffers: shared hit=6079 read=6
  • I/O Timings: read=77.598
21.          

SubPlan (forIndex Scan)

22. 3.184 33.432 ↑ 1.0 1 796

Aggregate (cost=4.71..4.72 rows=1 width=8) (actual time=0.042..0.042 rows=1 loops=796)

  • Output: count(DISTINCT objectaccess_2.depth)
  • Buffers: shared hit=2387 read=2
  • I/O Timings: read=25.565
23. 30.248 30.248 ↑ 1.0 3 796

Index Only Scan using pk_objectaccess on dalimes.objectaccess objectaccess_2 (cost=0.42..4.71 rows=3 width=8) (actual time=0.035..0.038 rows=3 loops=796)

  • Output: objectaccess_2.object_id, objectaccess_2.entry_id, objectaccess_2.depth
  • Index Cond: (objectaccess_2.object_id = f.lobj_id)
  • Filter: (objectaccess_2.entry_id = ANY ('{-1,35,6212,7743,6890,333,4583,6438,4310,4308,4306,5058,3590,3624,6441,4234,7969,3561,4890,3586,3596,5482,444,3610,4706,3616,4820,5659,6254,4312,3620,4314}'::bigint[]))
  • Rows Removed by Filter: 2
  • Heap Fetches: 0
  • Buffers: shared hit=2387 read=2
  • I/O Timings: read=25.565
24. 0.886 111.874 ↓ 654.0 654 1

Nested Loop Semi Join (cost=22.34..26.66 rows=1 width=8) (actual time=62.785..111.874 rows=654 loops=1)

  • Output: pageorderparent_1.object_id
  • Buffers: shared hit=67093 read=3
  • I/O Timings: read=35.956
25. 1.307 68.938 ↓ 1,450.0 1,450 1

Nested Loop (cost=21.64..25.69 rows=1 width=16) (actual time=62.745..68.938 rows=1,450 loops=1)

  • Output: pageorderparent_1.object_id, pageorderparent_1.parent_id
  • Buffers: shared hit=62232
26. 1.211 63.281 ↓ 1,450.0 1,450 1

HashAggregate (cost=21.21..21.22 rows=1 width=8) (actual time=62.733..63.281 rows=1,450 loops=1)

  • Output: l0_1.lobj_id
  • Group Key: l0_1.lobj_id
  • Buffers: shared hit=57873
27. 2.826 62.070 ↓ 1,450.0 1,450 1

Nested Loop (cost=2.40..21.21 rows=1 width=8) (actual time=0.106..62.070 rows=1,450 loops=1)

  • Output: l0_1.lobj_id
  • Buffers: shared hit=57873
28. 0.000 30.419 ↓ 5,765.0 5,765 1

Nested Loop (cost=1.83..15.42 rows=1 width=16) (actual time=0.073..30.419 rows=5,765 loops=1)

  • Output: l0_1.lobj_id, ln1_1.childlobj_id
  • Buffers: shared hit=28973
29. 4.696 18.896 ↓ 5,765.0 5,765 1

Nested Loop (cost=1.55..13.10 rows=1 width=32) (actual time=0.064..18.896 rows=5,765 loops=1)

  • Output: l0_1.lobj_id, ln1_1.parentlobj_id, ln1_1.childlobj_id, ln2_1.childlobj_id
  • Buffers: shared hit=17442
30. 1.067 2.670 ↓ 5,765.0 5,765 1

Nested Loop (cost=1.12..10.59 rows=1 width=24) (actual time=0.050..2.670 rows=5,765 loops=1)

  • Output: ln1_1.parentlobj_id, ln1_1.childlobj_id, ln2_1.childlobj_id
  • Buffers: shared hit=106
31. 0.009 0.055 ↓ 12.0 12 1

Nested Loop (cost=0.56..6.00 rows=1 width=8) (actual time=0.031..0.055 rows=12 loops=1)

  • Output: ln2_1.childlobj_id
  • Buffers: shared hit=8
32. 0.020 0.020 ↑ 1.0 1 1

Seq Scan on dalimes.o_customer p2_1 (cost=0.00..1.41 rows=1 width=8) (actual time=0.013..0.020 rows=1 loops=1)

  • Output: p2_1.lobj_id, p2_1.ts_creation, p2_1.lobj_isroot, p2_1.ostt_list, p2_1.syshierarchy, p2_1.lobj_name, p2_1.creationuser_code, p2_1.ts_deletion, p2_1.lobj_version, p2_1.commentulong, p2_1.defaultproduct_productid, p2_1.ostt_value, p2_1.node_id, p2_1.lastchangeuser_code, p2_1.ts_lastchange, p2_1.defaultsite_siteid, p2_1.parent_node_id, p2_1.commentushort
  • Filter: ((p2_1.ts_deletion = 0) AND ((p2_1.lobj_name)::text = 'Lana Jewelry'::text))
  • Rows Removed by Filter: 26
  • Buffers: shared hit=1
33. 0.026 0.026 ↓ 12.0 12 1

Index Only Scan using pk_objectlink on dalimes.objectlink ln2_1 (cost=0.56..4.58 rows=1 width=16) (actual time=0.015..0.026 rows=12 loops=1)

  • Output: ln2_1.parentotpl_id, ln2_1.parentlobj_id, ln2_1.ts_deletion, ln2_1.childotpl_id, ln2_1.childlobj_id, ln2_1.olnk_id
  • Index Cond: ((ln2_1.parentotpl_id = 8) AND (ln2_1.parentlobj_id = p2_1.lobj_id) AND (ln2_1.ts_deletion = 0) AND (ln2_1.childotpl_id = 35))
  • Heap Fetches: 0
  • Buffers: shared hit=7
34. 1.548 1.548 ↓ 480.0 480 12

Index Only Scan using pk_objectlink on dalimes.objectlink ln1_1 (cost=0.56..4.58 rows=1 width=16) (actual time=0.013..0.129 rows=480 loops=12)

  • Output: ln1_1.parentotpl_id, ln1_1.parentlobj_id, ln1_1.ts_deletion, ln1_1.childotpl_id, ln1_1.childlobj_id, ln1_1.olnk_id
  • Index Cond: ((ln1_1.parentotpl_id = 35) AND (ln1_1.parentlobj_id = ln2_1.childlobj_id) AND (ln1_1.ts_deletion = 0) AND (ln1_1.childotpl_id = 53))
  • Heap Fetches: 0
  • Buffers: shared hit=98
35. 11.530 11.530 ↑ 1.0 1 5,765

Index Only Scan using ixu_o_pageorder_idlist on dalimes.o_pageorder l0_1 (cost=0.43..2.50 rows=1 width=8) (actual time=0.002..0.002 rows=1 loops=5,765)

  • Output: l0_1.ts_deletion, l0_1.lobj_id
  • Index Cond: ((l0_1.ts_deletion = 0) AND (l0_1.lobj_id = ln1_1.childlobj_id))
  • Heap Fetches: 0
  • Buffers: shared hit=17336
36. 11.530 11.530 ↑ 1.0 1 5,765

Index Only Scan using ixu_o_job_id on dalimes.o_job p1_1 (cost=0.29..2.31 rows=1 width=8) (actual time=0.001..0.002 rows=1 loops=5,765)

  • Output: p1_1.lobj_id, p1_1.ts_deletion, p1_1.syshierarchy, p1_1.lobj_name
  • Index Cond: ((p1_1.lobj_id = ln1_1.parentlobj_id) AND (p1_1.ts_deletion = 0))
  • Heap Fetches: 0
  • Buffers: shared hit=11531
37. 28.825 28.825 ↓ 0.0 0 5,765

Index Scan using ixu_mdt_pageorder_lobjidkey on dalimes.mdt_pageorder mtd0_1 (cost=0.56..5.78 rows=1 width=8) (actual time=0.005..0.005 rows=0 loops=5,765)

  • Output: mtd0_1.val_id, mtd0_1.lobj_id, mtd0_1.ns_id, mtd0_1.data_key, mtd0_1.data_value, mtd0_1.data_extid, mtd0_1.data_type, mtd0_1.ts_deletion
  • Index Cond: ((mtd0_1.ts_deletion = 0) AND (mtd0_1.lobj_id = l0_1.lobj_id) AND ((mtd0_1.data_key)::text = 'Comp_Layer'::text) AND (mtd0_1.ns_id = 101))
  • Filter: ((mtd0_1.data_value)::text = '0'::text)
  • Rows Removed by Filter: 1
  • Buffers: shared hit=28900
38. 4.350 4.350 ↑ 1.0 1 1,450

Index Only Scan using pk_pageorderparent on dalimes.pageorderparent pageorderparent_1 (cost=0.43..4.45 rows=1 width=16) (actual time=0.003..0.003 rows=1 loops=1,450)

  • Output: pageorderparent_1.object_id, pageorderparent_1.parent_id
  • Index Cond: (pageorderparent_1.object_id = l0_1.lobj_id)
  • Heap Fetches: 0
  • Buffers: shared hit=4359
39. 1.218 42.050 ↓ 0.0 0 1,450

Nested Loop Semi Join (cost=0.70..0.96 rows=1 width=16) (actual time=0.029..0.029 rows=0 loops=1,450)

  • Output: o_job.lobj_id, objectaccess.object_id
  • Buffers: shared hit=4861 read=3
  • I/O Timings: read=35.956
40. 2.900 2.900 ↓ 0.0 0 1,450

Index Only Scan using ixu_o_job_id on dalimes.o_job (cost=0.29..0.31 rows=1 width=8) (actual time=0.002..0.002 rows=0 loops=1,450)

  • Output: o_job.lobj_id, o_job.ts_deletion, o_job.syshierarchy, o_job.lobj_name
  • Index Cond: ((o_job.lobj_id = pageorderparent_1.parent_id) AND (o_job.ts_deletion = 0))
  • Heap Fetches: 0
  • Buffers: shared hit=2901
41. 37.932 37.932 ↑ 3.0 1 654

Index Only Scan using pk_objectaccess on dalimes.objectaccess (cost=0.42..0.88 rows=3 width=8) (actual time=0.058..0.058 rows=1 loops=654)

  • Output: objectaccess.object_id, objectaccess.entry_id, objectaccess.depth
  • Index Cond: (objectaccess.object_id = o_job.lobj_id)
  • Filter: (objectaccess.entry_id = ANY ('{-1,35,6212,7743,6890,333,4583,6438,4310,4308,4306,5058,3590,3624,6441,4234,7969,3561,4890,3586,3596,5482,444,3610,4706,3616,4820,5659,6254,4312,3620,4314}'::bigint[]))
  • Heap Fetches: 0
  • Buffers: shared hit=1960 read=3
  • I/O Timings: read=35.956
42. 0.031 296,650.475 ↓ 0.0 0 1

Sort (cost=28,953.33..28,953.34 rows=2 width=8) (actual time=296,650.475..296,650.475 rows=0 loops=1)

  • Output: pageorderparent_2.object_id
  • Sort Key: pageorderparent_2.object_id
  • Sort Method: quicksort Memory: 25kB
  • Buffers: shared hit=10016500 read=677833
  • I/O Timings: read=271077.628
43. 0.016 296,650.444 ↓ 0.0 0 1

Append (cost=14,467.51..28,953.32 rows=2 width=8) (actual time=296,650.444..296,650.444 rows=0 loops=1)

  • Buffers: shared hit=10016500 read=677833
  • I/O Timings: read=271077.628
44. 0.001 155,864.793 ↓ 0.0 0 1

Nested Loop Semi Join (cost=14,467.51..14,481.05 rows=1 width=8) (actual time=155,864.793..155,864.793 rows=0 loops=1)

  • Output: pageorderparent_2.object_id
  • Buffers: shared hit=5009796 read=337372
  • I/O Timings: read=142907.837
45. 0.000 155,864.792 ↓ 0.0 0 1

Nested Loop (cost=14,467.23..14,471.28 rows=1 width=16) (actual time=155,864.792..155,864.792 rows=0 loops=1)

  • Output: pageorderparent_2.object_id, pageorderparent_2.parent_id
  • Buffers: shared hit=5009796 read=337372
  • I/O Timings: read=142907.837
46. 0.004 155,864.792 ↓ 0.0 0 1

HashAggregate (cost=14,466.80..14,466.81 rows=1 width=8) (actual time=155,864.792..155,864.792 rows=0 loops=1)

  • Output: appinf.lobj_id
  • Group Key: appinf.lobj_id
  • Buffers: shared hit=5009796 read=337372
  • I/O Timings: read=142907.837
47. 290.364 155,864.788 ↓ 0.0 0 1

Nested Loop (cost=57.23..14,466.80 rows=1 width=8) (actual time=155,864.788..155,864.788 rows=0 loops=1)

  • Output: appinf.lobj_id
  • Buffers: shared hit=5009796 read=337372
  • I/O Timings: read=142907.837
48. 541.079 153,002.283 ↓ 233,831.0 233,831 1

Nested Loop (cost=56.81..14,441.97 rows=1 width=24) (actual time=51.697..153,002.283 rows=233,831 loops=1)

  • Output: l0_2.lobj_id, ln1_2.childlobj_id, mtd0_2.lobj_id
  • Buffers: shared hit=4287253 read=335426
  • I/O Timings: read=141740.427
49. 612.346 6,516.360 ↓ 26,117.5 574,586 1

Nested Loop (cost=56.24..14,321.59 rows=22 width=16) (actual time=32.802..6,516.360 rows=574,586 loops=1)

  • Output: l0_2.lobj_id, ln1_2.childlobj_id
  • Buffers: shared hit=1740136 read=7132
  • I/O Timings: read=2372.189
50. 232.986 1,881.912 ↓ 3,440.6 574,586 1

Nested Loop (cost=55.81..13,956.84 rows=167 width=8) (actual time=26.892..1,881.912 rows=574,586 loops=1)

  • Output: ln1_2.childlobj_id
  • Buffers: shared hit=14608 read=4453
  • I/O Timings: read=1261.516
51. 114.415 128.810 ↑ 1.0 2,852 1

Bitmap Heap Scan on dalimes.o_job p1_2 (cost=55.25..963.90 rows=2,852 width=8) (actual time=26.826..128.810 rows=2,852 loops=1)

  • Output: p1_2.outerpage_scalingvalue, p1_2.new_useissuescaling, p1_2.new_routingmargins, p1_2.lobj_isroot, p1_2.blocksize_back, p1_2.lobj_id, p1_2.new_defaultoffsety, p1_2.new_pageorderworkflow, p1_2.segmenttrim_overfold, p1_2.new_defaultrotation, p1_2.new_publicationdate, p1_2.new_defaultoffsetx, p1_2.new_collatingmarksposition, p1_2.new_simulation, p1_2.new_shrinkouterribon, p1_2.new_jobworkflow, p1_2.new_inhousepostprocessing, p1_2.syshierarchy, p1_2.printedtrim_footer, p1_2.parent_node_id, p1_2.outerpage_creepvalue, p1_2.segmenttrim_outer, p1_2.lobj_name, p1_2.segmenttrim_routingmargins, p1_2.new_folding, p1_2.new_lockshortname, p1_2.new_priority, p1_2.maximalscaling_use, p1_2.maximalscaling_value, p1_2.new_reversedview, p1_2.new_trimmedwidth, p1_2.new_safetylr, p1_2.ostt_list, p1_2.lobj_version, p1_2.new_exportasrss, p1_2.new_formworkflow, p1_2.new_rolemasks, p1_2.nw_denyupdateofpublicationda, p1_2.new_trimmedheight, p1_2.ts_deletion, p1_2.new_shiftmark, p1_2.new_site, p1_2.new_iccname, p1_2.maximalscaling_steps, p1_2.ts_creation, p1_2.printedtrim_head, p1_2.printedtrim_face, p1_2.new_skalingmethod, p1_2.outerpage_scalingstartvalue, p1_2.segmenttrim_gutter, p1_2.new_bleedleftandright, p1_2.new_usesectionscaling, p1_2.new_pagecuttoff, p1_2.ts_lastchange, p1_2.commentulong, p1_2.new_usenbpageforskaling, p1_2.creationuser_code, p1_2.new_safetytb, p1_2.new_creepingreference, p1_2.new_applycreeping, p1_2.new_compensatebracketeffect, p1_2.segmenttrim_millingdepth, p1_2.blocksize_front, p1_2.segmenttrim_footer, p1_2.new_bleedtopandbottom, p1_2.new_uselinearissuescaling, p1_2.innerpage_scalingvalue, p1_2.maximalscaling_stepsperform, p1_2.innerpage_creepvalue, p1_2.commentushort, p1_2.new_reelpostprocessing, p1_2.node_id, p1_2.new_uselinearsectionscaling, p1_2.new_mainpageorder, p1_2.ostt_value, p1_2.lastchangeuser_code, p1_2.segmenttrim_head
  • Recheck Cond: ((p1_2.ts_deletion = 0) AND (p1_2.new_publicationdate IS NULL))
  • Heap Blocks: exact=514
  • Buffers: shared hit=1 read=522
  • I/O Timings: read=106.966
52. 14.395 14.395 ↑ 1.0 2,852 1

Bitmap Index Scan on ix_o_job_topublish (cost=0.00..54.54 rows=2,852 width=0) (actual time=14.395..14.395 rows=2,852 loops=1)

  • Buffers: shared read=9
  • I/O Timings: read=14.119
53. 1,520.116 1,520.116 ↓ 201.0 201 2,852

Index Only Scan using pk_objectlink on dalimes.objectlink ln1_2 (cost=0.56..4.55 rows=1 width=16) (actual time=0.286..0.533 rows=201 loops=2,852)

  • Output: ln1_2.parentotpl_id, ln1_2.parentlobj_id, ln1_2.ts_deletion, ln1_2.childotpl_id, ln1_2.childlobj_id, ln1_2.olnk_id
  • Index Cond: ((ln1_2.parentotpl_id = 35) AND (ln1_2.parentlobj_id = p1_2.lobj_id) AND (ln1_2.ts_deletion = 0) AND (ln1_2.childotpl_id = 53))
  • Heap Fetches: 0
  • Buffers: shared hit=14607 read=3931
  • I/O Timings: read=1154.550
54. 4,022.102 4,022.102 ↑ 1.0 1 574,586

Index Only Scan using ixu_o_pageorder_idlist on dalimes.o_pageorder l0_2 (cost=0.43..2.17 rows=1 width=8) (actual time=0.006..0.007 rows=1 loops=574,586)

  • Output: l0_2.ts_deletion, l0_2.lobj_id
  • Index Cond: ((l0_2.ts_deletion = 0) AND (l0_2.lobj_id = ln1_2.childlobj_id))
  • Heap Fetches: 0
  • Buffers: shared hit=1725528 read=2679
  • I/O Timings: read=1110.673
55. 145,944.844 145,944.844 ↓ 0.0 0 574,586

Index Scan using ixu_mdt_pageorder_lobjidkey on dalimes.mdt_pageorder mtd0_2 (cost=0.56..5.46 rows=1 width=8) (actual time=0.254..0.254 rows=0 loops=574,586)

  • Output: mtd0_2.val_id, mtd0_2.lobj_id, mtd0_2.ns_id, mtd0_2.data_key, mtd0_2.data_value, mtd0_2.data_extid, mtd0_2.data_type, mtd0_2.ts_deletion
  • Index Cond: ((mtd0_2.ts_deletion = 0) AND (mtd0_2.lobj_id = l0_2.lobj_id) AND ((mtd0_2.data_key)::text = 'selection'::text) AND (mtd0_2.ns_id = 46))
  • Filter: ((mtd0_2.data_value)::text = '1'::text)
  • Rows Removed by Filter: 1
  • Buffers: shared hit=2547117 read=328294
  • I/O Timings: read=139368.238
56. 2,572.141 2,572.141 ↓ 0.0 0 233,831

Index Scan using ix_approvalinfo_appinfo on dalimes.approvalinfo appinf (cost=0.42..24.81 rows=1 width=8) (actual time=0.011..0.011 rows=0 loops=233,831)

  • Output: appinf.exestep_id, appinf.wflinst_id, appinf.lobj_id, appinf.otpl_id, appinf.prodgrp_id, appinf.approved, appinf.app_info
  • Index Cond: ((appinf.lobj_id = l0_2.lobj_id) AND (appinf.approved = 0))
  • Filter: ((appinf.otpl_id = '53'::bigint) AND ((appinf.app_info)::text = ANY ('{U:admin,"G:Splashlight IT","G:PPI Apparel","G:CIS Marketing","G:Eileen Fisher","G:Splashlight Applications","G:Splashlight Retouching",G:Target,"G:Dia and Co","G:Splashlight Creative","G:Under Armour","G:My Customer","G:Splashlight Handbooks","G:Centric Brands","G:Main Organization","G:Globo Marketing",G:Macys,G:Bloomingdales,"G:El Palacio de Hierro","G:ALDO Marketing",G:Splashlight,"G:Production Lane","G:Avery Dennison",G:Amsale,"G:David Yurman",G:MCM,"G:Lana Jewelry",G:Giggle,"G:ALDO Group","G:J Crew","G:Ann Taylor"}'::text[])) AND (NOT (SubPlan 3)))
  • Rows Removed by Filter: 0
  • Buffers: shared hit=722543 read=1946
  • I/O Timings: read=1167.410
57.          

SubPlan (forIndex Scan)

58. 0.000 0.000 ↓ 0.0 0

Index Scan using ix_approvalinfo_approved_info on dalimes.approvalinfo (cost=0.42..6.20 rows=1 width=8) (never executed)

  • Output: approvalinfo.lobj_id
  • Index Cond: ((approvalinfo.approved = 1) AND ((approvalinfo.app_info)::text = 'U:admin'::text) AND (approvalinfo.otpl_id = '53'::bigint))
  • Filter: (approvalinfo.exestep_id = appinf.exestep_id)
59. 0.000 0.000 ↓ 0.0 0

Index Only Scan using pk_pageorderparent on dalimes.pageorderparent pageorderparent_2 (cost=0.43..4.45 rows=1 width=16) (never executed)

  • Output: pageorderparent_2.object_id, pageorderparent_2.parent_id
  • Index Cond: (pageorderparent_2.object_id = appinf.lobj_id)
  • Heap Fetches: 0
60. 0.000 0.000 ↓ 0.0 0

Index Scan using ixu_o_folder_id on dalimes.o_folder f_1 (cost=0.28..5.03 rows=1 width=8) (never executed)

  • Output: f_1.ss_useversioningfolder, f_1.settings_template, f_1.node_id, f_1.ts_deletion, f_1.ts_lastchange, f_1.ts_creation, f_1.lobj_id, f_1.settings_uuid, f_1.settings_folderregexp, f_1.commentushort, f_1.settings_folderexclregexp, f_1.lobj_name, f_1.settings_volumeid, f_1.commentulong, f_1.ostt_list, f_1.settings_objectid, f_1.lastchangeuser_code, f_1.settings_category, f_1.settings_color, f_1.ostt_value, f_1.settings_productname, f_1.creationuser_code, f_1.settings_depth, f_1.settings_insertmetadata, f_1.settings_rgroupname, f_1.syshierarchy, f_1.settings_path, f_1.lobj_isroot, f_1.settings_fileexclregexp, f_1.settings_smartviewname, f_1.settings_fileregexp, f_1.lobj_version, f_1.parent_node_id, f_1.settings_wgroupname, f_1.settings_filepattern
  • Index Cond: ((f_1.lobj_id = pageorderparent_2.parent_id) AND (f_1.ts_deletion = 0))
  • Filter: (f_1.settings_depth = (SubPlan 2))
61.          

SubPlan (forIndex Scan)

62. 0.000 0.000 ↓ 0.0 0

Aggregate (cost=4.71..4.72 rows=1 width=8) (never executed)

  • Output: count(DISTINCT objectaccess_3.depth)
63. 0.000 0.000 ↓ 0.0 0

Index Only Scan using pk_objectaccess on dalimes.objectaccess objectaccess_3 (cost=0.42..4.71 rows=3 width=8) (never executed)

  • Output: objectaccess_3.object_id, objectaccess_3.entry_id, objectaccess_3.depth
  • Index Cond: (objectaccess_3.object_id = f_1.lobj_id)
  • Filter: (objectaccess_3.entry_id = ANY ('{-1,35,6212,7743,6890,333,4583,6438,4310,4308,4306,5058,3590,3624,6441,4234,7969,3561,4890,3586,3596,5482,444,3610,4706,3616,4820,5659,6254,4312,3620,4314}'::bigint[]))
  • Heap Fetches: 0
64. 0.001 140,785.635 ↓ 0.0 0 1

Nested Loop Semi Join (cost=14,467.93..14,472.25 rows=1 width=8) (actual time=140,785.635..140,785.635 rows=0 loops=1)

  • Output: pageorderparent_3.object_id
  • Buffers: shared hit=5006704 read=340461
  • I/O Timings: read=128169.791
65. 0.001 140,785.634 ↓ 0.0 0 1

Nested Loop (cost=14,467.23..14,471.28 rows=1 width=16) (actual time=140,785.634..140,785.634 rows=0 loops=1)

  • Output: pageorderparent_3.object_id, pageorderparent_3.parent_id
  • Buffers: shared hit=5006704 read=340461
  • I/O Timings: read=128169.791
66. 0.004 140,785.633 ↓ 0.0 0 1

HashAggregate (cost=14,466.80..14,466.81 rows=1 width=8) (actual time=140,785.633..140,785.633 rows=0 loops=1)

  • Output: appinf_1.lobj_id
  • Group Key: appinf_1.lobj_id
  • Buffers: shared hit=5006704 read=340461
  • I/O Timings: read=128169.791
67. 237.733 140,785.629 ↓ 0.0 0 1

Nested Loop (cost=57.23..14,466.80 rows=1 width=8) (actual time=140,785.629..140,785.629 rows=0 loops=1)

  • Output: appinf_1.lobj_id
  • Buffers: shared hit=5006704 read=340461
  • I/O Timings: read=128169.791
68. 787.059 138,209.586 ↓ 233,831.0 233,831 1

Nested Loop (cost=56.81..14,441.97 rows=1 width=24) (actual time=145.828..138,209.586 rows=233,831 loops=1)

  • Output: l0_3.lobj_id, ln1_3.childlobj_id, mtd0_3.lobj_id
  • Buffers: shared hit=4284084 read=338595
  • I/O Timings: read=127235.598
69. 692.942 5,842.333 ↓ 26,117.5 574,586 1

Nested Loop (cost=56.24..14,321.59 rows=22 width=16) (actual time=92.327..5,842.333 rows=574,586 loops=1)

  • Output: l0_3.lobj_id, ln1_3.childlobj_id
  • Buffers: shared hit=1738844 read=8424
  • I/O Timings: read=1810.843
70. 215.853 1,701.875 ↓ 3,440.6 574,586 1

Nested Loop (cost=55.81..13,956.84 rows=167 width=8) (actual time=59.105..1,701.875 rows=574,586 loops=1)

  • Output: ln1_3.childlobj_id
  • Buffers: shared hit=13348 read=5713
  • I/O Timings: read=1109.967
71. 65.347 74.282 ↑ 1.0 2,852 1

Bitmap Heap Scan on dalimes.o_job p1_3 (cost=55.25..963.90 rows=2,852 width=8) (actual time=21.473..74.282 rows=2,852 loops=1)

  • Output: p1_3.outerpage_scalingvalue, p1_3.new_useissuescaling, p1_3.new_routingmargins, p1_3.lobj_isroot, p1_3.blocksize_back, p1_3.lobj_id, p1_3.new_defaultoffsety, p1_3.new_pageorderworkflow, p1_3.segmenttrim_overfold, p1_3.new_defaultrotation, p1_3.new_publicationdate, p1_3.new_defaultoffsetx, p1_3.new_collatingmarksposition, p1_3.new_simulation, p1_3.new_shrinkouterribon, p1_3.new_jobworkflow, p1_3.new_inhousepostprocessing, p1_3.syshierarchy, p1_3.printedtrim_footer, p1_3.parent_node_id, p1_3.outerpage_creepvalue, p1_3.segmenttrim_outer, p1_3.lobj_name, p1_3.segmenttrim_routingmargins, p1_3.new_folding, p1_3.new_lockshortname, p1_3.new_priority, p1_3.maximalscaling_use, p1_3.maximalscaling_value, p1_3.new_reversedview, p1_3.new_trimmedwidth, p1_3.new_safetylr, p1_3.ostt_list, p1_3.lobj_version, p1_3.new_exportasrss, p1_3.new_formworkflow, p1_3.new_rolemasks, p1_3.nw_denyupdateofpublicationda, p1_3.new_trimmedheight, p1_3.ts_deletion, p1_3.new_shiftmark, p1_3.new_site, p1_3.new_iccname, p1_3.maximalscaling_steps, p1_3.ts_creation, p1_3.printedtrim_head, p1_3.printedtrim_face, p1_3.new_skalingmethod, p1_3.outerpage_scalingstartvalue, p1_3.segmenttrim_gutter, p1_3.new_bleedleftandright, p1_3.new_usesectionscaling, p1_3.new_pagecuttoff, p1_3.ts_lastchange, p1_3.commentulong, p1_3.new_usenbpageforskaling, p1_3.creationuser_code, p1_3.new_safetytb, p1_3.new_creepingreference, p1_3.new_applycreeping, p1_3.new_compensatebracketeffect, p1_3.segmenttrim_millingdepth, p1_3.blocksize_front, p1_3.segmenttrim_footer, p1_3.new_bleedtopandbottom, p1_3.new_uselinearissuescaling, p1_3.innerpage_scalingvalue, p1_3.maximalscaling_stepsperform, p1_3.innerpage_creepvalue, p1_3.commentushort, p1_3.new_reelpostprocessing, p1_3.node_id, p1_3.new_uselinearsectionscaling, p1_3.new_mainpageorder, p1_3.ostt_value, p1_3.lastchangeuser_code, p1_3.segmenttrim_head
  • Recheck Cond: ((p1_3.ts_deletion = 0) AND (p1_3.new_publicationdate IS NULL))
  • Heap Blocks: exact=514
  • Buffers: shared hit=1 read=522
  • I/O Timings: read=51.728
72. 8.935 8.935 ↑ 1.0 2,852 1

Bitmap Index Scan on ix_o_job_topublish (cost=0.00..54.54 rows=2,852 width=0) (actual time=8.935..8.935 rows=2,852 loops=1)

  • Buffers: shared read=9
  • I/O Timings: read=8.155
73. 1,411.740 1,411.740 ↓ 201.0 201 2,852

Index Only Scan using pk_objectlink on dalimes.objectlink ln1_3 (cost=0.56..4.55 rows=1 width=16) (actual time=0.203..0.495 rows=201 loops=2,852)

  • Output: ln1_3.parentotpl_id, ln1_3.parentlobj_id, ln1_3.ts_deletion, ln1_3.childotpl_id, ln1_3.childlobj_id, ln1_3.olnk_id
  • Index Cond: ((ln1_3.parentotpl_id = 35) AND (ln1_3.parentlobj_id = p1_3.lobj_id) AND (ln1_3.ts_deletion = 0) AND (ln1_3.childotpl_id = 53))
  • Heap Fetches: 0
  • Buffers: shared hit=13347 read=5191
  • I/O Timings: read=1058.239
74. 3,447.516 3,447.516 ↑ 1.0 1 574,586

Index Only Scan using ixu_o_pageorder_idlist on dalimes.o_pageorder l0_3 (cost=0.43..2.17 rows=1 width=8) (actual time=0.006..0.006 rows=1 loops=574,586)

  • Output: l0_3.ts_deletion, l0_3.lobj_id
  • Index Cond: ((l0_3.ts_deletion = 0) AND (l0_3.lobj_id = ln1_3.childlobj_id))
  • Heap Fetches: 0
  • Buffers: shared hit=1725496 read=2711
  • I/O Timings: read=700.876
75. 131,580.194 131,580.194 ↓ 0.0 0 574,586

Index Scan using ixu_mdt_pageorder_lobjidkey on dalimes.mdt_pageorder mtd0_3 (cost=0.56..5.46 rows=1 width=8) (actual time=0.229..0.229 rows=0 loops=574,586)

  • Output: mtd0_3.val_id, mtd0_3.lobj_id, mtd0_3.ns_id, mtd0_3.data_key, mtd0_3.data_value, mtd0_3.data_extid, mtd0_3.data_type, mtd0_3.ts_deletion
  • Index Cond: ((mtd0_3.ts_deletion = 0) AND (mtd0_3.lobj_id = l0_3.lobj_id) AND ((mtd0_3.data_key)::text = 'selection'::text) AND (mtd0_3.ns_id = 46))
  • Filter: ((mtd0_3.data_value)::text = '1'::text)
  • Rows Removed by Filter: 1
  • Buffers: shared hit=2545240 read=330171
  • I/O Timings: read=125424.755
76. 2,338.310 2,338.310 ↓ 0.0 0 233,831

Index Scan using ix_approvalinfo_appinfo on dalimes.approvalinfo appinf_1 (cost=0.42..24.81 rows=1 width=8) (actual time=0.010..0.010 rows=0 loops=233,831)

  • Output: appinf_1.exestep_id, appinf_1.wflinst_id, appinf_1.lobj_id, appinf_1.otpl_id, appinf_1.prodgrp_id, appinf_1.approved, appinf_1.app_info
  • Index Cond: ((appinf_1.lobj_id = l0_3.lobj_id) AND (appinf_1.approved = 0))
  • Filter: ((appinf_1.otpl_id = '53'::bigint) AND ((appinf_1.app_info)::text = ANY ('{U:admin,"G:Splashlight IT","G:PPI Apparel","G:CIS Marketing","G:Eileen Fisher","G:Splashlight Applications","G:Splashlight Retouching",G:Target,"G:Dia and Co","G:Splashlight Creative","G:Under Armour","G:My Customer","G:Splashlight Handbooks","G:Centric Brands","G:Main Organization","G:Globo Marketing",G:Macys,G:Bloomingdales,"G:El Palacio de Hierro","G:ALDO Marketing",G:Splashlight,"G:Production Lane","G:Avery Dennison",G:Amsale,"G:David Yurman",G:MCM,"G:Lana Jewelry",G:Giggle,"G:ALDO Group","G:J Crew","G:Ann Taylor"}'::text[])) AND (NOT (SubPlan 4)))
  • Rows Removed by Filter: 0
  • Buffers: shared hit=722620 read=1866
  • I/O Timings: read=934.193
77.          

SubPlan (forIndex Scan)

78. 0.000 0.000 ↓ 0.0 0

Index Scan using ix_approvalinfo_approved_info on dalimes.approvalinfo approvalinfo_1 (cost=0.42..6.20 rows=1 width=8) (never executed)

  • Output: approvalinfo_1.lobj_id
  • Index Cond: ((approvalinfo_1.approved = 1) AND ((approvalinfo_1.app_info)::text = 'U:admin'::text) AND (approvalinfo_1.otpl_id = '53'::bigint))
  • Filter: (approvalinfo_1.exestep_id = appinf_1.exestep_id)
79. 0.000 0.000 ↓ 0.0 0

Index Only Scan using pk_pageorderparent on dalimes.pageorderparent pageorderparent_3 (cost=0.43..4.45 rows=1 width=16) (never executed)

  • Output: pageorderparent_3.object_id, pageorderparent_3.parent_id
  • Index Cond: (pageorderparent_3.object_id = appinf_1.lobj_id)
  • Heap Fetches: 0
80. 0.000 0.000 ↓ 0.0 0

Nested Loop Semi Join (cost=0.70..0.96 rows=1 width=16) (never executed)

  • Output: o_job_1.lobj_id, objectaccess_1.object_id
81. 0.000 0.000 ↓ 0.0 0

Index Only Scan using ixu_o_job_id on dalimes.o_job o_job_1 (cost=0.29..0.31 rows=1 width=8) (never executed)

  • Output: o_job_1.lobj_id, o_job_1.ts_deletion, o_job_1.syshierarchy, o_job_1.lobj_name
  • Index Cond: ((o_job_1.lobj_id = pageorderparent_3.parent_id) AND (o_job_1.ts_deletion = 0))
  • Heap Fetches: 0
82. 0.000 0.000 ↓ 0.0 0

Index Only Scan using pk_objectaccess on dalimes.objectaccess objectaccess_1 (cost=0.42..0.88 rows=3 width=8) (never executed)

  • Output: objectaccess_1.object_id, objectaccess_1.entry_id, objectaccess_1.depth
  • Index Cond: (objectaccess_1.object_id = o_job_1.lobj_id)
  • Filter: (objectaccess_1.entry_id = ANY ('{-1,35,6212,7743,6890,333,4583,6438,4310,4308,4306,5058,3590,3624,6441,4234,7969,3561,4890,3586,3596,5482,444,3610,4706,3616,4820,5659,6254,4312,3620,4314}'::bigint[]))
  • Heap Fetches: 0