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   
  - Parameter: param0, value is in HEX form.
  + Parameter: param0, value: "EQ(J/,1" - not in HEX form.
  - Parameter: param1, value is in HEX form.
  + Parameter: param1, value: "|j#x12OL#x04w_" - not in HEX form.
  - Parameter: param2, value is in HEX form.
  + Parameter: param2, value: "#x0E&#x08B\An/" - not in HEX form.
  - Parameter: param3, value is in HEX form.
  + Parameter: param3, value: "#x19#x125#x16yB#x12:8e" - not in HEX form.

LOG DETAILS:

2025-02-14 08:31:40.077
2025-02-14 08:31:40.077 act = <firebird.qa.plugin.Action object at [hex]>
2025-02-14 08:31:40.077 capsys = <_pytest.capture.CaptureFixture object at [hex]>
2025-02-14 08:31:40.077
2025-02-14 08:31:40.077     @pytest.mark.trace
2025-02-14 08:31:40.077     @pytest.mark.version('>=5.0.2')
2025-02-14 08:31:40.077     def test_1(act: Action, capsys):
2025-02-14 08:31:40.077
2025-02-14 08:31:40.077         with act.trace(db_events = trace_events_lst):
2025-02-14 08:31:40.077             act.reset()
2025-02-14 08:31:40.077             act.isql(switches = ['-q'], input = test_sql, combine_output = True)
2025-02-14 08:31:40.077
2025-02-14 08:31:40.077         # Process trace
2025-02-14 08:31:40.077         # BEFORE FIX: param0 = varchar(16), "<binary data here>"
2025-02-14 08:31:40.077         # AFTER FIX:  param0 = varbinary(16), "D0EC952EC11A4C209011CF95C1712D2F"
2025-02-14 08:31:40.077
2025-02-14 08:31:40.077         param_name_pattern = re.compile( r'\s?param\d+\s?=\s?(var)?(binary|char)\(\d+\)', re.IGNORECASE )
2025-02-14 08:31:40.077         # param_hexvalue_ptn = re.compile('')
2025-02-14 08:31:40.078
2025-02-14 08:31:40.078         for line in act.trace_log:
2025-02-14 08:31:40.078             if param_name_pattern.search(line.lower()):
2025-02-14 08:31:40.078                 param_name = line.split("=")[0].strip()
2025-02-14 08:31:40.078                 param_val = line.split('"')[1]
2025-02-14 08:31:40.078                 try:
2025-02-14 08:31:40.078                    _ = int(param_val, 16)
2025-02-14 08:31:40.078                    print(f'Parameter: {param_name}, value is in HEX form.')
2025-02-14 08:31:40.078                 except ValueError as e:
2025-02-14 08:31:40.078                    print(f'Parameter: {param_name}, value: "{param_val}" - not in HEX form.')
2025-02-14 08:31:40.078
2025-02-14 08:31:40.078         act.expected_stdout = """
2025-02-14 08:31:40.078             Parameter: param0, value is in HEX form.
2025-02-14 08:31:40.078             Parameter: param1, value is in HEX form.
2025-02-14 08:31:40.078             Parameter: param2, value is in HEX form.
2025-02-14 08:31:40.078             Parameter: param3, value is in HEX form.
2025-02-14 08:31:40.078         """
2025-02-14 08:31:40.078         act.stdout = capsys.readouterr().out
2025-02-14 08:31:40.078 >       assert act.clean_stdout == act.clean_expected_stdout
2025-02-14 08:31:40.078 E       assert
2025-02-14 08:31:40.079 E         - Parameter: param0, value is in HEX form.
2025-02-14 08:31:40.079 E         + Parameter: param0, value: "EQ(J/,1" - not in HEX form.
2025-02-14 08:31:40.079 E         - Parameter: param1, value is in HEX form.
2025-02-14 08:31:40.079 E         + Parameter: param1, value: "|jOLw_" - not in HEX form.
2025-02-14 08:31:40.079 E         - Parameter: param2, value is in HEX form.
2025-02-14 08:31:40.079 E         + Parameter: param2, value: "&B\An/" - not in HEX form.
2025-02-14 08:31:40.079 E         - Parameter: param3, value is in HEX form.
2025-02-14 08:31:40.079 E         + Parameter: param3, value: "5yB:8e" - not in HEX form.
2025-02-14 08:31:40.079
2025-02-14 08:31:40.079 tests\bugs\gh_8356_test.py:88: AssertionError
2025-02-14 08:31:40.079 ---------------------------- Captured stdout setup ----------------------------
2025-02-14 08:31:40.080 Creating db: localhost:H:\QA\temp\qa2024.tmp\fbqa\test_11701\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]>
capsys = <_pytest.capture.CaptureFixture pytest object at [hex]>

    @pytest.mark.trace
    @pytest.mark.version('>=5.0.2')
    def test_1(act: Action, capsys):
    
        with act.trace(db_events = trace_events_lst):
            act.reset()
            act.isql(switches = ['-q'], input = test_sql, combine_output = True)
    
        # Process trace
        # BEFORE FIX: param0 = varchar(16), "<binary data here>"
        # AFTER FIX:  param0 = varbinary(16), "D0EC952EC11A4C209011CF95C1712D2F"
    
        param_name_pattern = re.compile( r'\s?param\d+\s?=\s?(var)?(binary|char)\(\d+\)', re.IGNORECASE )
        # param_hexvalue_ptn = re.compile('')
    
        for line in act.trace_log:
            if param_name_pattern.search(line.lower()):
                param_name = line.split("=")[0].strip()
                param_val = line.split('"')[1]
                try:
                   _ = int(param_val, 16)
                   print(f'Parameter: {param_name}, value is in HEX form.')
                except ValueError as e:
                   print(f'Parameter: {param_name}, value: "{param_val}" - not in HEX form.')
    
        act.expected_stdout = """
            Parameter: param0, value is in HEX form.
            Parameter: param1, value is in HEX form.
            Parameter: param2, value is in HEX form.
            Parameter: param3, value is in HEX form.
        """
        act.stdout = capsys.readouterr().out
>       assert act.clean_stdout == act.clean_expected_stdout
E       assert   
E         - Parameter: param0, value is in HEX form.
E         + Parameter: param0, value: "EQ(J/,1" - not in HEX form.
E         - Parameter: param1, value is in HEX form.
E         + Parameter: param1, value: "|j#x12OL#x04w_" - not in HEX form.
E         - Parameter: param2, value is in HEX form.
E         + Parameter: param2, value: "#x0E&#x08B\An/" - not in HEX form.
E         - Parameter: param3, value is in HEX form.
E         + Parameter: param3, value: "#x19#x125#x16yB#x12:8e" - not in HEX form.

tests\bugs\gh_8356_test.py:88: 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 5.0.3.1674 2025.06.27 3ee5c P P 2912 2671 2025.06.30 11:06:49.836 2025.06.30 11:06:52.748 2025.06.30 10:05:38.717 2025.06.30 10:05:41.388
2 5.0.3.1657 2025.06.26 dcb8a P P 3156 2665 2025.06.27 11:08:11.589 2025.06.27 11:08:14.745 2025.06.27 10:07:13.884 2025.06.27 10:07:16.549
3 5.0.3.1657 2025.06.20 8b4d2 P P 2921 2673 2025.06.26 11:22:39.804 2025.06.26 11:22:42.725 2025.06.26 10:21:30.686 2025.06.26 10:21:33.359
4 5.0.3.1657 2025.06.19 4bd4c P P 3359 2676 2025.06.20 05:26:53.614 2025.06.20 05:26:56.973 2025.06.20 04:25:49.036 2025.06.20 04:25:51.712
5 5.0.3.1657 2025.06.11 dae6f P P 2910 2674 2025.06.19 10:58:21.348 2025.06.19 10:58:24.258 2025.06.19 09:57:12.573 2025.06.19 09:57:15.247
6 5.0.3.1657 2025.06.10 dbc92 P P 2966 2666 2025.06.11 08:44:31.209 2025.06.11 08:44:34.175 2025.06.11 07:43:09.412 2025.06.11 07:43:12.078
7 5.0.3.1656 2025.06.05 00512 P P 2918 2675 2025.06.10 10:00:01.391 2025.06.10 10:00:04.309 2025.06.10 08:58:14.459 2025.06.10 08:58:17.134
8 5.0.3.1656 2025.05.20 c4b11 P P 2912 2668 2025.06.03 09:46:54.411 2025.06.03 09:46:57.323 2025.06.03 08:46:18.388 2025.06.03 08:46:21.056
9 5.0.3.1652 2025.05.13 f51c6 P P 2930 2672 2025.05.21 06:27:54.103 2025.05.21 06:27:57.033 2025.05.21 05:27:34.094 2025.05.21 05:27:36.766
10 5.0.3.1651 2025.05.08 ee9d2 P E 3009 2227 2025.05.13 06:40:33.137 2025.05.13 06:40:36.146 2025.05.13 05:21:46.756 2025.05.13 05:21:48.983
11 5.0.3.1651 2025.05.04 3d914 P E 2899 2242 2025.05.09 04:29:36.199 2025.05.09 04:29:39.098 2025.05.09 03:10:44.423 2025.05.09 03:10:46.665
12 5.0.3.1651 2025.04.30 141ef P E 2912 2386 2025.05.02 04:37:13.201 2025.05.02 04:37:16.113 2025.05.02 03:18:37.679 2025.05.02 03:18:40.065
13 5.0.3.1650 2025.04.30 6253f P E 2946 2397 2025.05.01 04:36:15.912 2025.05.01 04:36:18.858 2025.05.01 03:17:34.066 2025.05.01 03:17:36.463
14 5.0.3.1650 2025.04.28 4cbff P E 2913 2397 2025.04.30 04:35:17.570 2025.04.30 04:35:20.483 2025.04.30 03:16:46.985 2025.04.30 03:16:49.382
15 5.0.3.1649 2025.04.21 5b2d0 P E 2942 2238 2025.04.26 10:09:12.816 2025.04.26 10:09:15.758 2025.04.26 08:49:47.262 2025.04.26 08:49:49.500
16 5.0.3.1648 2025.04.18 2f4c5 P P 2936 2682 2025.04.20 04:20:26.897 2025.04.20 04:20:29.833 2025.04.20 03:19:05.668 2025.04.20 03:19:08.350
17 5.0.3.1635 2025.04.03 f6bd1 P E 2978 2400 2025.04.18 06:48:07.712 2025.04.18 06:48:10.690 2025.04.18 05:28:57.222 2025.04.18 05:28:59.622
18 5.0.3.1635 2025.03.31 22ec6 P E 2919 2246 2025.04.03 09:53:56.897 2025.04.03 09:53:59.816 2025.04.03 08:34:27.564 2025.04.03 08:34:29.810
19 5.0.3.1633 2025.03.28 3123a P E 2953 2380 2025.03.31 09:52:26.104 2025.03.31 09:52:29.057 2025.03.31 08:33:03.338 2025.03.31 08:33:05.718
20 5.0.3.1633 2025.03.27 e0fb8 P E 2981 2427 2025.03.28 10:24:04.849 2025.03.28 10:24:07.830 2025.03.28 09:00:57.871 2025.03.28 09:01:00.298
21 5.0.3.1631 2025.03.25 bda65 P P 2955 2744 2025.03.27 10:04:36.263 2025.03.27 10:04:39.218 2025.03.27 08:59:32.391 2025.03.27 08:59:35.135
22 5.0.3.1631 2025.03.21 1925b P P 2952 2699 2025.03.25 06:38:38.562 2025.03.25 06:38:41.514 2025.03.25 05:33:25.780 2025.03.25 05:33:28.479
23 5.0.3.1629 2025.03.18 506d7 P P 2927 2675 2025.03.20 09:38:56.076 2025.03.20 09:38:59.003 2025.03.20 08:33:32.823 2025.03.20 08:33:35.498
24 5.0.3.1628 2025.03.14 16d05 P P 2915 2674 2025.03.18 09:33:03.908 2025.03.18 09:33:06.823 2025.03.18 08:29:14.682 2025.03.18 08:29:17.356
25 5.0.3.1627 2025.02.26 4e218 P P 3314 2859 2025.03.13 09:52:21.412 2025.03.13 09:52:24.726 2025.03.13 08:46:46.845 2025.03.13 08:46:49.704
26 5.0.3.1624 2025.02.25 dc3b2 P P 2948 2678 2025.02.26 15:24:37.083 2025.02.26 15:24:40.031 2025.02.26 14:19:43.933 2025.02.26 14:19:46.611
27 5.0.2.1615 2025.02.20 4a726 P P 2999 2675 2025.02.25 08:39:10.936 2025.02.25 08:39:13.935 2025.02.25 07:17:29.304 2025.02.25 07:17:31.979
28 5.0.2.1615 2025.02.14 9cb76 P P 2925 2669 2025.02.15 04:06:49.736 2025.02.15 04:06:52.661 2025.02.15 03:03:44.881 2025.02.15 03:03:47.550
29 5.0.2.1577 2025.02.07 f50a2 F F 2958 2993 2025.02.14 06:19:27.281 2025.02.14 06:19:30.239 2025.02.14 05:17:33.371 2025.02.14 05:17:36.364
30 5.0.2.1577 2024.12.24 3c80e F F 2945 2687 2025.02.06 09:32:59.543 2025.02.06 09:33:02.488 2025.02.06 08:31:08.753 2025.02.06 08:31:11.440

Elapsed time, ms. Chart for last 30 runs:

Last commits information (all timestamps in UTC):