explain.depesz.com

PostgreSQL's explain analyze made readable

Result: kmOO

Settings
# exclusive inclusive rows x rows loops node
1. 0.048 24,347.548 ↑ 1.0 1 1

Aggregate (cost=10,218,681.08..10,218,681.09 rows=1 width=32) (actual time=24,347.548..24,347.548 rows=1 loops=1)

2. 0.035 24,347.500 ↑ 305.0 2 1

Subquery Scan on tt (cost=10,218,671.93..10,218,679.55 rows=610 width=2,582) (actual time=24,347.485..24,347.500 rows=2 loops=1)

3. 0.002 24,347.465 ↑ 305.0 2 1

Limit (cost=10,218,671.93..10,218,673.45 rows=610 width=2,566) (actual time=24,347.464..24,347.465 rows=2 loops=1)

4. 0.017 24,347.463 ↑ 305.0 2 1

Sort (cost=10,218,671.93..10,218,673.45 rows=610 width=2,566) (actual time=24,347.463..24,347.463 rows=2 loops=1)

  • Sort Key: t.item_id DESC
  • Sort Method: quicksort Memory: 27kB
5. 0.011 24,347.446 ↑ 305.0 2 1

WindowAgg (cost=257.80..10,218,246.01 rows=610 width=2,566) (actual time=24,347.445..24,347.446 rows=2 loops=1)

6. 44.915 24,347.435 ↑ 305.0 2 1

Subquery Scan on t (cost=257.80..10,218,238.38 rows=610 width=2,558) (actual time=24,347.142..24,347.435 rows=2 loops=1)

  • Filter: (t.customer_id = 1602)
  • Rows Removed by Filter: 310120
7. 1,235.245 24,302.520 ↓ 1.0 310,122 1

WindowAgg (cost=257.80..10,214,361.87 rows=310,121 width=2,558) (actual time=4.151..24,302.520 rows=310,122 loops=1)

8.          

Initplan (for WindowAgg)

9. 0.005 0.005 ↑ 1.0 1 1

Seq Scan on t_object_type ot (cost=0.00..1.11 rows=1 width=4) (actual time=0.004..0.005 rows=1 loops=1)

  • Filter: ((brief)::text = 'ITEM'::text)
  • Rows Removed by Filter: 8
10. 157.754 738.486 ↓ 1.0 310,122 1

Hash Left Join (cost=256.69..17,427.22 rows=310,121 width=1,842) (actual time=3.908..738.486 rows=310,122 loops=1)

  • Hash Cond: (d.doc_type_id = dt.doc_type_id)
11. 160.543 580.725 ↓ 1.0 310,122 1

Hash Left Join (cost=255.60..15,749.54 rows=310,121 width=1,804) (actual time=3.889..580.725 rows=310,122 loops=1)

  • Hash Cond: (tt_1.doc_id = d.doc_id)
12. 152.362 419.659 ↓ 1.0 310,122 1

Hash Left Join (cost=201.72..14,878.19 rows=310,121 width=1,792) (actual time=3.351..419.659 rows=310,122 loops=1)

  • Hash Cond: (i.cat_id = c.cat_id)
13. 209.520 267.289 ↓ 1.0 310,122 1

Hash Left Join (cost=200.65..12,913.02 rows=310,121 width=756) (actual time=3.329..267.289 rows=310,122 loops=1)

  • Hash Cond: (tt_1.item_id = i.item_id)
14. 54.468 54.468 ↓ 1.0 310,122 1

Seq Scan on t_tran tt_1 (cost=0.00..8,448.21 rows=310,121 width=16) (actual time=0.010..54.468 rows=310,122 loops=1)

15. 0.901 3.301 ↓ 1.0 1,582 1

Hash (cost=180.89..180.89 rows=1,581 width=748) (actual time=3.301..3.301 rows=1,582 loops=1)

  • Buckets: 2048 Batches: 1 Memory Usage: 524kB
16. 0.323 2.400 ↓ 1.0 1,582 1

Hash Left Join (cost=53.64..180.89 rows=1,581 width=748) (actual time=0.650..2.400 rows=1,582 loops=1)

  • Hash Cond: (i.item_id = ic.item_id)
17. 0.415 2.071 ↓ 1.0 1,582 1

Hash Left Join (cost=52.57..173.86 rows=1,581 width=330) (actual time=0.631..2.071 rows=1,582 loops=1)

  • Hash Cond: (i.item_id = p.item_id)
18. 0.739 1.060 ↓ 1.0 1,582 1

Hash Left Join (cost=1.02..118.15 rows=1,581 width=325) (actual time=0.029..1.060 rows=1,582 loops=1)

  • Hash Cond: (i.manufacturer_id = m.manufacturer_id)
19. 0.315 0.315 ↓ 1.0 1,582 1

Seq Scan on t_item i (cost=0.00..95.81 rows=1,581 width=297) (actual time=0.003..0.315 rows=1,582 loops=1)

20. 0.002 0.006 ↑ 1.0 1 1

Hash (cost=1.01..1.01 rows=1 width=36) (actual time=0.006..0.006 rows=1 loops=1)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
21. 0.004 0.004 ↑ 1.0 1 1

Seq Scan on t_manufacturer m (cost=0.00..1.01 rows=1 width=36) (actual time=0.003..0.004 rows=1 loops=1)

22. 0.284 0.596 ↑ 1.0 1,542 1

Hash (cost=32.28..32.28 rows=1,542 width=13) (actual time=0.596..0.596 rows=1,542 loops=1)

  • Buckets: 2048 Batches: 1 Memory Usage: 89kB
23. 0.312 0.312 ↑ 1.0 1,542 1

Seq Scan on t_pline p (cost=0.00..32.28 rows=1,542 width=13) (actual time=0.006..0.312 rows=1,542 loops=1)

  • Filter: (pl_id = 1)
24. 0.003 0.006 ↑ 1.0 3 1

Hash (cost=1.03..1.03 rows=3 width=426) (actual time=0.006..0.006 rows=3 loops=1)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
25. 0.003 0.003 ↑ 1.0 3 1

Seq Scan on t_icode ic (cost=0.00..1.03 rows=3 width=426) (actual time=0.003..0.003 rows=3 loops=1)

26. 0.004 0.008 ↑ 1.0 3 1

Hash (cost=1.03..1.03 rows=3 width=1,036) (actual time=0.008..0.008 rows=3 loops=1)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
27. 0.004 0.004 ↑ 1.0 3 1

Seq Scan on t_cat c (cost=0.00..1.03 rows=3 width=1,036) (actual time=0.003..0.004 rows=3 loops=1)

28. 0.217 0.523 ↓ 1.0 1,018 1

Hash (cost=41.17..41.17 rows=1,017 width=28) (actual time=0.523..0.523 rows=1,018 loops=1)

  • Buckets: 1024 Batches: 1 Memory Usage: 60kB
29. 0.306 0.306 ↓ 1.0 1,018 1

Seq Scan on t_doc d (cost=0.00..41.17 rows=1,017 width=28) (actual time=0.004..0.306 rows=1,018 loops=1)

30. 0.004 0.007 ↑ 1.0 4 1

Hash (cost=1.04..1.04 rows=4 width=46) (actual time=0.007..0.007 rows=4 loops=1)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
31. 0.003 0.003 ↑ 1.0 4 1

Seq Scan on t_doc_type dt (cost=0.00..1.04 rows=4 width=46) (actual time=0.002..0.003 rows=4 loops=1)

32.          

SubPlan (for WindowAgg)

33. 928.998 4,961.952 ↓ 0.0 0 310,122

Nested Loop (cost=1.85..4.14 rows=1 width=516) (actual time=0.015..0.016 rows=0 loops=310,122)

  • Join Filter: (ip.prop_id = p_1.prop_id)
  • Rows Removed by Join Filter: 1
34. 798.488 3,721.464 ↑ 1.0 1 310,122

Hash Join (cost=1.85..3.04 rows=1 width=520) (actual time=0.012..0.012 rows=1 loops=310,122)

  • Hash Cond: (pv.prop_value_id = ip.prop_value_id)
35. 442.000 442.000 ↑ 1.0 13 221,000

Seq Scan on t_prop_value pv (cost=0.00..1.13 rows=13 width=520) (actual time=0.001..0.002 rows=13 loops=221,000)

36. 310.122 2,480.976 ↑ 1.0 1 310,122

Hash (cost=1.84..1.84 rows=1 width=8) (actual time=0.008..0.008 rows=1 loops=310,122)

  • Buckets: 1024 Batches: 1 Memory Usage: 8kB
37. 2,170.854 2,170.854 ↑ 1.0 1 310,122

Seq Scan on t_item_prop ip (cost=0.00..1.84 rows=1 width=8) (actual time=0.005..0.007 rows=1 loops=310,122)

  • Filter: (item_id = i.item_id)
  • Rows Removed by Filter: 66
38. 311.490 311.490 ↑ 1.0 1 311,490

Seq Scan on t_prop p_1 (cost=0.00..1.09 rows=1 width=4) (actual time=0.001..0.001 rows=1 loops=311,490)

  • Filter: ((brief)::text = 'GROUP'::text)
  • Rows Removed by Filter: 5
39. 6,822.684 15,195.978 ↑ 1.0 1 310,122

Aggregate (cost=27.16..27.17 rows=1 width=32) (actual time=0.048..0.049 rows=1 loops=310,122)

40. 310.113 8,373.294 ↓ 1.2 5 310,122

Hash Left Join (cost=3.50..27.14 rows=4 width=1,176) (actual time=0.022..0.027 rows=5 loops=310,122)

  • Hash Cond: (ip_1.prop_value_id = pv_1.prop_value_id)
41. 620.316 8,063.172 ↓ 1.2 5 310,122

Nested Loop Left Join (cost=2.21..25.83 rows=4 width=660) (actual time=0.022..0.026 rows=5 loops=310,122)

  • Join Filter: (ip_1.prop_id = cp.prop_id)
  • Rows Removed by Join Filter: 4
42. 930.366 4,341.708 ↓ 1.2 5 310,122

Hash Join (cost=2.21..23.93 rows=4 width=560) (actual time=0.012..0.014 rows=5 loops=310,122)

  • Hash Cond: (pt.prop_type_id = p_2.type)
43. 310.122 310.122 ↑ 141.7 6 310,122

Seq Scan on t_prop_type pt (cost=0.00..18.50 rows=850 width=36) (actual time=0.000..0.001 rows=6 loops=310,122)

44. 620.244 3,101.220 ↓ 5.0 5 310,122

Hash (cost=2.19..2.19 rows=1 width=528) (actual time=0.010..0.010 rows=5 loops=310,122)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
45. 1,240.488 2,480.976 ↓ 5.0 5 310,122

Hash Join (cost=1.09..2.19 rows=1 width=528) (actual time=0.006..0.008 rows=5 loops=310,122)

  • Hash Cond: (p_2.prop_id = cp.prop_id)
46. 310.122 310.122 ↑ 1.0 7 310,122

Seq Scan on t_prop p_2 (cost=0.00..1.07 rows=7 width=524) (actual time=0.000..0.001 rows=7 loops=310,122)

47. 310.122 930.366 ↓ 5.0 5 310,122

Hash (cost=1.07..1.07 rows=1 width=4) (actual time=0.003..0.003 rows=5 loops=310,122)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
48. 620.244 620.244 ↓ 5.0 5 310,122

Seq Scan on t_cat_prop cp (cost=0.00..1.07 rows=1 width=4) (actual time=0.001..0.002 rows=5 loops=310,122)

  • Filter: (cat_id = i.cat_id)
  • Rows Removed by Filter: 1
49. 930.294 3,101.148 ↑ 1.0 1 1,550,574

Materialize (cost=0.00..1.84 rows=1 width=108) (actual time=0.001..0.002 rows=1 loops=1,550,574)

50. 2,170.854 2,170.854 ↑ 1.0 1 310,122

Seq Scan on t_item_prop ip_1 (cost=0.00..1.84 rows=1 width=108) (actual time=0.005..0.007 rows=1 loops=310,122)

  • Filter: (item_id = i.item_id)
  • Rows Removed by Filter: 66
51. 0.005 0.009 ↑ 1.0 13 1

Hash (cost=1.13..1.13 rows=13 width=520) (actual time=0.009..0.009 rows=13 loops=1)

  • Buckets: 1024 Batches: 1 Memory Usage: 9kB
52. 0.004 0.004 ↑ 1.0 13 1

Seq Scan on t_prop_value pv_1 (cost=0.00..1.13 rows=13 width=520) (actual time=0.002..0.004 rows=13 loops=1)

53. 930.366 2,170.854 ↑ 1.0 1 310,122

Aggregate (cost=1.53..1.54 rows=1 width=32) (actual time=0.007..0.007 rows=1 loops=310,122)

54. 1,240.488 1,240.488 ↑ 1.0 1 310,122

Seq Scan on t_item_image ii (cost=0.00..1.52 rows=1 width=1,040) (actual time=0.003..0.004 rows=1 loops=310,122)

  • Filter: (item_id = i.item_id)
  • Rows Removed by Filter: 42
Planning time : 3.556 ms
Execution time : 24,347.862 ms