Skip to content

Instantly share code, notes, and snippets.

@chris-baynes

chris-baynes/calcite-trace.log

Created July 22, 2016 15:14
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save chris-baynes/79bc39a7e40d3310ca0b9f0cdb34293f to your computer and use it in GitHub Desktop.
Save chris-baynes/79bc39a7e40d3310ca0b9f0cdb34293f to your computer and use it in GitHub Desktop.
Download ZIP
Raw
calcite-trace.log
0 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalTableScan#0
451 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#1
453 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#2
484 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#3
489 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#4
496 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#5
500 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]) in rel#5:Subset#0.NONE.[]
500 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] is 0.0
506 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
507 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
507 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
507 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#6
508 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#7
508 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0) in rel#7:Subset#1.NONE.[]
508 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] to its parent [rel#7:Subset#1.NONE.[]] is 0.0 (parent importance=0.0, child cost=1.0E30, parent cost=1.0E30)
508 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] is 0.0
508 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] is 0.0
509 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)]
510 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#8
510 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#9
510 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)) in rel#9:Subset#2.NONE.[]
510 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] to its parent [rel#9:Subset#2.NONE.[]] is 0.0 (parent importance=0.0, child cost=1.0E30, parent cost=1.0E30)
510 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] is 0.0
510 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 0.0
511 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [FilterProjectTransposeRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)]
511 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))]
621 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 1.0
674 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#10
675 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#11
675 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#12
675 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#13
675 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#14
678 [main] TRACE org.apache.calcite.plan.RelOptPlanner -
Breadth-first from root: {
HepRelVertex#14 = rel#13:LogicalFilter.NONE.[](input=HepRelVertex#12,condition==($0, 400)), rowcount=15.0, cumulative cost={215.0 rows, 301.0 cpu, 0.0 io}
HepRelVertex#12 = rel#11:LogicalProject.NONE.[](input=HepRelVertex#10,time_id=$0), rowcount=100.0, cumulative cost={200.0 rows, 201.0 cpu, 0.0 io}
HepRelVertex#10 = rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
}
679 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [SubQueryRemoveRule:Filter]
680 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [SubQueryRemoveRule:Project]
680 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [SubQueryRemoveRule:Join]
680 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#13:LogicalFilter.NONE.[](input=HepRelVertex#12,condition==($0, 400))
680 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#11:LogicalProject.NONE.[](input=HepRelVertex#10,time_id=$0)
680 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#15
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#16
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#17
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#17 is equivalent to rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#18
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#18 is equivalent to rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))
692 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#19
693 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new AbstractConverter#20
693 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]) in rel#9:Subset#2.NONE.[]
693 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 1.0
693 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [ExpandConversionRule] rels [rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[])]
693 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new AbstractConverter#21
694 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]) in rel#19:Subset#2.ENUMERABLE.[]
694 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.495 (parent importance=0.5, child cost=1.0E30, parent cost=1.0E30)
694 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 0.495
694 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#19:Subset#2.ENUMERABLE.[]] is 1.0
694 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [ExpandConversionRule] rels [rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[])]
699 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 1/1; PHASE = PRE_PROCESS_MDR; COST = {inf}
700 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.7290000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.9 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.7290000000000001}
700 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 2/1; PHASE = PRE_PROCESS; COST = {inf}
701 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.7290000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.9 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.7290000000000001}
701 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 3/1; PHASE = OPTIMIZE; COST = {inf}
702 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.7290000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.9 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.7290000000000001}
704 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [FilterProjectTransposeRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.9
rule [ExpandConversionRule] rels [rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[])] importance 0.9
rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))] importance 0.9
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.7290000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.7290000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.7290000000000001
704 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [ExpandConversionRule] rels [rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[])]
705 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#90: Apply rule [ExpandConversionRule] to [rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[])]
705 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#90 generated 0 successors.
705 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 4/2; PHASE = OPTIMIZE; COST = {inf}
707 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.7290000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.9 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.7290000000000001}
707 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [ExpandConversionRule] rels [rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[])] importance 0.9
rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))] importance 0.9
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.7290000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.7290000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.7290000000000001
707 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [FilterProjectTransposeRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)]
707 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#62: Apply rule [FilterProjectTransposeRule] to [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)]
708 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#22
708 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#23
708 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#23 via FilterProjectTransposeRule
709 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#62: Rule FilterProjectTransposeRule arguments [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] created rel#23:LogicalProject
710 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#24
710 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)) in rel#24:Subset#3.NONE.[]
711 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] to its parent [rel#7:Subset#1.NONE.[]] is 0.8019000000000001 (parent importance=0.81, child cost=1.0E30, parent cost=1.0E30)
711 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] to its parent [rel#24:Subset#3.NONE.[]] is 0.0 (parent importance=0.0, child cost=1.0E30, parent cost=1.0E30)
711 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] is 0.8019000000000001
711 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] is 0.0
711 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))]
711 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [MaterializedViewFilterScanRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
712 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#25
712 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0) in rel#9:Subset#2.NONE.[]
712 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] to its parent [rel#9:Subset#2.NONE.[]] is 0.891 (parent importance=0.9, child cost=1.0E30, parent cost=1.0E30)
712 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] is 0.891
713 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=1.0E30, parent cost=1.0E30)
713 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 0.99
713 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [ProjectFilterTransposeRule] rels [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))]
713 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableProjectRule] rels [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)]
714 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#62 generated 1 successors: [LogicalProject#23]
714 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 5/3; PHASE = OPTIMIZE; COST = {inf}
715 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
716 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [ExpandConversionRule] rels [rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[])] importance 0.99
rule [EnumerableProjectRule] rels [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)] importance 0.99
rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))] importance 0.99
rule [MaterializedViewFilterScanRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.891
rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] importance 0.891
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
716 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [ProjectFilterTransposeRule] rels [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))]
716 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#131: Apply rule [ProjectFilterTransposeRule] to [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))]
720 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalProject#26
721 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#27
721 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#27 via ProjectFilterTransposeRule
721 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#131: Rule ProjectFilterTransposeRule arguments [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] created rel#27:LogicalFilter
721 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#26 is equivalent to rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)
722 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new LogicalFilter#28
722 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#28 is equivalent to rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))
722 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#131 generated 1 successors: [LogicalFilter#27]
722 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 6/4; PHASE = OPTIMIZE; COST = {inf}
723 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
723 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableProjectRule] rels [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)] importance 0.99
rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))] importance 0.99
rule [MaterializedViewFilterScanRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.891
rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] importance 0.891
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
723 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [ExpandConversionRule] rels [rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[])]
723 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#81: Apply rule [ExpandConversionRule] to [rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[])]
723 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#81 generated 0 successors.
723 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 7/5; PHASE = OPTIMIZE; COST = {inf}
724 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
724 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))] importance 0.99
rule [MaterializedViewFilterScanRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.891
rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] importance 0.891
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
724 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableProjectRule] rels [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)]
725 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#133: Apply rule [EnumerableProjectRule] to [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)]
725 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#29
725 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableProject#30
725 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#30 via EnumerableProjectRule
725 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#133: Rule EnumerableProjectRule arguments [rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)] created rel#30:EnumerableProject
726 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0) in rel#19:Subset#2.ENUMERABLE.[]
726 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#19:Subset#2.ENUMERABLE.[]] is 1.0
727 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#133 generated 1 successors: [rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0)]
727 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 8/6; PHASE = OPTIMIZE; COST = {inf}
728 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.4455
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
728 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [MaterializedViewFilterScanRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.891
rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] importance 0.891
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
728 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableFilterRule] rels [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))]
728 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#66: Apply rule [EnumerableFilterRule] to [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))]
729 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#31
729 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableFilter#32
729 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#32 via EnumerableFilterRule
729 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#66: Rule EnumerableFilterRule arguments [rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))] created rel#32:EnumerableFilter
729 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)) in rel#19:Subset#2.ENUMERABLE.[]
729 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#19:Subset#2.ENUMERABLE.[]] is 1.0
730 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#66 generated 1 successors: [rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400))]
730 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 9/7; PHASE = OPTIMIZE; COST = {inf}
731 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.405
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.4455
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
732 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] importance 0.891
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
732 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [MaterializedViewFilterScanRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
732 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#113: Apply rule [MaterializedViewFilterScanRule] to [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
732 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#113 generated 0 successors.
732 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 10/8; PHASE = OPTIMIZE; COST = {inf}
733 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.405
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.4455
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
733 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] importance 0.81
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
733 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableFilterRule] rels [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))]
733 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#110: Apply rule [EnumerableFilterRule] to [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))]
733 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#33
733 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableFilter#34
733 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#34 via EnumerableFilterRule
733 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#110: Rule EnumerableFilterRule arguments [rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))] created rel#34:EnumerableFilter
734 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)) in rel#29:Subset#3.ENUMERABLE.[]
734 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#29:Subset#3.ENUMERABLE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=1.0E30, parent cost=1.0E30)
734 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#29:Subset#3.ENUMERABLE.[]] is 0.99
735 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#110 generated 1 successors: [rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400))]
735 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 11/9; PHASE = OPTIMIZE; COST = {inf}
736 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.8019000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=null, importance=0.40095000000000003
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.405
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.891
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.99
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#29:Subset#3.ENUMERABLE.[]=0.99 rel#24:Subset#3.NONE.[]=0.891 rel#7:Subset#1.NONE.[]=0.81 rel#5:Subset#0.NONE.[]=0.8019000000000001}
736 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.8019000000000001
736 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableProjectRule] rels [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)]
736 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#31: Apply rule [EnumerableProjectRule] to [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)]
737 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableProject#35
737 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#35 via EnumerableProjectRule
737 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#31: Rule EnumerableProjectRule arguments [rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)] created rel#35:EnumerableProject
737 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0) in rel#31:Subset#1.ENUMERABLE.[]
737 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#31:Subset#1.ENUMERABLE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=1.0E30, parent cost=1.0E30)
737 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#31:Subset#1.ENUMERABLE.[]] is 0.99
738 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [FilterProjectTransposeRule] rels [rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0)]
738 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#31 generated 1 successors: [rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0)]
739 [main] TRACE org.apache.calcite.plan.RelOptPlanner - boostImportance(1.25, [rel#9:Subset#2.NONE.[], rel#7:Subset#1.NONE.[], rel#5:Subset#0.NONE.[], rel#24:Subset#3.NONE.[]])
739 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 12/10; PHASE = OPTIMIZE; COST = {inf}
740 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9999999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=null, importance=0.49999999999999994
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9999999999999999
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9999999999999999
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9999999999999999
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.99
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#5:Subset#0.NONE.[]=0.9999999999999999 rel#7:Subset#1.NONE.[]=0.9999999999999999 rel#9:Subset#2.NONE.[]=0.9999999999999999 rel#24:Subset#3.NONE.[]=0.9999999999999999 rel#29:Subset#3.ENUMERABLE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99}
741 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.9999999999999999
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.9999999999999999
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.9999999999999999
741 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [FilterProjectTransposeRule] rels [rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0)]
741 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#204: Apply rule [FilterProjectTransposeRule] to [rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0)]
741 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableFilter#36
741 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableProject#37
741 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#37 via FilterProjectTransposeRule
741 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#204: Rule FilterProjectTransposeRule arguments [rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0)] created rel#37:EnumerableProject
741 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#36 is equivalent to rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400))
742 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableProject#38
742 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#38 is equivalent to rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0)
743 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#204 generated 1 successors: [EnumerableProject#37]
743 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 13/11; PHASE = OPTIMIZE; COST = {inf}
744 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9999999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=null, importance=0.49999999999999994
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9999999999999999
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9999999999999999
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9999999999999999
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.99
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#5:Subset#0.NONE.[]=0.9999999999999999 rel#7:Subset#1.NONE.[]=0.9999999999999999 rel#9:Subset#2.NONE.[]=0.9999999999999999 rel#24:Subset#3.NONE.[]=0.9999999999999999 rel#29:Subset#3.ENUMERABLE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99}
744 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.9999999999999999
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.9999999999999999
744 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [TableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
744 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#15: Apply rule [TableScanRule] to [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
745 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new JdbcTableScan#39
745 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#39 via TableScanRule
745 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#15: Rule TableScanRule arguments [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] created rel#39:JdbcTableScan
752 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#40
765 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#40:Subset#0.JDBC.source1.[]] cost was {inf} now {100.0 rows, 101.0 cpu, 0.0 io}
765 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]) in rel#40:Subset#0.JDBC.source1.[]
765 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#40:Subset#0.JDBC.source1.[]] is 0.0
766 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])]
766 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#40:Subset#0.JDBC.source1.[]]
805 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#15 generated 1 successors: [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])]
805 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 14/12; PHASE = OPTIMIZE; COST = {inf}
807 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9999999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=null, importance=0.49999999999999994
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49999999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9999999999999999
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9999999999999999
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9999999999999999
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.99
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#5:Subset#0.NONE.[]=0.9999999999999999 rel#7:Subset#1.NONE.[]=0.9999999999999999 rel#9:Subset#2.NONE.[]=0.9999999999999999 rel#24:Subset#3.NONE.[]=0.9999999999999999 rel#29:Subset#3.ENUMERABLE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#40:Subset#0.JDBC.source1.[]=0.0}
809 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.9999999999999999
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#40:Subset#0.JDBC.source1.[]] importance 0.49999999999999994
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49999999999999994
809 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [BindableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
809 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#5: Apply rule [BindableTableScanRule] to [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
810 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new BindableTableScan#41
810 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#41 via BindableTableScanRule
810 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#5: Rule BindableTableScanRule arguments [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] created rel#41:BindableTableScan
812 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new RelSubset#42
827 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#42:Subset#0.BINDABLE.[]] cost was {inf} now {1.0 rows, 1.01 cpu, 0.0 io}
827 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]) in rel#42:Subset#0.BINDABLE.[]
827 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#42:Subset#0.BINDABLE.[]] is 0.0
827 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
827 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [EnumerableInterpreterRule] rels [rel#42:Subset#0.BINDABLE.[]]
872 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#5 generated 1 successors: [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
873 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 15/13; PHASE = OPTIMIZE; COST = {inf}
875 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9999999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=null, importance=0.49999999999999994
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49999999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49999999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9999999999999999
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=null, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9999999999999999
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=null, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9999999999999999
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=null, importance=0.99
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#5:Subset#0.NONE.[]=0.9999999999999999 rel#7:Subset#1.NONE.[]=0.9999999999999999 rel#9:Subset#2.NONE.[]=0.9999999999999999 rel#24:Subset#3.NONE.[]=0.9999999999999999 rel#29:Subset#3.ENUMERABLE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#40:Subset#0.JDBC.source1.[]=0.0 rel#42:Subset#0.BINDABLE.[]=0.0}
875 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#40:Subset#0.JDBC.source1.[]] importance 0.49999999999999994
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49999999999999994
rule [EnumerableInterpreterRule] rels [rel#42:Subset#0.BINDABLE.[]] importance 0.49999999999999994
rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49999999999999994
875 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableTableScanRule] rels [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
875 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#12: Apply rule [EnumerableTableScanRule] to [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])]
877 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableTableScan#43
877 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#43 via EnumerableTableScanRule
877 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#12: Rule EnumerableTableScanRule arguments [rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])] created rel#43:EnumerableTableScan
878 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#33:Subset#0.ENUMERABLE.[]] cost was {inf} now {100.0 rows, 101.0 cpu, 0.0 io}
878 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#29:Subset#3.ENUMERABLE.[]] cost was {inf} now {115.0 rows, 201.0 cpu, 0.0 io}
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#29:Subset#3.ENUMERABLE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 3.16E-28 (parent importance=1.0, child cost=316.0, parent cost=1.0E30)
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#29:Subset#3.ENUMERABLE.[]] is 3.16E-28
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#19:Subset#2.ENUMERABLE.[]] cost was {inf} now {130.0 rows, 216.0 cpu, 0.0 io}
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#19:Subset#2.ENUMERABLE.[]] is 1.0
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#31:Subset#1.ENUMERABLE.[]] cost was {inf} now {200.0 rows, 201.0 cpu, 0.0 io}
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#31:Subset#1.ENUMERABLE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=401.0, parent cost=346.0)
879 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#31:Subset#1.ENUMERABLE.[]] is 0.99
880 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]) in rel#33:Subset#0.ENUMERABLE.[]
880 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#29:Subset#3.ENUMERABLE.[]] is 0.3180379746835442 (parent importance=0.49999999999999994, child cost=201.0, parent cost=316.0)
880 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#31:Subset#1.ENUMERABLE.[]] is 0.4962344139650873 (parent importance=0.99, child cost=201.0, parent cost=401.0)
880 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] is 0.4962344139650873
880 [main] TRACE org.apache.calcite.plan.RelOptPlanner - OPTIMIZE Rule-match queued: rule [MaterializedViewFilterScanRule] rels [rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
881 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#12 generated 1 successors: [rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
882 [main] TRACE org.apache.calcite.plan.RelOptPlanner - boostImportance(1.0, [])
882 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] to its parent [rel#7:Subset#1.NONE.[]] is 0.9899999999999999 (parent importance=0.9999999999999999, child cost=1.0E30, parent cost=1.0E30)
882 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] to its parent [rel#24:Subset#3.NONE.[]] is 0.9899999999999999 (parent importance=0.9999999999999999, child cost=1.0E30, parent cost=1.0E30)
882 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#5:Subset#0.NONE.[]] is 0.9899999999999999
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] to its parent [rel#9:Subset#2.NONE.[]] is 0.9899999999999999 (parent importance=0.9999999999999999, child cost=1.0E30, parent cost=1.0E30)
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] is 0.9899999999999999
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=1.0E30, parent cost=346.0)
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 0.99
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#19:Subset#2.ENUMERABLE.[]] is 1.0
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] to its parent [rel#9:Subset#2.NONE.[]] is 0.9801 (parent importance=0.99, child cost=1.0E30, parent cost=1.0E30)
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] is 0.9801
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=1.0E30, parent cost=346.0)
883 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 0.99
884 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] to its parent [rel#9:Subset#2.NONE.[]] is 0.9801 (parent importance=0.99, child cost=1.0E30, parent cost=1.0E30)
884 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#7:Subset#1.NONE.[]] is 0.9801
884 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] to its parent [rel#9:Subset#2.NONE.[]] is 0.9801 (parent importance=0.99, child cost=1.0E30, parent cost=1.0E30)
884 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#24:Subset#3.NONE.[]] is 0.9801
884 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=1.0E30, parent cost=346.0)
884 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#9:Subset#2.NONE.[]] is 0.99
884 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 16/14; PHASE = OPTIMIZE; COST = {130.0 rows, 216.0 cpu, 0.0 io}
887 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9899999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#43, importance=0.4962344139650873
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49499999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49499999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9801
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={200.0 rows, 201.0 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={130.0 rows, 216.0 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={215.0 rows, 301.0 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9801
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.49005
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={115.0 rows, 201.0 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#5:Subset#0.NONE.[]=0.9899999999999999 rel#7:Subset#1.NONE.[]=0.9801 rel#24:Subset#3.NONE.[]=0.9801 rel#33:Subset#0.ENUMERABLE.[]=0.4962344139650873 rel#40:Subset#0.JDBC.source1.[]=0.0 rel#42:Subset#0.BINDABLE.[]=0.0 rel#29:Subset#3.ENUMERABLE.[]=3.16E-28}
887 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.4962344139650873
rule [EnumerableInterpreterRule] rels [rel#42:Subset#0.BINDABLE.[]] importance 0.4962344139650873
rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49499999999999994
rule [MaterializedViewFilterScanRule] rels [rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49005
887 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#40:Subset#0.JDBC.source1.[]]
887 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#234: Apply rule [JdbcToEnumerableConverterRule:JDBC.source1] to [rel#40:Subset#0.JDBC.source1.[]]
892 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new JdbcToEnumerableConverter#44
892 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#44 via JdbcToEnumerableConverterRule:JDBC.source1
892 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#234: Rule JdbcToEnumerableConverterRule:JDBC.source1 arguments [rel#40:Subset#0.JDBC.source1.[]] created rel#44:JdbcToEnumerableConverter
931 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]) in rel#33:Subset#0.ENUMERABLE.[]
932 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#40:Subset#0.JDBC.source1.[]] to its parent [rel#33:Subset#0.ENUMERABLE.[]] is 0.4912720698254364 (parent importance=0.4962344139650873, child cost=201.0, parent cost=201.0)
932 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#40:Subset#0.JDBC.source1.[]] is 0.4912720698254364
932 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#29:Subset#3.ENUMERABLE.[]] is 0.3117090189873417 (parent importance=0.49005, child cost=201.0, parent cost=316.0)
932 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#31:Subset#1.ENUMERABLE.[]] is 0.4962344139650873 (parent importance=0.99, child cost=201.0, parent cost=401.0)
932 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] is 0.4962344139650873
954 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#234 generated 1 successors: [rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[])]
954 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 17/15; PHASE = OPTIMIZE; COST = {130.0 rows, 216.0 cpu, 0.0 io}
957 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9899999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#43, importance=0.4962344139650873
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49499999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49499999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9801
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={200.0 rows, 201.0 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={130.0 rows, 216.0 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={215.0 rows, 301.0 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9801
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.49005
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={115.0 rows, 201.0 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#5:Subset#0.NONE.[]=0.9899999999999999 rel#7:Subset#1.NONE.[]=0.9801 rel#24:Subset#3.NONE.[]=0.9801 rel#33:Subset#0.ENUMERABLE.[]=0.4962344139650873 rel#40:Subset#0.JDBC.source1.[]=0.4912720698254364 rel#42:Subset#0.BINDABLE.[]=0.0 rel#29:Subset#3.ENUMERABLE.[]=3.16E-28}
957 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49499999999999994
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.4962344139650873
rule [MaterializedViewFilterScanRule] rels [rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49005
957 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableInterpreterRule] rels [rel#42:Subset#0.BINDABLE.[]]
957 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#255: Apply rule [EnumerableInterpreterRule] to [rel#42:Subset#0.BINDABLE.[]]
957 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableInterpreter#45
957 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#45 via EnumerableInterpreterRule
957 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#255: Rule EnumerableInterpreterRule arguments [rel#42:Subset#0.BINDABLE.[]] created rel#45:EnumerableInterpreter
993 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#33:Subset#0.ENUMERABLE.[]] cost was {100.0 rows, 101.0 cpu, 0.0 io} now {51.0 rows, 51.01 cpu, 0.0 io}
994 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#29:Subset#3.ENUMERABLE.[]] is 0.15819620411392402 (parent importance=0.49005, child cost=102.00999999999999, parent cost=316.0)
994 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#31:Subset#1.ENUMERABLE.[]] is 0.2518451371571072 (parent importance=0.99, child cost=102.00999999999999, parent cost=401.0)
994 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] is 0.2518451371571072
1007 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#29:Subset#3.ENUMERABLE.[]] cost was {115.0 rows, 201.0 cpu, 0.0 io} now {66.0 rows, 151.01 cpu, 0.0 io}
1008 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#29:Subset#3.ENUMERABLE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.6271965317919075 (parent importance=1.0, child cost=217.01, parent cost=346.0)
1008 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#29:Subset#3.ENUMERABLE.[]] is 0.6271965317919075
1008 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#19:Subset#2.ENUMERABLE.[]] cost was {130.0 rows, 216.0 cpu, 0.0 io} now {81.0 rows, 166.01 cpu, 0.0 io}
1008 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#19:Subset#2.ENUMERABLE.[]] is 1.0
1008 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Subset cost improved: subset [rel#31:Subset#1.ENUMERABLE.[]] cost was {200.0 rows, 201.0 cpu, 0.0 io} now {151.0 rows, 151.01 cpu, 0.0 io}
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#31:Subset#1.ENUMERABLE.[]] to its parent [rel#19:Subset#2.ENUMERABLE.[]] is 0.99 (parent importance=1.0, child cost=302.01, parent cost=247.01)
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#31:Subset#1.ENUMERABLE.[]] is 0.99
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]) in rel#33:Subset#0.ENUMERABLE.[]
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#42:Subset#0.BINDABLE.[]] to its parent [rel#33:Subset#0.ENUMERABLE.[]] is 0.009753455543574157 (parent importance=0.49499999999999994, child cost=2.01, parent cost=102.00999999999999)
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#42:Subset#0.BINDABLE.[]] is 0.009753455543574157
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#29:Subset#3.ENUMERABLE.[]] is 0.29482658959537567 (parent importance=0.6271965317919075, child cost=102.00999999999999, parent cost=217.01)
1009 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] to its parent [rel#31:Subset#1.ENUMERABLE.[]] is 0.3343925697824575 (parent importance=0.99, child cost=102.00999999999999, parent cost=302.01)
1010 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Importance of [rel#33:Subset#0.ENUMERABLE.[]] is 0.3343925697824575
1011 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#255 generated 1 successors: [rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[])]
1011 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 18/16; PHASE = OPTIMIZE; COST = {81.0 rows, 166.01 cpu, 0.0 io}
1014 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9899999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#45, importance=0.49499999999999994
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]), rowcount=100.0, cumulative cost={51.0 rows, 51.01 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49499999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49499999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9801
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={151.0 rows, 151.01 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={81.0 rows, 166.01 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={166.0 rows, 251.01 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9801
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.6271965317919075
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={66.0 rows, 151.01 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#5:Subset#0.NONE.[]=0.9899999999999999 rel#7:Subset#1.NONE.[]=0.9801 rel#24:Subset#3.NONE.[]=0.9801 rel#29:Subset#3.ENUMERABLE.[]=0.6271965317919075 rel#33:Subset#0.ENUMERABLE.[]=0.3343925697824575 rel#40:Subset#0.JDBC.source1.[]=0.4912720698254364 rel#42:Subset#0.BINDABLE.[]=0.009753455543574157}
1014 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49499999999999994
rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49499999999999994
1014 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [MaterializedViewFilterScanRule] rels [rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
1014 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#263: Apply rule [MaterializedViewFilterScanRule] to [rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
1014 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#263 generated 0 successors.
1014 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 19/17; PHASE = OPTIMIZE; COST = {81.0 rows, 166.01 cpu, 0.0 io}
1017 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9899999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#45, importance=0.49499999999999994
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]), rowcount=100.0, cumulative cost={51.0 rows, 51.01 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49499999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49499999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9801
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={151.0 rows, 151.01 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={81.0 rows, 166.01 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={166.0 rows, 251.01 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9801
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.6271965317919075
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={66.0 rows, 151.01 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#5:Subset#0.NONE.[]=0.9899999999999999 rel#7:Subset#1.NONE.[]=0.9801 rel#24:Subset#3.NONE.[]=0.9801 rel#29:Subset#3.ENUMERABLE.[]=0.6271965317919075 rel#33:Subset#0.ENUMERABLE.[]=0.3343925697824575 rel#40:Subset#0.JDBC.source1.[]=0.4912720698254364 rel#42:Subset#0.BINDABLE.[]=0.009753455543574157}
1017 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] importance 0.49499999999999994
1017 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [JdbcToEnumerableConverterRule:JDBC.source1] rels [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])]
1017 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#225: Apply rule [JdbcToEnumerableConverterRule:JDBC.source1] to [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])]
1017 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new JdbcToEnumerableConverter#46
1018 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#46 via JdbcToEnumerableConverterRule:JDBC.source1
1018 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#225: Rule JdbcToEnumerableConverterRule:JDBC.source1 arguments [rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997])] created rel#46:JdbcToEnumerableConverter
1018 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new JdbcToEnumerableConverter#47
1018 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#47 is equivalent to rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[])
1019 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#225 generated 1 successors: [JdbcToEnumerableConverter#46]
1019 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 20/18; PHASE = OPTIMIZE; COST = {81.0 rows, 166.01 cpu, 0.0 io}
1022 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9899999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#45, importance=0.49499999999999994
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]), rowcount=100.0, cumulative cost={51.0 rows, 51.01 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49499999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49499999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9801
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={151.0 rows, 151.01 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={81.0 rows, 166.01 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={166.0 rows, 251.01 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9801
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.6271965317919075
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={66.0 rows, 151.01 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#5:Subset#0.NONE.[]=0.9899999999999999 rel#7:Subset#1.NONE.[]=0.9801 rel#24:Subset#3.NONE.[]=0.9801 rel#29:Subset#3.ENUMERABLE.[]=0.6271965317919075 rel#33:Subset#0.ENUMERABLE.[]=0.3343925697824575 rel#40:Subset#0.JDBC.source1.[]=0.4912720698254364 rel#42:Subset#0.BINDABLE.[]=0.009753455543574157}
1022 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Sorted rule queue:
1022 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Pop match: rule [EnumerableInterpreterRule] rels [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
1022 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#240: Apply rule [EnumerableInterpreterRule] to [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])]
1022 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableInterpreter#48
1022 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Transform to: rel#48 via EnumerableInterpreterRule
1022 [main] TRACE org.apache.calcite.plan.RelOptPlanner - call#240: Rule EnumerableInterpreterRule arguments [rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])] created rel#48:EnumerableInterpreter
1022 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableInterpreter#49
1022 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Register: rel#49 is equivalent to rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[])
1023 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#240 generated 1 successors: [EnumerableInterpreter#48]
1023 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 21/19; PHASE = OPTIMIZE; COST = {81.0 rows, 166.01 cpu, 0.0 io}
1026 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.9899999999999999
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#45, importance=0.49499999999999994
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]), rowcount=100.0, cumulative cost={51.0 rows, 51.01 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.49499999999999994
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.49499999999999994
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.9801
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.99
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={151.0 rows, 151.01 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.99
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={81.0 rows, 166.01 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={166.0 rows, 251.01 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.9801
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.6271965317919075
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={66.0 rows, 151.01 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.99 rel#31:Subset#1.ENUMERABLE.[]=0.99 rel#5:Subset#0.NONE.[]=0.9899999999999999 rel#7:Subset#1.NONE.[]=0.9801 rel#24:Subset#3.NONE.[]=0.9801 rel#29:Subset#3.ENUMERABLE.[]=0.6271965317919075 rel#33:Subset#0.ENUMERABLE.[]=0.3343925697824575 rel#40:Subset#0.JDBC.source1.[]=0.4912720698254364 rel#42:Subset#0.BINDABLE.[]=0.009753455543574157}
1026 [main] TRACE org.apache.calcite.plan.RelOptPlanner - boostImportance(1.0, [])
1026 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - PLANNER = org.apache.calcite.plan.volcano.VolcanoPlanner@25455e70; TICK = 22/1; PHASE = CLEANUP; COST = {81.0 rows, 166.01 cpu, 0.0 io}
1029 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.7290000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#45, importance=0.81
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]), rowcount=100.0, cumulative cost={51.0 rows, 51.01 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.7290000000000001
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.7290000000000001
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.9
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={151.0 rows, 151.01 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={81.0 rows, 166.01 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={166.0 rows, 251.01 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.81
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.9
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={66.0 rows, 151.01 cpu, 0.0 io}
Importances: { rel#19:Subset#2.ENUMERABLE.[]=1.0 rel#9:Subset#2.NONE.[]=0.9 rel#29:Subset#3.ENUMERABLE.[]=0.9 rel#31:Subset#1.ENUMERABLE.[]=0.9 rel#7:Subset#1.NONE.[]=0.81 rel#24:Subset#3.NONE.[]=0.81 rel#33:Subset#0.ENUMERABLE.[]=0.81 rel#5:Subset#0.NONE.[]=0.7290000000000001 rel#40:Subset#0.JDBC.source1.[]=0.7290000000000001 rel#42:Subset#0.BINDABLE.[]=0.7290000000000001}
1031 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Root: rel#19:Subset#2.ENUMERABLE.[]
Original rel:
Sets:
Set#0, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#5:Subset#0.NONE.[], best=null, importance=0.7290000000000001
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={inf}
rel#33:Subset#0.ENUMERABLE.[], best=rel#45, importance=0.81
rel#43:EnumerableTableScan.ENUMERABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#44:JdbcToEnumerableConverter.ENUMERABLE.[](input=rel#40:Subset#0.JDBC.source1.[]), rowcount=100.0, cumulative cost={110.0 rows, 111.0 cpu, 0.0 io}
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[]), rowcount=100.0, cumulative cost={51.0 rows, 51.01 cpu, 0.0 io}
rel#40:Subset#0.JDBC.source1.[], best=rel#39, importance=0.7290000000000001
rel#39:JdbcTableScan.JDBC.source1.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={100.0 rows, 101.0 cpu, 0.0 io}
rel#42:Subset#0.BINDABLE.[], best=rel#41, importance=0.7290000000000001
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
Set#1, type: RecordType(INTEGER time_id)
rel#7:Subset#1.NONE.[], best=null, importance=0.81
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0), rowcount=100.0, cumulative cost={inf}
rel#31:Subset#1.ENUMERABLE.[], best=rel#35, importance=0.9
rel#35:EnumerableProject.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],time_id=$0), rowcount=100.0, cumulative cost={151.0 rows, 151.01 cpu, 0.0 io}
Set#2, type: RecordType(INTEGER time_id)
rel#9:Subset#2.NONE.[], best=null, importance=0.9
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#20:AbstractConverter.NONE.[](input=rel#19:Subset#2.ENUMERABLE.[],convention=NONE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0), rowcount=15.0, cumulative cost={inf}
rel#19:Subset#2.ENUMERABLE.[], best=rel#30, importance=1.0
rel#21:AbstractConverter.ENUMERABLE.[](input=rel#9:Subset#2.NONE.[],convention=ENUMERABLE,sort=[]), rowcount=15.0, cumulative cost={inf}
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0), rowcount=15.0, cumulative cost={81.0 rows, 166.01 cpu, 0.0 io}
rel#32:EnumerableFilter.ENUMERABLE.[](input=rel#31:Subset#1.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={166.0 rows, 251.01 cpu, 0.0 io}
Set#3, type: RecordType(INTEGER time_id, VARCHAR(30) city, VARCHAR(30) state_province, VARCHAR(30) country, DECIMAL(10, 4) store_sales, DECIMAL(10, 4) store_cost, DECIMAL(10, 4) unit_sales, INTEGER fact_count)
rel#24:Subset#3.NONE.[], best=null, importance=0.81
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={inf}
rel#29:Subset#3.ENUMERABLE.[], best=rel#34, importance=0.9
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400)), rowcount=15.0, cumulative cost={66.0 rows, 151.01 cpu, 0.0 io}
1032 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableInterpreter#50
1033 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableFilter#51
1033 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableProject#52
1064 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Cheapest plan:
EnumerableProject(time_id=[$0]): rowcount = 15.0, cumulative cost = {80.0 rows, 165.0 cpu, 0.0 io}, id = 52
EnumerableFilter(condition=[=($0, 400)]): rowcount = 15.0, cumulative cost = {65.0 rows, 150.0 cpu, 0.0 io}, id = 51
EnumerableInterpreter: rowcount = 100.0, cumulative cost = {50.0 rows, 50.0 cpu, 0.0 io}, id = 50
BindableTableScan(table=[[source1, agg_lc_06_sales_fact_1997]]): rowcount = 100.0, cumulative cost = {1.0 rows, 1.01 cpu, 0.0 io}, id = 41
1066 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - Provenance:
EnumerableProject#52
direct
rel#30:EnumerableProject.ENUMERABLE.[](input=rel#29:Subset#3.ENUMERABLE.[],time_id=$0)
call#133 rule [EnumerableProjectRule]
rel#25:LogicalProject.NONE.[](input=rel#24:Subset#3.NONE.[],time_id=$0)
call#62 rule [FilterProjectTransposeRule]
rel#8:LogicalFilter.NONE.[](input=rel#7:Subset#1.NONE.[],condition==($0, 400))
no parent
rel#6:LogicalProject.NONE.[](input=rel#5:Subset#0.NONE.[],time_id=$0)
no parent
EnumerableFilter#51
direct
rel#34:EnumerableFilter.ENUMERABLE.[](input=rel#33:Subset#0.ENUMERABLE.[],condition==($0, 400))
call#110 rule [EnumerableFilterRule]
rel#22:LogicalFilter.NONE.[](input=rel#5:Subset#0.NONE.[],condition==($0, 400))
call#62 rule [FilterProjectTransposeRule]
rel#8 (see above)
rel#6 (see above)
EnumerableInterpreter#50
direct
rel#45:EnumerableInterpreter.ENUMERABLE.[](input=rel#42:Subset#0.BINDABLE.[])
call#255 rule [EnumerableInterpreterRule]
rel#42:Subset#0.BINDABLE.[]
subset rel#42:Subset#0.BINDABLE.[]
rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])
call#5 rule [BindableTableScanRule]
rel#0:LogicalTableScan.NONE.[](table=[source1, agg_lc_06_sales_fact_1997])
no parent
rel#41 (see above)
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#53
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableInterpreter#54
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#55
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableFilter#56
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#57
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableProject#58
1066 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#59
1067 [main] TRACE org.apache.calcite.plan.RelOptPlanner -
Breadth-first from root: {
HepRelVertex#59 = rel#58:EnumerableProject.ENUMERABLE.[](input=HepRelVertex#57,time_id=$0), rowcount=15.0, cumulative cost={80.0 rows, 165.0 cpu, 0.0 io}
HepRelVertex#57 = rel#56:EnumerableFilter.ENUMERABLE.[](input=HepRelVertex#55,condition==($0, 400)), rowcount=15.0, cumulative cost={65.0 rows, 150.0 cpu, 0.0 io}
HepRelVertex#55 = rel#54:EnumerableInterpreter.ENUMERABLE.[](input=HepRelVertex#53), rowcount=100.0, cumulative cost={50.0 rows, 50.0 cpu, 0.0 io}
HepRelVertex#53 = rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
}
1067 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [NoneToBindableConverterRule]
1068 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [EnumerableCalcRule]
1068 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [EnumerableFilterToCalcRule]
1068 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#282: Apply rule [EnumerableFilterToCalcRule] to [rel#56:EnumerableFilter.ENUMERABLE.[](input=HepRelVertex#55,condition==($0, 400))]
1101 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableCalc#60
1102 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#282: Rule EnumerableFilterToCalcRule arguments [rel#56:EnumerableFilter.ENUMERABLE.[](input=HepRelVertex#55,condition==($0, 400))] produced EnumerableCalc#60
1102 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#61
1178 [main] TRACE org.apache.calcite.plan.RelOptPlanner -
Breadth-first from root: {
HepRelVertex#59 = rel#58:EnumerableProject.ENUMERABLE.[](input=HepRelVertex#61,time_id=$0), rowcount=15.0, cumulative cost={80.0 rows, 1965.0 cpu, 0.0 io}
HepRelVertex#61 = rel#60:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#55,expr#0..7={inputs},expr#8=400,expr#9==($t0, $t8),time_id=$t0,city=$t1,state_province=$t2,country=$t3,store_sales=$t4,store_cost=$t5,unit_sales=$t6,fact_count=$t7,$condition=$t9), rowcount=15.0, cumulative cost={65.0 rows, 1950.0 cpu, 0.0 io}
HepRelVertex#55 = rel#54:EnumerableInterpreter.ENUMERABLE.[](input=HepRelVertex#53), rowcount=100.0, cumulative cost={50.0 rows, 50.0 cpu, 0.0 io}
HepRelVertex#53 = rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
}
1178 [main] TRACE org.apache.calcite.plan.RelOptPlanner - collecting garbage
1178 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [EnumerableProjectToCalcRule]
1178 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#283: Apply rule [EnumerableProjectToCalcRule] to [rel#58:EnumerableProject.ENUMERABLE.[](input=HepRelVertex#61,time_id=$0)]
1198 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableCalc#62
1198 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#283: Rule EnumerableProjectToCalcRule arguments [rel#58:EnumerableProject.ENUMERABLE.[](input=HepRelVertex#61,time_id=$0)] produced EnumerableCalc#62
1198 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#63
1199 [main] TRACE org.apache.calcite.plan.RelOptPlanner -
Breadth-first from root: {
HepRelVertex#63 = rel#62:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#61,expr#0..7={inputs},time_id=$t0), rowcount=15.0, cumulative cost={80.0 rows, 2085.0 cpu, 0.0 io}
HepRelVertex#61 = rel#60:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#55,expr#0..7={inputs},expr#8=400,expr#9==($t0, $t8),time_id=$t0,city=$t1,state_province=$t2,country=$t3,store_sales=$t4,store_cost=$t5,unit_sales=$t6,fact_count=$t7,$condition=$t9), rowcount=15.0, cumulative cost={65.0 rows, 1950.0 cpu, 0.0 io}
HepRelVertex#55 = rel#54:EnumerableInterpreter.ENUMERABLE.[](input=HepRelVertex#53), rowcount=100.0, cumulative cost={50.0 rows, 50.0 cpu, 0.0 io}
HepRelVertex#53 = rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
}
1199 [main] TRACE org.apache.calcite.plan.RelOptPlanner - collecting garbage
1200 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [CalcMergeRule]
1200 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#284: Apply rule [CalcMergeRule] to [rel#62:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#61,expr#0..7={inputs},time_id=$t0), rel#60:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#55,expr#0..7={inputs},expr#8=400,expr#9==($t0, $t8),time_id=$t0,city=$t1,state_province=$t2,country=$t3,store_sales=$t4,store_cost=$t5,unit_sales=$t6,fact_count=$t7,$condition=$t9)]
1200 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new EnumerableCalc#64
1201 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - call#284: Rule CalcMergeRule arguments [rel#62:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#61,expr#0..7={inputs},time_id=$t0), rel#60:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#55,expr#0..7={inputs},expr#8=400,expr#9==($t0, $t8),time_id=$t0,city=$t1,state_province=$t2,country=$t3,store_sales=$t4,store_cost=$t5,unit_sales=$t6,fact_count=$t7,$condition=$t9)] produced EnumerableCalc#64
1201 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#65
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner -
Breadth-first from root: {
HepRelVertex#65 = rel#64:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#55,expr#0..7={inputs},expr#8=400,expr#9==($t0, $t8),time_id=$t0,$condition=$t9), rowcount=15.0, cumulative cost={65.0 rows, 1250.0 cpu, 0.0 io}
HepRelVertex#55 = rel#54:EnumerableInterpreter.ENUMERABLE.[](input=HepRelVertex#53), rowcount=100.0, cumulative cost={50.0 rows, 50.0 cpu, 0.0 io}
HepRelVertex#53 = rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
}
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - collecting garbage
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [FilterCalcMergeRule]
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [ProjectCalcMergeRule]
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [FilterToCalcRule]
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [ProjectToCalcRule]
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [CalcMergeRule]
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [FilterCalcMergeRule]
1202 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [ProjectCalcMergeRule]
1202 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#64:EnumerableCalc.ENUMERABLE.[](input=HepRelVertex#55,expr#0..7={inputs},expr#8=400,expr#9==($t0, $t8),time_id=$t0,$condition=$t9)
1202 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#54:EnumerableInterpreter.ENUMERABLE.[](input=HepRelVertex#53)
1202 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])
1361 [main] TRACE org.apache.calcite.plan.RelOptPlanner - new HepRelVertex#66
1362 [main] TRACE org.apache.calcite.plan.RelOptPlanner -
Breadth-first from root: {
HepRelVertex#66 = rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997]), rowcount=100.0, cumulative cost={1.0 rows, 1.01 cpu, 0.0 io}
}
1362 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [CalcSplitRule]
1362 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [FilterTableRule]
1362 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [FilterTableRule:interpreter]
1362 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [ProjectScanRule]
1362 [main] TRACE org.apache.calcite.plan.RelOptPlanner - Applying rule set [ProjectScanRule:interpreter]
1362 [main] DEBUG org.apache.calcite.plan.RelOptPlanner - For final plan, using rel#41:BindableTableScan.BINDABLE.[](table=[source1, agg_lc_06_sales_fact_1997])
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment