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
2 @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-07-02 14:08:05.910
2025-07-02 14:08:05.915 act = <firebird.qa.plugin.Action object at [hex]>
2025-07-02 14:08:05.919
2025-07-02 14:08:05.924 @pytest.mark.version('>=3')
2025-07-02 14:08:05.928 def test_1(act: Action):
2025-07-02 14:08:05.933 act.expected_stdout = expected_stdout
2025-07-02 14:08:05.938 act.execute()
2025-07-02 14:08:05.945 >       assert act.clean_stdout == act.clean_expected_stdout
2025-07-02 14:08:05.951 E       assert
2025-07-02 14:08:05.956 E         + set planonly;
2025-07-02 14:08:05.961 E         + select * from test t where x = 0 plan (t natural); -- 1
2025-07-02 14:08:05.965 E         + PLAN (T NATURAL)
2025-07-02 14:08:05.969 E         + select * from v_test1 v1; -- 2
2025-07-02 14:08:05.974 E         + PLAN (V1 T INDEX (TEST_X_ASC))
2025-07-02 14:08:05.979 E         + select * from v_test1 v2; -- 3
2025-07-02 14:08:05.983 E         + PLAN (V2 T INDEX (TEST_X_ASC))
2025-07-02 14:08:05.988 E         + select * from v_test1 v1 where v1.x = 0 plan (v1 natural); -- 4
2025-07-02 14:08:05.992 E         + PLAN (V1 T NATURAL)
2025-07-02 14:08:05.997 E         + select * from v_test2 v2 where v2.x = 0 plan (v2 natural); -- 5
2025-07-02 14:08:06.001 E         + PLAN (V2 T NATURAL)
2025-07-02 14:08:06.006 E         + select * from v_test1 v1 where v1.x = 0 PLAN (V1 INDEX (TEST_X_DESC)) ; -- 6
2025-07-02 14:08:06.010 E         + PLAN (V1 T INDEX (TEST_X_DESC))
2025-07-02 14:08:06.015 E         + select * from v_test2 v2 where v2.x = 0 PLAN (V2 INDEX (TEST_X_DESC)) ; -- 7
2025-07-02 14:08:06.019 E         + PLAN (V2 T INDEX (TEST_X_DESC))
2025-07-02 14:08:06.024 E         + select * from v_test1 v1 where v1.x = 50 and v1.y = 5000 PLAN (V1 INDEX (test_x_y)) ; -- 8
2025-07-02 14:08:06.029 E         + PLAN (V1 T INDEX (TEST_X_Y))
2025-07-02 14:08:06.033 E         + select * from v_test1 v2 where v2.x = 50 and v2.y = 5000 PLAN (V2 INDEX (test_y_x)) ; -- 9
2025-07-02 14:08:06.038 E         + PLAN (V2 T INDEX (TEST_Y_X))
2025-07-02 14:08:06.042 E         + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_x_y)); -- 10
2025-07-02 14:08:06.047 E         + PLAN (V1 T INDEX (TEST_X_Y))
2025-07-02 14:08:06.051 E         + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_x_y)); -- 11
2025-07-02 14:08:06.056 E         + PLAN (V2 T INDEX (TEST_X_Y))
2025-07-02 14:08:06.061 E         + select * from v_test1 v1 where v1.x + v1.y = 1000 PLAN (V1 INDEX (test_sum_x_y)); -- 12
2025-07-02 14:08:06.065 E         + PLAN (V1 T INDEX (TEST_SUM_X_Y))
2025-07-02 14:08:06.070 E         + select * from v_test2 v2 where v2.x - v2.y = 1000 PLAN (V2 INDEX (test_sub_x_y)); -- 13
2025-07-02 14:08:06.074 E         + PLAN (V2 T INDEX (TEST_SUB_X_Y))
2025-07-02 14:08:06.078 E         + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
2025-07-02 14:08:06.083 E         + -- PLAN (V3 T INDEX (TEST_X_ASC))
2025-07-02 14:08:06.087 E         + select * from v_test3 v3; -- 14
2025-07-02 14:08:06.092 E         + PLAN (V3 T INDEX (TEST_X_ASC))
2025-07-02 14:08:06.096 E         + select * from v_test3 v3 plan ( v3 index(test_x_y) );
2025-07-02 14:08:06.101 E         + PLAN (V3 T INDEX (TEST_X_Y))
2025-07-02 14:08:06.105 E         + -- NB: here optimizer will use index __NOT__ from view V3 DDL:
2025-07-02 14:08:06.110 E         + -- PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
2025-07-02 14:08:06.114 E         + select * from v_test4 v4; -- 15
2025-07-02 14:08:06.118 E         + PLAN (V4 V_TEST3 T INDEX (TEST_X_ASC))
2025-07-02 14:08:06.123 E         + select * from v_test4 v4 PLAN (V4 V_TEST3 T INDEX (TEST_X_Y)); -- 16
2025-07-02 14:08:06.127 E         + PLAN (V4 V_TEST3 T INDEX (TEST_X_Y))
2025-07-02 14:08:06.131
2025-07-02 14:08:06.136 tests/bugs/core_0203_test.py:124: AssertionError
2025-07-02 14:08:06.140 ---------------------------- Captured stdout setup -----------------------------
2025-07-02 14:08:06.145 Creating db: localhost:/var/tmp/qa_2024/test_141/test.fdb [page_size=None, sql_dialect=None, charset='NONE', user=SYSDBA, password=masterkey]
3 #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.33814 2025.06.21 85255 F F 1117 845 2025.07.02 10:11:44.081 2025.07.02 10:11:45.198 2025.07.02 09:30:14.661 2025.07.02 09:30:15.506
2 3.0.13.33813 2025.06.14 222a9 P P 779 582 2025.06.20 03:24:36.057 2025.06.20 03:24:36.836 2025.06.20 02:45:27.935 2025.06.20 02:45:28.517
3 3.0.13.33811 2025.05.07 16491 P P 827 626 2025.06.14 09:52:32.883 2025.06.14 09:52:33.710 2025.06.14 09:13:11.832 2025.06.14 09:13:12.458
4 3.0.13.33810 2025.05.06 02b1d P P 1047 623 2025.05.07 08:15:21.120 2025.05.07 08:15:22.167 2025.05.07 07:30:15.303 2025.05.07 07:30:15.926
5 3.0.13.33809 2025.05.05 4ec6d P P 1071 703 2025.05.06 08:21:16.584 2025.05.06 08:21:17.655 2025.05.06 07:36:09.264 2025.05.06 07:36:09.967
6 3.0.13.33808 2025.04.18 bf513 P P 931 698 2025.05.04 22:02:18.967 2025.05.04 22:02:19.898 2025.05.04 21:17:01.069 2025.05.04 21:17:01.767
7 3.0.13.33807 2025.04.14 73e94 P P 1040 625 2025.04.18 08:13:55.619 2025.04.18 08:13:56.659 2025.04.18 07:28:32.152 2025.04.18 07:28:32.777
8 3.0.13.33806 2025.03.26 b6cfe P P 932 683 2025.04.14 07:10:25.438 2025.04.14 07:10:26.370 2025.04.14 06:28:58.801 2025.04.14 06:28:59.484
9 3.0.13.33805 2025.03.17 98320 P P 888 597 2025.03.25 04:35:13.268 2025.03.25 04:35:14.156 2025.03.25 03:55:01.406 2025.03.25 03:55:02.003
10 3.0.13.33804 2025.02.25 1439d P P 803 509 2025.03.17 04:42:05.187 2025.03.17 04:42:05.990 2025.03.17 03:56:22.008 2025.03.17 03:56:22.517
11 3.0.13.33803 2025.01.29 f1848 P P 863 488 2025.02.25 07:22:16.579 2025.02.25 07:22:17.442 2025.02.25 06:38:57.811 2025.02.25 06:38:58.299
12 3.0.13.33802 2025.01.28 650bd P P 785 496 2025.01.29 22:00:30.634 2025.01.29 22:00:31.419 2025.01.29 21:16:13.801 2025.01.29 21:16:14.297
13 3.0.13.33800 2025.01.20 f20ab P P 887 528 2025.01.28 07:37:26.076 2025.01.28 07:37:26.963 2025.01.28 06:51:45.853 2025.01.28 06:51:46.381
14 3.0.13.33798 2025.01.16 0c3bb P P 845 509 2025.01.20 07:09:53.646 2025.01.20 07:09:54.491 2025.01.20 06:25:21.738 2025.01.20 06:25:22.247
15 3.0.13.33795 2024.12.23 1bf0b P P 813 482 2025.01.16 07:07:53.417 2025.01.16 07:07:54.230 2025.01.16 06:23:50.911 2025.01.16 06:23:51.393
16 3.0.13.33794 2024.10.23 e2a6b P P 613 372 2024.12.23 00:59:00.239 2024.12.23 00:59:00.852 2024.12.23 00:24:21.999 2024.12.23 00:24:22.371
17 3.0.13.33793 2024.09.02 3e627 P P 777 457 2024.10.23 07:01:06.614 2024.10.23 07:01:07.391 2024.10.23 06:23:29.544 2024.10.23 06:23:30.001
18 3.0.13.33792 2024.08.30 d9f38 P P 1067 1318 2024.09.02 09:56:44.380 2024.09.02 09:56:45.447 2024.09.02 08:43:58.664 2024.09.02 08:43:59.982
19 3.0.13.33791 2024.08.21 c8a36 P P 1381 1067 2024.08.30 09:40:45.431 2024.08.30 09:40:46.812 2024.08.30 08:29:19.569 2024.08.30 08:29:20.636
20 3.0.13.33790 2024.08.20 3bf52 P P 1433 863 2024.08.21 09:12:13.691 2024.08.21 09:12:15.124 2024.08.21 08:09:23.499 2024.08.21 08:09:24.362
21 3.0.13.33789 2024.08.09 7933a P P 885 603 2024.08.19 05:46:50.554 2024.08.19 05:46:51.439 2024.08.19 05:01:48.648 2024.08.19 05:01:49.251
22 3.0.12.33787 2024.08.06 bf180 P P 976 575 2024.08.09 05:34:08.340 2024.08.09 05:34:09.316 2024.08.09 04:49:30.777 2024.08.09 04:49:31.352
23 3.0.12.33784 2024.08.01 cd857 P P 624 336 2024.08.06 04:38:16.281 2024.08.06 04:38:16.905 2024.08.06 04:00:01.277 2024.08.06 04:00:01.613
24 3.0.12.33779 2024.07.31 ae35d P P 675 346 2024.08.01 04:36:52.523 2024.08.01 04:36:53.198 2024.08.01 03:58:51.721 2024.08.01 03:58:52.067
25 3.0.12.33778 2024.07.21 4680d P P 659 382 2024.07.30 04:33:55.572 2024.07.30 04:33:56.231 2024.07.30 03:56:03.675 2024.07.30 03:56:04.057
26 3.0.12.33777 2024.07.19 8e912 P P 646 382 2024.07.21 04:36:03.073 2024.07.21 04:36:03.719 2024.07.21 03:58:07.603 2024.07.21 03:58:07.985
27 3.0.12.33766 2024.07.13 b5086 P P 613 379 2024.07.19 04:28:45.725 2024.07.19 04:28:46.338 2024.07.19 03:51:10.341 2024.07.19 03:51:10.720
28 3.0.12.33765 2024.07.10 06f2a P P 683 448 2024.07.13 04:31:26.745 2024.07.13 04:31:27.428 2024.07.13 03:52:33.053 2024.07.13 03:52:33.501
29 3.0.12.33764 2024.06.18 4d0c0 P P 635 377 2024.07.10 04:21:13.820 2024.07.10 04:21:14.455 2024.07.10 03:44:36.626 2024.07.10 03:44:37.003
30 3.0.12.33761 2024.06.17 b259d P P 727 366 2024.06.18 04:22:22.628 2024.06.18 04:22:23.355 2024.06.18 03:45:05.234 2024.06.18 03:45:05.600
31 3.0.12.33758 2024.06.14 4f9bc P P 634 362 2024.06.17 04:16:59.449 2024.06.17 04:17:00.083 2024.06.17 03:39:08.324 2024.06.17 03:39:08.686
32 3.0.12.33757 2024.06.13 c7a1c P P 600 282 2024.06.14 04:34:20.720 2024.06.14 04:34:21.320 2024.06.14 04:01:36.137 2024.06.14 04:01:36.419
33 3.0.12.33744 2024.04.19 ecf36 P P 539 277 2024.05.08 15:14:09.211 2024.05.08 15:14:09.750 2024.05.08 14:41:19.531 2024.05.08 14:41:19.808

Elapsed time, ms. Chart for last 33 runs:

Last commits information (all timestamps in UTC):