Jump to: output_first_mismatch    outcomes_full_history    elapsed_time_chart
Show cross-report outcomes.

Annotation type Annotation details
1 @message
assert   
  + ['2024-05-16T10:30:52.5360 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', 'recreate /* ddl_1 line_1 */ \n', ' \n', '            table /* ddl_1 line_2 */ \n', ' \n', ' \n', ' \n', '            t_test /* ddl_1 line_3 */ (x int) \n', '        \r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n', '2024-05-16T10:30:52.5360 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', 'comment on  /* ddl_2 line_1 */ \n', '    table /* ddl_2 line_2 */ \n', ' \n', ' \n', '    t_test is /* ddl_2 line_3 */ \n', "            'foo  /* ddl_2 line_4 */ \n", "             /* ddl_2 line_4 */ bar' \n", '    \r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n', '2024-05-16T10:30:52.5520 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', ' \n', ' \n', '            create /* ddl_3 line_1 */ \n', '    or /* ddl_3 line_2 */ \n', ' \n', '    alter /* ddl_3 line_3 */ \n', '                    view /* ddl_3 line_4 */ \n', ' \n', '                    v_rio /* ddl_3 line_5 */ \n', ' \n', '                    as /* ddl_3 line_6 */ \n', '                    select * /* ddl_3 line_6 */ \n', '                    ...\r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n']

LOG DETAILS:

2024-05-16 10:34:10.870
2024-05-16 10:34:10.870 act = <firebird.qa.plugin.Action object at [hex]>
2024-05-16 10:34:10.870 capsys = <_pytest.capture.CaptureFixture object at [hex]>
2024-05-16 10:34:10.870
2024-05-16 10:34:10.870     @pytest.mark.trace
2024-05-16 10:34:10.870     @pytest.mark.version('>=3')
2024-05-16 10:34:10.870     def test_1(act: Action, capsys):
2024-05-16 10:34:10.870         with act.trace(db_events=trace), act.db.connect() as con:
2024-05-16 10:34:10.870             for cmd in ddl_lst:
2024-05-16 10:34:10.870                 con.execute_immediate(cmd)
2024-05-16 10:34:10.870             con.commit()
2024-05-16 10:34:10.870
2024-05-16 10:34:10.870         #print(act.trace_to_stdout())
2024-05-16 10:34:10.870         print(act.trace_log)
2024-05-16 10:34:10.870         act.expected_stdout = '' # expected_stdout
2024-05-16 10:34:10.870         act.stdout = capsys.readouterr().out
2024-05-16 10:34:10.870 >       assert act.clean_stdout == act.clean_expected_stdout
2024-05-16 10:34:10.870 E       assert
2024-05-16 10:34:10.870 E         + ['2024-05-16T10:30:52.5360 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', 'recreate /* ddl_1 line_1 */ \n', ' \n', '            table /* ddl_1 line_2 */ \n', ' \n', ' \n', ' \n', '            t_test /* ddl_1 line_3 */ (x int) \n', '        \r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n', '2024-05-16T10:30:52.5360 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', 'comment on  /* ddl_2 line_1 */ \n', '    table /* ddl_2 line_2 */ \n', ' \n', ' \n', '    t_test is /* ddl_2 line_3 */ \n', "            'foo  /* ddl_2 line_4 */ \n", "             /* ddl_2 line_4 */ bar' \n", '    \r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n', '2024-05-16T10:30:52.5520 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', ' \n', ' \n', '            create /* ddl_3 line_1 */ \n', '    or /* ddl_3 line_2 */ \n', ' \n', '    alter /* ddl_3 line_3 */ \n', '                    view /* ddl_3 line_4 */ \n', ' \n', '                    v_rio /* ddl_3 line_5 */ \n', ' \n', '                    as /* ddl_3 line_6 */ \n', '                    select * /* ddl_3 line_6 */ \n', '                    ...\r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n']
2024-05-16 10:34:10.870
2024-05-16 10:34:10.870 tests\bugs\test_trace_eol.py:76: AssertionError
2024-05-16 10:34:10.870 ---------------------------- Captured stdout setup ----------------------------
2024-05-16 10:34:10.870 Cached db: db-12.0-None-None-NONE.fdb [page_size=None, sql_dialect=None, charset='NONE'
2 #text
act = <firebird.qa.plugin.Action pytest object at [hex]>
capsys = <_pytest.capture.CaptureFixture pytest object at [hex]>

    @pytest.mark.trace
    @pytest.mark.version('>=3')
    def test_1(act: Action, capsys):
        with act.trace(db_events=trace), act.db.connect() as con:
            for cmd in ddl_lst:
                con.execute_immediate(cmd)
            con.commit()
    
        #print(act.trace_to_stdout())
        print(act.trace_log)
        act.expected_stdout = '' # expected_stdout
        act.stdout = capsys.readouterr().out
>       assert act.clean_stdout == act.clean_expected_stdout
E       assert   
E         + ['2024-05-16T10:30:52.5360 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', 'recreate /* ddl_1 line_1 */ \n', ' \n', '            table /* ddl_1 line_2 */ \n', ' \n', ' \n', ' \n', '            t_test /* ddl_1 line_3 */ (x int) \n', '        \r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n', '2024-05-16T10:30:52.5360 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', 'comment on  /* ddl_2 line_1 */ \n', '    table /* ddl_2 line_2 */ \n', ' \n', ' \n', '    t_test is /* ddl_2 line_3 */ \n', "            'foo  /* ddl_2 line_4 */ \n", "             /* ddl_2 line_4 */ bar' \n", '    \r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n', '2024-05-16T10:30:52.5520 (1584:00000000030881C0) EXECUTE_STATEMENT_FINISH\r \n', '\tR:\\TEMP\\QA\\FBQA\\TEST_11335\\TEST.FDB (ATT_11, SYSDBA:NONE, NONE, TCPv6:::1/63520)\r \n', '\tC:\\Python3x\\python.exe:4600\r \n', '\t\t(TRA_2, CONCURRENCY | WAIT | READ_WRITE)\r \n', '\r \n', '-------------------------------------------------------------------------------\r \n', ' \n', ' \n', '            create /* ddl_3 line_1 */ \n', '    or /* ddl_3 line_2 */ \n', ' \n', '    alter /* ddl_3 line_3 */ \n', '                    view /* ddl_3 line_4 */ \n', ' \n', '                    v_rio /* ddl_3 line_5 */ \n', ' \n', '                    as /* ddl_3 line_6 */ \n', '                    select * /* ddl_3 line_6 */ \n', '                    ...\r \n', '0 records fetched\r \n', '      0 ms\r \n', '\r \n']

tests\bugs\test_trace_eol.py:76: 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.12.33745 2024.05.09 9cf37 F F 2625 2359 2024.05.16 08:04:57.636 2024.05.16 08:05:00.261 2024.05.16 07:30:52.443 2024.05.16 07:30:54.802

Elapsed time, ms. Chart for last 1 runs:

Last commits information (all timestamps in UTC):