Check firebird.log [no messages found for interval when this test was running]
Jump to: output_first_mismatch    outcomes_full_history    elapsed_time_chart
Show cross-report outcomes.

Annotation type Annotation details
1 @message
assert   
  + set planonly;
  + select * from test t where x = 0 plan (t natural); -- 1
  + PLAN (T NATURAL)
  + select * from v_test1 v1; -- 2
  + PLAN (V1 T INDEX (TEST_X_ASC))
  + select * from v_test1 v2; -- 3
  + PLAN (V2 T INDEX (TEST_X_ASC))
  + select * from v_test1 v1 where v1.x = 0 plan (v1 natural); -- 4
  + PLAN (V1 T NATURAL)
  + select * from v_test2 v2 where v2.x = 0 plan (v2 natural); -- 5
  + PLAN (V2 T NATURAL)
  + select * from v_test1 v1 where v1.x = 0 PLAN (V1 INDEX (TEST_X_DESC)) ; -- 6
  + PLAN (V1 T INDEX (TEST_X_DESC))
  + select * from v_test2 v2 where v2.x = 0 PLAN (V2 INDEX (TEST_X_DESC)) ; -- 7
  + PLAN (V2 T INDEX (TEST_X_DESC))
  + select * from v_test1 v1 where v1.x = 50 and v1.y = 5000 PLAN (V1 INDEX (test_x_y)) ; -- 8
  + PLAN (V1 T INDEX (TEST_X_Y))
  + select * from v_test1 v2 where v2.x = 50 and v2.y = 5000 PLAN (V2 INDEX (test_y_x)) ; -- 9
  + PLAN (V2 T INDEX (TEST_Y_X))
  + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_x_y)); -- 10
  + PLAN (V1 T INDEX (TEST_X_Y))
  + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_x_y)); -- 11
  + PLAN (V2 T INDEX (TEST_X_Y))
  + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_sum_x_y)); -- 12
  + PLAN (V1 T INDEX (TEST_SUM_X_Y))
  + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_sub_x_y)); -- 13
  + PLAN (V2 T INDEX (TEST_SUB_X_Y))
  + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
  + -- PLAN (V3 T INDEX (TEST_X_ASC))
  + select * from v_test3 v3; -- 14
  + PLAN (V3 T INDEX (TEST_X_ASC))
  + select * from v_test3 v3 plan ( v3 index(test_x_y) );
  + PLAN (V3 T INDEX (TEST_X_Y))
  + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
  + -- PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
  + select * from v_test4 v4; -- 15
  + PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
  + select * from v_test4 v4 PLAN (V4 V_TEST3 T INDEX (TEST_X_Y)); -- 16
  + PLAN (V4 V_TEST3 T INDEX (TEST_X_Y))

LOG DETAILS:

2025-06-26 18:11:02.519
2025-06-26 18:11:02.519 act = <firebird.qa.plugin.Action object at [hex]>
2025-06-26 18:11:02.519
2025-06-26 18:11:02.519     @pytest.mark.version('>=3')
2025-06-26 18:11:02.519     def test_1(act: Action):
2025-06-26 18:11:02.519         act.expected_stdout = expected_stdout
2025-06-26 18:11:02.519         act.execute()
2025-06-26 18:11:02.519 >       assert act.clean_stdout == act.clean_expected_stdout
2025-06-26 18:11:02.519 E       assert
2025-06-26 18:11:02.519 E         + set planonly;
2025-06-26 18:11:02.519 E         + select * from test t where x = 0 plan (t natural); -- 1
2025-06-26 18:11:02.519 E         + PLAN (T NATURAL)
2025-06-26 18:11:02.519 E         + select * from v_test1 v1; -- 2
2025-06-26 18:11:02.520 E         + PLAN (V1 T INDEX (TEST_X_ASC))
2025-06-26 18:11:02.520 E         + select * from v_test1 v2; -- 3
2025-06-26 18:11:02.520 E         + PLAN (V2 T INDEX (TEST_X_ASC))
2025-06-26 18:11:02.520 E         + select * from v_test1 v1 where v1.x = 0 plan (v1 natural); -- 4
2025-06-26 18:11:02.520 E         + PLAN (V1 T NATURAL)
2025-06-26 18:11:02.520 E         + select * from v_test2 v2 where v2.x = 0 plan (v2 natural); -- 5
2025-06-26 18:11:02.520 E         + PLAN (V2 T NATURAL)
2025-06-26 18:11:02.520 E         + select * from v_test1 v1 where v1.x = 0 PLAN (V1 INDEX (TEST_X_DESC)) ; -- 6
2025-06-26 18:11:02.520 E         + PLAN (V1 T INDEX (TEST_X_DESC))
2025-06-26 18:11:02.520 E         + select * from v_test2 v2 where v2.x = 0 PLAN (V2 INDEX (TEST_X_DESC)) ; -- 7
2025-06-26 18:11:02.520 E         + PLAN (V2 T INDEX (TEST_X_DESC))
2025-06-26 18:11:02.520 E         + select * from v_test1 v1 where v1.x = 50 and v1.y = 5000 PLAN (V1 INDEX (test_x_y)) ; -- 8
2025-06-26 18:11:02.520 E         + PLAN (V1 T INDEX (TEST_X_Y))
2025-06-26 18:11:02.520 E         + select * from v_test1 v2 where v2.x = 50 and v2.y = 5000 PLAN (V2 INDEX (test_y_x)) ; -- 9
2025-06-26 18:11:02.520 E         + PLAN (V2 T INDEX (TEST_Y_X))
2025-06-26 18:11:02.520 E         + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_x_y)); -- 10
2025-06-26 18:11:02.520 E         + PLAN (V1 T INDEX (TEST_X_Y))
2025-06-26 18:11:02.520 E         + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_x_y)); -- 11
2025-06-26 18:11:02.521 E         + PLAN (V2 T INDEX (TEST_X_Y))
2025-06-26 18:11:02.521 E         + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_sum_x_y)); -- 12
2025-06-26 18:11:02.521 E         + PLAN (V1 T INDEX (TEST_SUM_X_Y))
2025-06-26 18:11:02.521 E         + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_sub_x_y)); -- 13
2025-06-26 18:11:02.521 E         + PLAN (V2 T INDEX (TEST_SUB_X_Y))
2025-06-26 18:11:02.521 E         + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
2025-06-26 18:11:02.521 E         + -- PLAN (V3 T INDEX (TEST_X_ASC))
2025-06-26 18:11:02.521 E         + select * from v_test3 v3; -- 14
2025-06-26 18:11:02.521 E         + PLAN (V3 T INDEX (TEST_X_ASC))
2025-06-26 18:11:02.521 E         + select * from v_test3 v3 plan ( v3 index(test_x_y) );
2025-06-26 18:11:02.521 E         + PLAN (V3 T INDEX (TEST_X_Y))
2025-06-26 18:11:02.521 E         + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
2025-06-26 18:11:02.521 E         + -- PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
2025-06-26 18:11:02.521 E         + select * from v_test4 v4; -- 15
2025-06-26 18:11:02.521 E         + PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
2025-06-26 18:11:02.521 E         + select * from v_test4 v4 PLAN (V4 V_TEST3 T INDEX (TEST_X_Y)); -- 16
2025-06-26 18:11:02.521 E         + PLAN (V4 V_TEST3 T INDEX (TEST_X_Y))
2025-06-26 18:11:02.521
2025-06-26 18:11:02.521 tests\bugs\core_0203_test.py:124: AssertionError
2025-06-26 18:11:02.522 ---------------------------- Captured stdout setup ----------------------------
2025-06-26 18:11:02.522 Creating db: localhost:H:\QA\temp\qa2024.tmp\fbqa\test_141\test.fdb [page_size=None, sql_dialect=None, charset='NONE', user=SYSDBA, password=masterkey]
2 #text
act = <firebird.qa.plugin.Action pytest object at [hex]>

    @pytest.mark.version('>=3')
    def test_1(act: Action):
        act.expected_stdout = expected_stdout
        act.execute()
>       assert act.clean_stdout == act.clean_expected_stdout
E       assert   
E         + set planonly;
E         + select * from test t where x = 0 plan (t natural); -- 1
E         + PLAN (T NATURAL)
E         + select * from v_test1 v1; -- 2
E         + PLAN (V1 T INDEX (TEST_X_ASC))
E         + select * from v_test1 v2; -- 3
E         + PLAN (V2 T INDEX (TEST_X_ASC))
E         + select * from v_test1 v1 where v1.x = 0 plan (v1 natural); -- 4
E         + PLAN (V1 T NATURAL)
E         + select * from v_test2 v2 where v2.x = 0 plan (v2 natural); -- 5
E         + PLAN (V2 T NATURAL)
E         + select * from v_test1 v1 where v1.x = 0 PLAN (V1 INDEX (TEST_X_DESC)) ; -- 6
E         + PLAN (V1 T INDEX (TEST_X_DESC))
E         + select * from v_test2 v2 where v2.x = 0 PLAN (V2 INDEX (TEST_X_DESC)) ; -- 7
E         + PLAN (V2 T INDEX (TEST_X_DESC))
E         + select * from v_test1 v1 where v1.x = 50 and v1.y = 5000 PLAN (V1 INDEX (test_x_y)) ; -- 8
E         + PLAN (V1 T INDEX (TEST_X_Y))
E         + select * from v_test1 v2 where v2.x = 50 and v2.y = 5000 PLAN (V2 INDEX (test_y_x)) ; -- 9
E         + PLAN (V2 T INDEX (TEST_Y_X))
E         + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_x_y)); -- 10
E         + PLAN (V1 T INDEX (TEST_X_Y))
E         + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_x_y)); -- 11
E         + PLAN (V2 T INDEX (TEST_X_Y))
E         + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_sum_x_y)); -- 12
E         + PLAN (V1 T INDEX (TEST_SUM_X_Y))
E         + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_sub_x_y)); -- 13
E         + PLAN (V2 T INDEX (TEST_SUB_X_Y))
E         + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
E         + -- PLAN (V3 T INDEX (TEST_X_ASC))
E         + select * from v_test3 v3; -- 14
E         + PLAN (V3 T INDEX (TEST_X_ASC))
E         + select * from v_test3 v3 plan ( v3 index(test_x_y) );
E         + PLAN (V3 T INDEX (TEST_X_Y))
E         + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
E         + -- PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
E         + select * from v_test4 v4; -- 15
E         + PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
E         + select * from v_test4 v4 PLAN (V4 V_TEST3 T INDEX (TEST_X_Y)); -- 16
E         + PLAN (V4 V_TEST3 T INDEX (TEST_X_Y))

tests\bugs\core_0203_test.py:124: AssertionError
Full history of outcomes and elapsed time, ms:
NN SNAP_INFO CS_outcome SS_outcome CS_run_time SS_run_time CS_run_beg CS_run_end SS_run_beg SS_run_end
1 3.0.13.33809 2025.05.14 6638e F F 1140 747 2025.06.26 14:30:57.103 2025.06.26 14:30:58.243 2025.06.26 14:00:50.914 2025.06.26 14:00:51.661
2 3.0.13.33809 2025.05.06 28ad0 P P 672 420 2025.05.14 07:54:18.585 2025.05.14 07:54:19.257 2025.05.14 07:24:00.627 2025.05.14 07:24:01.047
3 3.0.13.33808 2025.04.25 28426 P P 663 450 2025.05.06 13:06:54.923 2025.05.06 13:06:55.586 2025.05.06 12:38:11.305 2025.05.06 12:38:11.755
4 3.0.13.33803 2025.04.23 307b8 P P 663 409 2025.04.25 13:15:26.222 2025.04.25 13:15:26.885 2025.04.25 12:46:36.513 2025.04.25 12:46:36.922
5 3.0.13.33803 2025.03.25 ea22a P P 672 418 2025.04.20 07:46:47.727 2025.04.20 07:46:48.399 2025.04.20 06:56:12.243 2025.04.20 06:56:12.661
6 3.0.13.33803 2025.02.25 08ebd P P 703 446 2025.03.25 10:01:25.643 2025.03.25 10:01:26.346 2025.03.25 09:09:58.946 2025.03.25 09:09:59.392
7 3.0.13.33796 2025.01.29 0ab85 P P 659 405 2025.02.25 11:52:38.647 2025.02.25 11:52:39.306 2025.02.25 11:22:37.464 2025.02.25 11:22:37.869
8 3.0.13.33796 2025.01.14 99b3b P P 662 396 2025.01.24 10:57:26.279 2025.01.24 10:57:26.941 2025.01.24 10:28:35.647 2025.01.24 10:28:36.043
9 3.0.13.33795 2024.12.13 fbbd9 P P 705 409 2025.01.01 12:08:02.016 2025.01.01 12:08:02.721 2025.01.01 11:39:00.844 2025.01.01 11:39:01.253
10 3.0.13.33795 2024.11.24 b8847 P P 689 405 2024.12.11 12:05:59.607 2024.12.11 12:06:00.296 2024.12.11 11:36:57.309 2024.12.11 11:36:57.714
11 3.0.13.33794 2024.10.15 abe09 P P 715 411 2024.11.22 11:42:19.770 2024.11.22 11:42:20.485 2024.11.22 11:13:04.618 2024.11.22 11:13:05.029
12 3.0.13.33793 2024.10.14 f831a P P 662 413 2024.10.15 12:09:38.528 2024.10.15 12:09:39.190 2024.10.15 11:40:36.884 2024.10.15 11:40:37.297
13 3.0.13.33793 2024.10.04 82ccc P P 676 414 2024.10.12 12:08:58.652 2024.10.12 12:08:59.328 2024.10.12 11:40:00.625 2024.10.12 11:40:01.039
14 3.0.13.33792 2024.08.31 d8791 P P 662 412 2024.10.03 12:16:17.694 2024.10.03 12:16:18.356 2024.10.03 11:46:32.912 2024.10.03 11:46:33.324
15 3.0.13.33787 2024.08.23 8ee81 P P 713 456 2024.09.01 12:24:21.438 2024.09.01 12:24:22.151 2024.09.01 11:52:20.194 2024.09.01 11:52:20.650
16 3.0.13.33787 2024.08.09 df740 P P 762 479 2024.08.23 12:21:04.311 2024.08.23 12:21:05.073 2024.08.23 11:48:58.787 2024.08.23 11:48:59.266
17 3.0.12.33746 2024.07.15 11dd4 P P 753 482 2024.08.09 11:41:21.899 2024.08.09 11:41:22.652 2024.08.09 11:09:23.694 2024.08.09 11:09:24.176
18 3.0.12.33746 2024.06.11 8a5eb P P 576 374 2024.07.15 10:37:41.844 2024.07.15 10:37:42.420 2024.07.15 10:09:55.320 2024.07.15 10:09:55.694
19 3.0.12.33745 2024.05.21 301a7 P P 531 266 2024.05.25 07:36:33.548 2024.05.25 07:36:34.079 2024.05.25 07:12:04.274 2024.05.25 07:12:04.540
20 3.0.12.33745 2024.05.09 9cf37 P P 531 268 2024.05.21 07:36:34.427 2024.05.21 07:36:34.958 2024.05.21 07:11:50.416 2024.05.21 07:11:50.684
21 3.0.12.33744 2024.04.20 af6b2 P P 515 266 2024.05.11 07:33:26.070 2024.05.11 07:33:26.585 2024.05.11 07:09:31.520 2024.05.11 07:09:31.786
22 3.0.12.33740 2024.04.06 c6cdd P P 547 266 2024.04.21 01:47:58.656 2024.04.21 01:47:59.203 2024.04.21 01:24:28.393 2024.04.21 01:24:28.659
23 3.0.12.33726 2024.03.29 1fac6 P P 531 266 2024.04.05 06:43:54.959 2024.04.05 06:43:55.490 2024.04.05 06:20:44.184 2024.04.05 06:20:44.450
24 3.0.12.33726 2024.03.11 456ca P P 483 265 2024.03.29 12:26:10.092 2024.03.29 12:26:10.575 2024.03.29 12:03:01.150 2024.03.29 12:03:01.415

Elapsed time, ms. Chart for last 24 runs:

Last commits information (all timestamps in UTC):