No output when using EXPLAIN via ODBC

[bucweat]

Trying to use EXPLAIN a query in ODBC. If I run a select query it generates the expected output, if I add EXPLAIN to the front I get no output. If I turn profiling on (e.g. SET enable_profiling = 'query_tree';) then I get the expected profiling output including treees. When run from command line client, EXPLAIN works as expected.

Running ODBC driver version v1.3.2.0 on Windows from C# console app.

Originally reported on Discord tagging @staticlibs who I hope is @alexk.

I’m happy to help debug…I used to have a Cmake file that would build VS2022 project where ODBC driver is compiled in so that debugger can be used but that was before ODBC driver was split out of main project. I might try to revisit that if devs don’t find anything obvious.

[bucweat]

Update: seeing the same result as with C# when running query from vbscript. Profiling is visible when turned on, but explain output is not.

Here is example sql script that can be used to illustrate:

.echo on
.timer on

-- SET explain_output = 'physical_only';
-- SET explain_output = 'optimized_only';
SET explain_output = 'all';

SET enable_profiling = 'no_output';
-- SET enable_profiling = 'json';
-- SET enable_profiling = 'query_tree';
-- SET enable_profiling = 'query_tree_optimizer';

-- SET profiling_mode = 'standard';
SET profiling_mode = 'detailed';

CREATE OR REPLACE TABLE foo (foo1 int, foo2 int);

INSERT INTO foo SELECT i, i+15799 from generate_series(1, 100000) AS t(i);

CREATE OR REPLACE TABLE bar (bar1 int, bar2 int);

INSERT INTO bar SELECT i, i+15799 FROM generate_series(1, 100000) AS t(i);

ANALYZE;

EXPLAIN SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

PRAGMA disable_optimizer;

EXPLAIN SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

SET enable_profiling = 'no_output';

PRAGMA enable_optimizer;

SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

Copy the above to explain.sql and run with duckdb .\test.db < .\explain.sql. Output is:

.timer on

-- SET explain_output = 'physical_only';
-- SET explain_output = 'optimized_only';
SET explain_output = 'all';
Run Time (s): real 0.002 user 0.000000 sys 0.000000

SET enable_profiling = 'no_output';
Run Time (s): real 0.001 user 0.000000 sys 0.000000
-- SET enable_profiling = 'json';
-- SET enable_profiling = 'query_tree';
-- SET enable_profiling = 'query_tree_optimizer';

-- SET profiling_mode = 'standard';
SET profiling_mode = 'detailed';
Run Time (s): real 0.002 user 0.000000 sys 0.000000


CREATE OR REPLACE TABLE foo (foo1 int, foo2 int);
Run Time (s): real 0.018 user 0.000000 sys 0.000000

INSERT INTO foo SELECT i, i+15799 from generate_series(1, 100000) AS t(i);
Run Time (s): real 0.057 user 0.046875 sys 0.000000

CREATE OR REPLACE TABLE bar (bar1 int, bar2 int);
Run Time (s): real 0.002 user 0.000000 sys 0.000000

INSERT INTO bar SELECT i, i+15799 FROM generate_series(1, 100000) AS t(i);
Run Time (s): real 0.039 user 0.000000 sys 0.000000

ANALYZE;
Run Time (s): real 0.001 user 0.000000 sys 0.000000

EXPLAIN SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

┌─────────────────────────────┐
│┌───────────────────────────┐│
││ Unoptimized Logical Plan  ││
│└───────────────────────────┘│
└─────────────────────────────┘
┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│        Expressions:       │
│       (foo1 = bar1)       │
│ (foo1 < CAST(50 AS INTEGER│
│             ))            │
│ (bar2 > CAST(25 AS INTEGER│
│             ))            │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       │
│    ────────────────────   ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
└───────────────────────────┘└───────────────────────────┘

┌─────────────────────────────┐
│┌───────────────────────────┐│
││  Optimized Logical Plan   ││
│└───────────────────────────┘│
└─────────────────────────────┘
┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
│                           │
│         ~5690 Rows        │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│      COMPARISON_JOIN      │
│    ────────────────────   │
│      Join Type: INNER     │
│                           │
│        Conditions:        ├──────────────┐
│       (bar1 = foo1)       │              │
│                           │              │
│         ~5690 Rows        │              │
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│      Filters: bar1<50     ││      Filters: foo1<50     │
│         Table: bar        ││         Table: foo        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
│                           ││                           │
│        ~20000 Rows        ││        ~20000 Rows        │
└───────────────────────────┘└───────────────────────────┘

┌─────────────────────────────┐
│┌───────────────────────────┐│
││       Physical Plan       ││
│└───────────────────────────┘│
└─────────────────────────────┘
┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│            foo1           │
│            bar2           │
│                           │
│         ~5690 Rows        │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│         HASH_JOIN         │
│    ────────────────────   │
│      Join Type: INNER     │
│                           │
│        Conditions:        ├──────────────┐
│        bar1 = foo1        │              │
│                           │              │
│         ~5690 Rows        │              │
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│         SEQ_SCAN          ││         SEQ_SCAN          │
│    ────────────────────   ││    ────────────────────   │
│         Table: bar        ││         Table: foo        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
│                           ││     Projections: foo1     │
│        Projections:       ││      Filters: foo1<50     │
│            bar1           ││                           │
│            bar2           ││                           │
│                           ││                           │
│      Filters: bar1<50     ││                           │
│                           ││                           │
│        ~20000 Rows        ││        ~20000 Rows        │
└───────────────────────────┘└───────────────────────────┘
Run Time (s): real 0.010 user 0.000000 sys 0.000000

SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
┌───────┬───────┐
│ foo1  │ bar2  │
│ int32 │ int32 │
├───────┼───────┤
│     1 │ 15800 │
│     2 │ 15801 │
│     3 │ 15802 │
│     4 │ 15803 │
│     5 │ 15804 │
│     6 │ 15805 │
│     7 │ 15806 │
│     8 │ 15807 │
│     9 │ 15808 │
│    10 │ 15809 │
│    11 │ 15810 │
│    12 │ 15811 │
│    13 │ 15812 │
│    14 │ 15813 │
│    15 │ 15814 │
│    16 │ 15815 │
│    17 │ 15816 │
│    18 │ 15817 │
│    19 │ 15818 │
│    20 │ 15819 │
│     · │   ·   │
│     · │   ·   │
│     · │   ·   │
│    30 │ 15829 │
│    31 │ 15830 │
│    32 │ 15831 │
│    33 │ 15832 │
│    34 │ 15833 │
│    35 │ 15834 │
│    36 │ 15835 │
│    37 │ 15836 │
│    38 │ 15837 │
│    39 │ 15838 │
│    40 │ 15839 │
│    41 │ 15840 │
│    42 │ 15841 │
│    43 │ 15842 │
│    44 │ 15843 │
│    45 │ 15844 │
│    46 │ 15845 │
│    47 │ 15846 │
│    48 │ 15847 │
│    49 │ 15848 │
├───────┴───────┤
│    49 rows    │
│  (40 shown)   │
└───────────────┘
Run Time (s): real 0.008 user 0.000000 sys 0.000000

PRAGMA disable_optimizer;
┌─────────┐
│ Success │
│ boolean │
├─────────┤
│ 0 rows  │
└─────────┘
Run Time (s): real 0.001 user 0.000000 sys 0.000000

EXPLAIN SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;

┌─────────────────────────────┐
│┌───────────────────────────┐│
││ Unoptimized Logical Plan  ││
│└───────────────────────────┘│
└─────────────────────────────┘
┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│        Expressions:       │
│       (foo1 = bar1)       │
│ (foo1 < CAST(50 AS INTEGER│
│             ))            │
│ (bar2 > CAST(25 AS INTEGER│
│             ))            │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       │
│    ────────────────────   ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
└───────────────────────────┘└───────────────────────────┘

┌─────────────────────────────┐
│┌───────────────────────────┐│
││  Optimized Logical Plan   ││
│└───────────────────────────┘│
└─────────────────────────────┘
┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│        Expressions:       │
│       (foo1 = bar1)       │
│ (foo1 < CAST(50 AS INTEGER│
│             ))            │
│ (bar2 > CAST(25 AS INTEGER│
│             ))            │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       │
│    ────────────────────   ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
└───────────────────────────┘└───────────────────────────┘

┌─────────────────────────────┐
│┌───────────────────────────┐│
││       Physical Plan       ││
│└───────────────────────────┘│
└─────────────────────────────┘
┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│            foo1           │
│            bar2           │
│                           │
│          ~0 Rows          │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│ ((foo1 = bar1) AND (foo1 <│
│  CAST(50 AS INTEGER)) AND │
│ (bar2 > CAST(25 AS INTEGER│
│            )))            │
│                           │
│          ~0 Rows          │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│         SEQ_SCAN          ││         SEQ_SCAN          │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
│                           ││                           │
│          ~0 Rows          ││          ~0 Rows          │
└───────────────────────────┘└───────────────────────────┘
Run Time (s): real 0.003 user 0.000000 sys 0.000000

SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
┌───────┬───────┐
│ foo1  │ bar2  │
│ int32 │ int32 │
├───────┼───────┤
│     1 │ 15800 │
│     2 │ 15801 │
│     3 │ 15802 │
│     4 │ 15803 │
│     5 │ 15804 │
│     6 │ 15805 │
│     7 │ 15806 │
│     8 │ 15807 │
│     9 │ 15808 │
│    10 │ 15809 │
│    11 │ 15810 │
│    12 │ 15811 │
│    13 │ 15812 │
│    14 │ 15813 │
│    15 │ 15814 │
│    16 │ 15815 │
│    17 │ 15816 │
│    18 │ 15817 │
│    19 │ 15818 │
│    20 │ 15819 │
│     · │   ·   │
│     · │   ·   │
│     · │   ·   │
│    30 │ 15829 │
│    31 │ 15830 │
│    32 │ 15831 │
│    33 │ 15832 │
│    34 │ 15833 │
│    35 │ 15834 │
│    36 │ 15835 │
│    37 │ 15836 │
│    38 │ 15837 │
│    39 │ 15838 │
│    40 │ 15839 │
│    41 │ 15840 │
│    42 │ 15841 │
│    43 │ 15842 │
│    44 │ 15843 │
│    45 │ 15844 │
│    46 │ 15845 │
│    47 │ 15846 │
│    48 │ 15847 │
│    49 │ 15848 │
├───────┴───────┤
│    49 rows    │
│  (40 shown)   │
└───────────────┘
Run Time (s): real 38.795 user 75.515625 sys 0.500000

SET enable_profiling = 'no_output';
Run Time (s): real 0.001 user 0.000000 sys 0.000000

PRAGMA enable_optimizer;
┌─────────┐
│ Success │
│ boolean │
├─────────┤
│ 0 rows  │
└─────────┘
Run Time (s): real 0.000 user 0.000000 sys 0.000000

SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
┌───────┬───────┐
│ foo1  │ bar2  │
│ int32 │ int32 │
├───────┼───────┤
│     1 │ 15800 │
│     2 │ 15801 │
│     3 │ 15802 │
│     4 │ 15803 │
│     5 │ 15804 │
│     6 │ 15805 │
│     7 │ 15806 │
│     8 │ 15807 │
│     9 │ 15808 │
│    10 │ 15809 │
│    11 │ 15810 │
│    12 │ 15811 │
│    13 │ 15812 │
│    14 │ 15813 │
│    15 │ 15814 │
│    16 │ 15815 │
│    17 │ 15816 │
│    18 │ 15817 │
│    19 │ 15818 │
│    20 │ 15819 │
│     · │   ·   │
│     · │   ·   │
│     · │   ·   │
│    30 │ 15829 │
│    31 │ 15830 │
│    32 │ 15831 │
│    33 │ 15832 │
│    34 │ 15833 │
│    35 │ 15834 │
│    36 │ 15835 │
│    37 │ 15836 │
│    38 │ 15837 │
│    39 │ 15838 │
│    40 │ 15839 │
│    41 │ 15840 │
│    42 │ 15841 │
│    43 │ 15842 │
│    44 │ 15843 │
│    45 │ 15844 │
│    46 │ 15845 │
│    47 │ 15846 │
│    48 │ 15847 │
│    49 │ 15848 │
├───────┴───────┤
│    49 rows    │
│  (40 shown)   │
└───────────────┘
Run Time (s): real 0.002 user 0.000000 sys 0.000000

When I run this .sql file through either my C# or vbscript both of which use DuckDBODBC, I get no output from statements with EXPLAIN.

[staticlibs]

@bucweat

Hi, thanks for the report! This should be fixed by #241.

[bucweat]

Sorry it took a bit to verify the fix...I was looking for the cool guy way of getting the pull request into my fork...but could not figure it out. So I manually edited prepared.cpp and rebuilt and yes it appears to work now...THANK YOU :-)

Looks like the checks passed so hopefully this gets merged...

Here is the output from my C# ODBC test program that runs the SQL script I provided above:

processing G:\csharp_DotNet8_ODBC\bin\Debug\net8.0\sql\duckdb\optimize.sql...
***** Deleted G:\csharp_DotNet8_ODBC\bin\Debug\net8.0\db\test.db
bHaveConnStr True --> *** duckdb *** G:\csharp_DotNet8_ODBC\bin\Debug\net8.0\db\test.db
False query --> SET explain_output = 'all';
TIMER: 15 milliseconds  returned -1
False query --> SET enable_profiling = 'no_output';
TIMER: 2 milliseconds  returned -1
False query --> SET profiling_mode = 'standard';
TIMER: 1 millisecond  returned -1
False query --> CREATE OR REPLACE TABLE foo (foo1 int, foo2 int);
TIMER: 19 milliseconds  returned -1
False query --> INSERT INTO foo SELECT i, i+15799 from generate_series(1, 100000) AS t(i);
TIMER: 71 milliseconds  returned 1
False query --> CREATE OR REPLACE TABLE bar (bar1 int, bar2 int);
TIMER: 2 milliseconds  returned -1
False query --> INSERT INTO bar SELECT i, i+15799 FROM generate_series(1, 100000) AS t(i);
TIMER: 36 milliseconds  returned 1
True query --> ANALYZE;
TIMER: 5 milliseconds
True query --> EXPLAIN SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
TIMER: 7 milliseconds
RESULT:explain_key,explain_value
RESULT:logical_plan,┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│        Expressions:       │
│       (foo1 = bar1)       │
│ (foo1 < CAST(50 AS INTEGER│
│             ))            │
│ (bar2 > CAST(25 AS INTEGER│
│             ))            │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       │
│    ────────────────────   ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
└───────────────────────────┘└───────────────────────────┘

RESULT:logical_opt,┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
│                           │
│        ~5,690 rows        │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│      COMPARISON_JOIN      │
│    ────────────────────   │
│      Join Type: INNER     │
│                           │
│        Conditions:        ├──────────────┐
│       (bar1 = foo1)       │              │
│                           │              │
│        ~5,690 rows        │              │
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│      Filters: bar1<50     ││      Filters: foo1<50     │
│         Table: bar        ││         Table: foo        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
│                           ││                           │
│        ~20,000 rows       ││        ~20,000 rows       │
└───────────────────────────┘└───────────────────────────┘

RESULT:physical_plan,┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│            foo1           │
│            bar2           │
│                           │
│        ~5,690 rows        │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│         HASH_JOIN         │
│    ────────────────────   │
│      Join Type: INNER     │
│                           │
│        Conditions:        ├──────────────┐
│        bar1 = foo1        │              │
│                           │              │
│        ~5,690 rows        │              │
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│         SEQ_SCAN          ││         SEQ_SCAN          │
│    ────────────────────   ││    ────────────────────   │
│         Table: bar        ││         Table: foo        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
│                           ││     Projections: foo1     │
│        Projections:       ││      Filters: foo1<50     │
│            bar1           ││                           │
│            bar2           ││                           │
│                           ││                           │
│      Filters: bar1<50     ││                           │
│                           ││                           │
│        ~20,000 rows       ││        ~20,000 rows       │
└───────────────────────────┘└───────────────────────────┘

True query --> SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
TIMER: 9 milliseconds
RESULT:foo1,bar2
RESULT:1,15800
RESULT:2,15801
RESULT:3,15802
RESULT:4,15803
RESULT:5,15804
RESULT:6,15805
RESULT:7,15806
RESULT:8,15807
RESULT:9,15808
RESULT:10,15809
RESULT:11,15810
RESULT:12,15811
RESULT:13,15812
RESULT:14,15813
RESULT:15,15814
RESULT:16,15815
RESULT:17,15816
RESULT:18,15817
RESULT:19,15818
RESULT:20,15819
RESULT:21,15820
RESULT:22,15821
RESULT:23,15822
RESULT:24,15823
RESULT:25,15824
RESULT:26,15825
RESULT:27,15826
RESULT:28,15827
RESULT:29,15828
RESULT:30,15829
RESULT:31,15830
RESULT:32,15831
RESULT:33,15832
RESULT:34,15833
RESULT:35,15834
RESULT:36,15835
RESULT:37,15836
RESULT:38,15837
RESULT:39,15838
RESULT:40,15839
RESULT:41,15840
RESULT:42,15841
RESULT:43,15842
RESULT:44,15843
RESULT:45,15844
RESULT:46,15845
RESULT:47,15846
RESULT:48,15847
RESULT:49,15848
True query --> PRAGMA disable_optimizer;
TIMER:
True query --> EXPLAIN SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
TIMER: 2 milliseconds
RESULT:explain_key,explain_value
RESULT:logical_plan,┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│        Expressions:       │
│       (foo1 = bar1)       │
│ (foo1 < CAST(50 AS INTEGER│
│             ))            │
│ (bar2 > CAST(25 AS INTEGER│
│             ))            │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       │
│    ────────────────────   ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
└───────────────────────────┘└───────────────────────────┘

RESULT:logical_opt,┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│        Expressions:       │
│            foo1           │
│            bar2           │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│        Expressions:       │
│       (foo1 = bar1)       │
│ (foo1 < CAST(50 AS INTEGER│
│             ))            │
│ (bar2 > CAST(25 AS INTEGER│
│             ))            │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       │
│    ────────────────────   ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│          SEQ_SCAN         ││          SEQ_SCAN         │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
└───────────────────────────┘└───────────────────────────┘

RESULT:physical_plan,┌───────────────────────────┐
│         PROJECTION        │
│    ────────────────────   │
│            foo1           │
│            bar2           │
│                           │
│          ~0 rows          │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│           FILTER          │
│    ────────────────────   │
│ ((foo1 = bar1) AND (foo1 <│
│  CAST(50 AS INTEGER)) AND │
│ (bar2 > CAST(25 AS INTEGER│
│            )))            │
│                           │
│          ~0 rows          │
└─────────────┬─────────────┘
┌─────────────┴─────────────┐
│       CROSS_PRODUCT       ├──────────────┐
└─────────────┬─────────────┘              │
┌─────────────┴─────────────┐┌─────────────┴─────────────┐
│         SEQ_SCAN          ││         SEQ_SCAN          │
│    ────────────────────   ││    ────────────────────   │
│         Table: foo        ││         Table: bar        │
│   Type: Sequential Scan   ││   Type: Sequential Scan   │
│                           ││                           │
│          ~0 rows          ││          ~0 rows          │
└───────────────────────────┘└───────────────────────────┘

True query --> SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
TIMER: 36 seconds 621 milliseconds
RESULT:foo1,bar2
RESULT:1,15800
RESULT:2,15801
RESULT:3,15802
RESULT:4,15803
RESULT:5,15804
RESULT:6,15805
RESULT:7,15806
RESULT:8,15807
RESULT:9,15808
RESULT:10,15809
RESULT:11,15810
RESULT:12,15811
RESULT:13,15812
RESULT:14,15813
RESULT:15,15814
RESULT:16,15815
RESULT:17,15816
RESULT:18,15817
RESULT:19,15818
RESULT:20,15819
RESULT:21,15820
RESULT:22,15821
RESULT:23,15822
RESULT:24,15823
RESULT:25,15824
RESULT:26,15825
RESULT:27,15826
RESULT:28,15827
RESULT:29,15828
RESULT:30,15829
RESULT:31,15830
RESULT:32,15831
RESULT:33,15832
RESULT:34,15833
RESULT:35,15834
RESULT:36,15835
RESULT:37,15836
RESULT:38,15837
RESULT:39,15838
RESULT:40,15839
RESULT:41,15840
RESULT:42,15841
RESULT:43,15842
RESULT:44,15843
RESULT:45,15844
RESULT:46,15845
RESULT:47,15846
RESULT:48,15847
RESULT:49,15848
False query --> SET enable_profiling = 'no_output';
TIMER:  returned -1
True query --> PRAGMA enable_optimizer;
TIMER:
True query --> SELECT foo1, bar2 FROM foo, bar WHERE foo1 = bar1 and foo1 < 50 and bar2 > 25;
TIMER: 2 milliseconds
RESULT:foo1,bar2
RESULT:1,15800
RESULT:2,15801
RESULT:3,15802
RESULT:4,15803
RESULT:5,15804
RESULT:6,15805
RESULT:7,15806
RESULT:8,15807
RESULT:9,15808
RESULT:10,15809
RESULT:11,15810
RESULT:12,15811
RESULT:13,15812
RESULT:14,15813
RESULT:15,15814
RESULT:16,15815
RESULT:17,15816
RESULT:18,15817
RESULT:19,15818
RESULT:20,15819
RESULT:21,15820
RESULT:22,15821
RESULT:23,15822
RESULT:24,15823
RESULT:25,15824
RESULT:26,15825
RESULT:27,15826
RESULT:28,15827
RESULT:29,15828
RESULT:30,15829
RESULT:31,15830
RESULT:32,15831
RESULT:33,15832
RESULT:34,15833
RESULT:35,15834
RESULT:36,15835
RESULT:37,15836
RESULT:38,15837
RESULT:39,15838
RESULT:40,15839
RESULT:41,15840
RESULT:42,15841
RESULT:43,15842
RESULT:44,15843
RESULT:45,15844
RESULT:46,15845
RESULT:47,15846
RESULT:48,15847
RESULT:49,15848

Complete. Error count: 0

[staticlibs]

@bucweat

Thanks for verifying! Yes, this is going to be included into 1.4.1.0 update next week.