Uploaded image for project: 'MariaDB Server'
  1. MariaDB Server
  2. MDEV-33476

Assertion `success' failed in btr_compress; assertion: btr_page_get_next(latch_leaves.blocks[0]->frame) == page_get_page_no(page)

Details

    Description

      please find the test attached.
      It is repeatable on 10.4, but might be sporadic
      I had no luck repeating it on 10.5+, but I maybe that is a specific of the test.

      Version: '10.4.34-MariaDB-debug-log'  
      mysqld: /10.4/src/storage/innobase/btr/btr0btr.cc:3828: ulint btr_compress(btr_cur_t*, ulint, mtr_t*): Assertion `success' failed.
      		 
      240216 14:32:49 [ERROR] mysqld got signal 6 ;
      		 
       
      		 
      Server version: 10.4.34-MariaDB-debug-log source revision: ae709b64e29f503245fb5004574d85cb9c85a499
      		 
       
      		 
      /lib/x86_64-linux-gnu/libc.so.6(+0x33fd6)[0x7f9b2cfabfd6]
      		 
      btr/btr0btr.cc:3835(btr_compress(btr_cur_t*, unsigned long, mtr_t*))[0x5564c1caec1d]
      		 
      btr/btr0cur.cc:5774(btr_cur_compress_if_useful(btr_cur_t*, unsigned long, mtr_t*))[0x5564c1d028dc]
      		 
      btr/btr0cur.cc:6213(btr_cur_pessimistic_delete(dberr_t*, unsigned long, btr_cur_t*, unsigned long, bool, mtr_t*))[0x5564c1d05815]
      		 
      row/row0uins.cc:312(row_undo_ins_remove_sec_low(unsigned long, dict_index_t*, dtuple_t*, que_thr_t*))[0x5564c1fc558a]
      		 
      row/row0uins.cc:345(row_undo_ins_remove_sec(dict_index_t*, dtuple_t*, que_thr_t*))[0x5564c1fc57fa]
      		 
      row/row0uins.cc:523(row_undo_ins_remove_sec_rec(undo_node_t*, que_thr_t*))[0x5564c1fc6ca0]
      		 
      row/row0uins.cc:575(row_undo_ins(undo_node_t*, que_thr_t*))[0x5564c1fc70fd]
      		 
      row/row0undo.cc:427(row_undo(undo_node_t*, que_thr_t*))[0x5564c1b6e813]
      		 
      row/row0undo.cc:489(row_undo_step(que_thr_t*))[0x5564c1b6ed71]
      		 
      que/que0que.cc:964(que_thr_step(que_thr_t*))[0x5564c19ef16f]
      		 
      que/que0que.cc:1028(que_run_threads_low(que_thr_t*))[0x5564c19ef5f7]
      		 
      que/que0que.cc:1070(que_run_threads(que_thr_t*))[0x5564c19efa56]
      		 
      trx/trx0roll.cc:140(trx_rollback_to_savepoint_low(trx_t*, trx_savept_t*))[0x5564c1c3dfbe]
      		 
      trx/trx0roll.cc:212(trx_rollback_for_mysql_low(trx_t*))[0x5564c1c3e933]
      		 
      trx/trx0roll.cc:241(trx_rollback_for_mysql(trx_t*))[0x5564c1c3efaa]
      		 
      handler/ha_innodb.cc:4832(innobase_rollback(handlerton*, THD*, bool))[0x5564c173d21b]
      		 
      sql/handler.cc:1958(ha_rollback_trans(THD*, bool))[0x5564c0d7337e]
      		 
      sql/transaction.cc:342(trans_rollback(THD*))[0x5564c09e067b]
      		 
      sql/sql_parse.cc:5841(mysql_execute_command(THD*))[0x5564c05ab9f1]
      		 
      sql/sql_parse.cc:8088(mysql_parse(THD*, char*, unsigned int, Parser_state*, bool, bool))[0x5564c05ba605]
      		 
      sql/sql_parse.cc:1860(dispatch_command(enum_server_command, THD*, char*, unsigned int, bool, bool))[0x5564c0590377]
      		 
      sql/sql_parse.cc:1378(do_command(THD*))[0x5564c058cea2]
      		 
      sql/sql_connect.cc:1419(do_handle_one_connection(CONNECT*))[0x5564c09a286a]
      		 
      sql/sql_connect.cc:1324(handle_one_connection)[0x5564c09a210e]
      		 
      perfschema/pfs.cc:1871(pfs_spawn_thread)[0x5564c16419e6]
      		 
      nptl/pthread_create.c:478(start_thread)[0x7f9b2d4c6609]
      		 
       
      		 
      Query (0x62b0000a1290): rollback

      on non-debug:

      Version: '10.4.33-MariaDB' 
      2024-02-16 14:48:06 0x7f652860c700  InnoDB: Assertion failure in file /home/buildbot/buildbot/build/storage/innobase/btr/btr0cur.cc line 314
      		 
      InnoDB: Failing assertion: btr_page_get_next(latch_leaves.blocks[0]->frame) == page_get_page_no(page)
      		 
      InnoDB: We intentionally generate a memory trap.
      		 
      InnoDB: Submit a detailed bug report to https://jira.mariadb.org/
      		 
      InnoDB: If you get repeated assertion failures or crashes, even
      		 
      InnoDB: immediately after the mysqld startup, there may be
      		 
      InnoDB: corruption in the InnoDB tablespace. Please refer to
      		 
      InnoDB: https://mariadb.com/kb/en/library/innodb-recovery-modes/
      		 
      InnoDB: about forcing recovery.
      		 
      240216 14:48:06 [ERROR] mysqld got signal 6 ;
      		 
      Sorry, we probably made a mistake, and this is a bug.
      		 
       
      		 
      Server version: 10.4.33-MariaDB source revision: 46e3a7658b774942e9320a1acb234373bb44e874
      		 
       
      		 
      /lib/x86_64-linux-gnu/libc.so.6(gsignal+0xcb)[0x7f652bbbd00b]
      		 
      /lib/x86_64-linux-gnu/libc.so.6(abort+0x12b)[0x7f652bb9c859]
      		 
      ut/ut0rbt.cc:218(rbt_tree_add_child(ib_rbt_t const*, ib_rbt_bound_t*, ib_rbt_node_t*) [clone .isra.4] [clone .part.5])[0x55ff62a04594]
      		 
      btr/btr0cur.cc:311(btr_cur_latch_leaves(buf_block_t*, page_id_t, unsigned long, unsigned long, btr_cur_t*, mtr_t*))[0x55ff6313eb34]
      		 
      gis/gis0sea.cc:440(rtr_pcur_getnext_from_path(dtuple_t const*, page_cur_mode_t, btr_cur_t*, unsigned long, unsigned long, bool, mtr_t*))[0x55ff63225fc5]
      		 
      row/row0row.cc:1302(row_search_index_entry(dict_index_t*, dtuple_t const*, unsigned long, btr_pcur_t*, mtr_t*))[0x55ff630bfcef]
      		 
      row/row0uins.cc:278(row_undo_ins_remove_sec_low(unsigned long, dict_index_t*, dtuple_t*, que_thr_t*))[0x55ff63235473]
      		 
      row/row0uins.cc:353(row_undo_ins(undo_node_t*, que_thr_t*))[0x55ff63235c29]
      		 
      row/row0undo.cc:438(row_undo_step(que_thr_t*))[0x55ff630ca0f0]
      		 
      que/que0que.cc:964(que_run_threads(que_thr_t*))[0x55ff63073035]
      		 
      trx/trx0roll.cc:140(trx_rollback_to_savepoint_low(trx_t*, trx_savept_t*) [clone .constprop.98])[0x55ff6310a0ec]
      		 
      trx/trx0roll.cc:212(trx_rollback_for_mysql(trx_t*))[0x55ff6310a64a]
      		 
      handler/ha_innodb.cc:2845(innobase_rollback(handlerton*, THD*, bool))[0x55ff62fcc085]
      		 
      sql/handler.cc:1955(ha_rollback_trans(THD*, bool))[0x55ff62d093db]
      		 
      sql/transaction.cc:344(trans_rollback(THD*))[0x55ff62c0bb47]
      		 
      sql/sql_class.h:4732(THD::release_transactional_locks())[0x55ff62b0d847]
      		 
      sql/sql_parse.cc:8062(mysql_parse(THD*, char*, unsigned int, Parser_state*, bool, bool))[0x55ff62b126a2]
      		 
      sql/sql_parse.cc:1921(dispatch_command(enum_server_command, THD*, char*, unsigned int, bool, bool))[0x55ff62b14b53]
      		 
      sql/sql_parse.cc:1379(do_command(THD*))[0x55ff62b1631f]
      		 
      sql/sql_connect.cc:1419(do_handle_one_connection(CONNECT*))[0x55ff62bfd372]
      		 
      sql/sql_connect.cc:1325(handle_one_connection)[0x55ff62bfd45d]
      		 
      nptl/pthread_create.c:478(start_thread)[0x7f652c0ad609]
      		 
       
      		 
      Query (0x7f64c0010300): rollback

      Attachments

        Issue Links

          is part of

          Task - A task that needs to be done. MDEV-33073 always green buildbot

          • Major - Major loss of function.
          • Stalled
          relates to

          Bug - A problem which impairs or prevents the functions of the product. MDEV-22397 repeatable crashes: InnoDB: Assertion failure in file /home/buildbot/buildbot/padding_for_CPACK_RPM_BUILD_SOURCE_DIRS_PREFIX/mariadb-10.4.12/storage/innobase/btr/btr0cur.cc line 311

          • Major - Major loss of function.
          • Closed

          Bug - A problem which impairs or prevents the functions of the product. MDEV-28569 Server crash, fatal error or assertion failures somewhere in btr_cur_compress_if_useful

          • Major - Major loss of function.
          • Stalled

          Activity

            Ascending order - Click to sort in descending order
            alice Alice Sherepa created issue -
            alice Alice Sherepa made changes -
            Field Original Value New Value
            Attachment MDEV-33476.test [ 73151 ]
            alice Alice Sherepa made changes -
            Labels not-10.5+
            alice Alice Sherepa made changes -
            alice Alice Sherepa made changes -
            alice Alice Sherepa made changes -
            Assignee Marko Mäkelä [ marko ]
            danblack Daniel Black added a comment -

            10.6.18-74f196a98d96414673f1355aad8885f3b51c0b65 https://buildbot.mariadb.org/#/builders/572/builds/7712/steps/8/logs/stdio

            		 
            innodb_gis.rtree_compress '16k,innodb'   w42 [ fail ]
            		 
                    Test ended at 2024-03-25 22:18:47
            		 
            CURRENT_TEST: innodb_gis.rtree_compress
            		 
            mysqltest: At line 43: query 'rollback' failed: <Unknown> (2013): Lost connection to server during query
            		 
            The result from queries just before the failure was:
            		 
            < snip >
            		 
            insert into t1 values(8, Point(8,8));
            		 
            insert into t1 values(9, Point(9,9));
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            insert into t1 select * from t1;
            		 
            commit;
            		 
            unlock tables;
            		 
            start transaction;
            		 
            insert into t1 select * from t1;
            		 
            select count(*) from t1;
            		 
            count(*)
            		 
            18432
            		 
            rollback;
            		 
            More results from queries before failure can be found in /home/buildbot/amd64-debian-11-msan/build/mysql-test/var/42/log/rtree_compress.log
            		 
            Server [mysqld.1 - pid: 183802, winpid: 183802, exit: 256] failed during test run
            		 
            Server log from this test:
            		 
            ----------SERVER LOG START-----------
            		 
            $ /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd --defaults-group-suffix=.1 --defaults-file=/home/buildbot/amd64-debian-11-msan/build/mysql-test/var/42/my.cnf --log-output=file --innodb --innodb-cmpmem --innodb-cmp-per-index --innodb-trx --innodb-locks --innodb-lock-waits --innodb-metrics --innodb-buffer-pool-stats --innodb-buffer-page --innodb-buffer-page-lru --innodb-sys-columns --innodb-sys-fields --innodb-sys-foreign --innodb-sys-foreign-cols --innodb-sys-indexes --innodb-sys-tables --innodb-sys-virtual --innodb-page-size=16K --skip-innodb-read-only-compressed --core-file --loose-debug-sync-timeout=300
            		 
            2024-03-25 22:18:11 0 [Warning] Could not increase number of max_open_files to more than 1024 (request: 32246)
            		 
            2024-03-25 22:18:11 0 [Warning] Changed limits: max_open_files: 1024  max_connections: 151 (was 151)  table_cache: 421 (was 2000)
            		 
            2024-03-25 22:18:11 0 [Note] Starting MariaDB 10.6.18-MariaDB-debug-log source revision 74f196a98d96414673f1355aad8885f3b51c0b65 as process 183829
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'partition' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'SEQUENCE' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Compressed tables use zlib 1.3
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Number of pools: 1
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Initializing buffer pool, total size = 8388608, chunk size = 8388608
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Completed initialization of buffer pool
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Setting O_DIRECT on file ./ibdata1 failed
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: 128 rollback segments are active.
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Creating shared tablespace for temporary tables
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: 10.6.18 started; log sequence number 54052; transaction id 16
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMP' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_WAITS' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_QUEUES' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'FEEDBACK' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_GROUPS' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'user_variables' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_STATS' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] Plugin 'unix_socket' is disabled.
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Loading buffer pool(s) from /dev/shm/var_auto_ylcC/42/mysqld.1/data/ib_buffer_pool
            		 
            2024-03-25 22:18:11 0 [Warning] /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd: unknown option '--loose-pam-debug'
            		 
            2024-03-25 22:18:11 0 [Warning] /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd: unknown option '--loose-aria'
            		 
            2024-03-25 22:18:11 0 [Note] InnoDB: Buffer pool(s) load completed at 240325 22:18:11
            		 
            2024-03-25 22:18:12 0 [Note] Server socket created on IP: '127.0.0.1'.
            		 
            2024-03-25 22:18:12 0 [Note] /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd: ready for connections.
            		 
            Version: '10.6.18-MariaDB-debug-log'  socket: '/home/buildbot/amd64-debian-11-msan/build/mysql-test/var/tmp/42/mysqld.1.sock'  port: 16780  Source distribution
            		 
            ==183829==WARNING: MemorySanitizer: use-of-uninitialized-value
            		 
                #0 0x561cfe07adcb in rtr_pcur_getnext_from_path(dtuple_t const*, page_cur_mode_t, btr_cur_t*, unsigned long, unsigned long, bool, mtr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/gis/gis0sea.cc:292:3
            		 
                #1 0x561d00ddac40 in rtr_search(dtuple_t const*, btr_latch_mode, btr_pcur_t*, mtr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/gis/gis0sea.cc:1087:8
            		 
                #2 0x561d00e2013f in row_undo_ins_remove_sec_low(btr_latch_mode, dict_index_t*, dtuple_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:283:7
            		 
                #3 0x561d00e18c39 in row_undo_ins_remove_sec(dict_index_t*, dtuple_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:353:8
            		 
                #4 0x561d00e18c39 in row_undo_ins_remove_sec_rec(undo_node_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:547:10
            		 
                #5 0x561d00e18c39 in row_undo_ins(undo_node_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:599:9
            		 
                #6 0x561d007eaad7 in row_undo(undo_node_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0undo.cc:399:5
            		 
                #7 0x561d007eaad7 in row_undo_step(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0undo.cc:440:8
            		 
                #8 0x561d00563a58 in que_thr_step(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/que/que0que.cc:586:9
            		 
                #9 0x561d00563a58 in que_run_threads_low(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/que/que0que.cc:644:25
            		 
                #10 0x561d00563a58 in que_run_threads(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/que/que0que.cc:664:2
            		 
                #11 0x561d008fbb1e in trx_t::rollback_low(trx_savept_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/trx/trx0roll.cc:125:5
            		 
                #12 0x561d008f2680 in trx_rollback_for_mysql(trx_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/trx/trx0roll.cc
            		 
                #13 0x561d00199880 in innobase_rollback(handlerton*, THD*, bool) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/handler/ha_innodb.cc:4697:11
            		 
                #14 0x561cff1a16da in ha_rollback_trans(THD*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/handler.cc:2237:17
            		 
                #15 0x561cfebb575b in trans_rollback(THD*) /home/buildbot/amd64-debian-11-msan/build/sql/transaction.cc:387:8
            		 
                #16 0x561cfe58dd21 in mysql_execute_command(THD*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:5777:27
            		 
                #17 0x561cfe569cb9 in mysql_parse(THD*, char*, unsigned int, Parser_state*) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:8139:18
            		 
                #18 0x561cfe5600d3 in dispatch_command(enum_server_command, THD*, char*, unsigned int, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:1896:7
            		 
                #19 0x561cfe56b3e2 in do_command(THD*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:1409:17
            		 
                #20 0x561cfeb5a5c6 in do_handle_one_connection(CONNECT*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_connect.cc:1415:11
            		 
                #21 0x561cfeb59bc9 in handle_one_connection /home/buildbot/amd64-debian-11-msan/build/sql/sql_connect.cc:1317:5
            		 
                #22 0x561cffe7191e in pfs_spawn_thread /home/buildbot/amd64-debian-11-msan/build/storage/perfschema/pfs.cc:2201:3
            		 
                #23 0x7f8f950cbea6 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x7ea6) (BuildId: 255e355c207aba91a59ae1f808e3b4da443abf0c)
            		 
                #24 0x7f8f94ad3a6e in __clone (/lib/x86_64-linux-gnu/libc.so.6+0xfba6e) (BuildId: 090256e8388c10b0a5a367e269cc0ed39d15d20b)
            		 
              Memory was marked as uninitialized
            		 
                #0 0x561cfe0b6bbd in __msan_allocated_memory (/home/buildbot/amd64-debian-11-msan/build/sql/mariadbd+0x85fbbd) (BuildId: dee61be51ef1ed50047fddc8092700f8514a3cbd)
            		 
                #1 0x561d00b38f94 in buf_LRU_block_free_non_file_page(buf_block_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/buf/buf0lru.cc:975:2
            		 
            SUMMARY: MemorySanitizer: use-of-uninitialized-value /home/buildbot/amd64-debian-11-msan/build/storage/innobase/gis/gis0sea.cc:292:3 in rtr_pcur_getnext_from_path(dtuple_t const*, page_cur_mode_t, btr_cur_t*, unsigned long, unsigned long, bool, mtr_t*)
            		 
            Exiting
            		 
            240325 22:18:45 [ERROR] mysqld got signal 6 ;
            		 
            Sorry, we probably made a mistake, and this is a bug.

            Core file in https://ci.mariadb.org/44762/logs/amd64-debian-11-msan/ var.tar.gz

            danblack Daniel Black added a comment - 10.6.18-74f196a98d96414673f1355aad8885f3b51c0b65 https://buildbot.mariadb.org/#/builders/572/builds/7712/steps/8/logs/stdio innodb_gis.rtree_compress '16k,innodb' w42 [ fail ] Test ended at 2024-03-25 22:18:47 CURRENT_TEST: innodb_gis.rtree_compress mysqltest: At line 43: query 'rollback' failed: <Unknown> (2013): Lost connection to server during query The result from queries just before the failure was: < snip > insert into t1 values(8, Point(8,8)); insert into t1 values(9, Point(9,9)); insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; insert into t1 select * from t1; commit; unlock tables; start transaction; insert into t1 select * from t1; select count(*) from t1; count(*) 18432 rollback; More results from queries before failure can be found in /home/buildbot/amd64-debian-11-msan/build/mysql-test/var/42/log/rtree_compress.log Server [mysqld.1 - pid: 183802, winpid: 183802, exit: 256] failed during test run Server log from this test: ----------SERVER LOG START----------- $ /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd --defaults-group-suffix=.1 --defaults-file=/home/buildbot/amd64-debian-11-msan/build/mysql-test/var/42/my.cnf --log-output=file --innodb --innodb-cmpmem --innodb-cmp-per-index --innodb-trx --innodb-locks --innodb-lock-waits --innodb-metrics --innodb-buffer-pool-stats --innodb-buffer-page --innodb-buffer-page-lru --innodb-sys-columns --innodb-sys-fields --innodb-sys-foreign --innodb-sys-foreign-cols --innodb-sys-indexes --innodb-sys-tables --innodb-sys-virtual --innodb-page-size=16K --skip-innodb-read-only-compressed --core-file --loose-debug-sync-timeout=300 2024-03-25 22:18:11 0 [Warning] Could not increase number of max_open_files to more than 1024 (request: 32246) 2024-03-25 22:18:11 0 [Warning] Changed limits: max_open_files: 1024 max_connections: 151 (was 151) table_cache: 421 (was 2000) 2024-03-25 22:18:11 0 [Note] Starting MariaDB 10.6.18-MariaDB-debug-log source revision 74f196a98d96414673f1355aad8885f3b51c0b65 as process 183829 2024-03-25 22:18:11 0 [Note] Plugin 'partition' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'SEQUENCE' is disabled. 2024-03-25 22:18:11 0 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!! 2024-03-25 22:18:11 0 [Note] InnoDB: Compressed tables use zlib 1.3 2024-03-25 22:18:11 0 [Note] InnoDB: Number of pools: 1 2024-03-25 22:18:11 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions 2024-03-25 22:18:11 0 [Note] InnoDB: Initializing buffer pool, total size = 8388608, chunk size = 8388608 2024-03-25 22:18:11 0 [Note] InnoDB: Completed initialization of buffer pool 2024-03-25 22:18:11 0 [Note] InnoDB: Setting O_DIRECT on file ./ibdata1 failed 2024-03-25 22:18:11 0 [Note] InnoDB: 128 rollback segments are active. 2024-03-25 22:18:11 0 [Note] InnoDB: Creating shared tablespace for temporary tables 2024-03-25 22:18:11 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ... 2024-03-25 22:18:11 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB. 2024-03-25 22:18:11 0 [Note] InnoDB: 10.6.18 started; log sequence number 54052; transaction id 16 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_CONFIG' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_DELETED' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMP' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_WAITS' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMP_RESET' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_QUEUES' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'FEEDBACK' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_GROUPS' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'user_variables' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'THREAD_POOL_STATS' is disabled. 2024-03-25 22:18:11 0 [Note] Plugin 'unix_socket' is disabled. 2024-03-25 22:18:11 0 [Note] InnoDB: Loading buffer pool(s) from /dev/shm/var_auto_ylcC/42/mysqld.1/data/ib_buffer_pool 2024-03-25 22:18:11 0 [Warning] /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd: unknown option '--loose-pam-debug' 2024-03-25 22:18:11 0 [Warning] /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd: unknown option '--loose-aria' 2024-03-25 22:18:11 0 [Note] InnoDB: Buffer pool(s) load completed at 240325 22:18:11 2024-03-25 22:18:12 0 [Note] Server socket created on IP: '127.0.0.1'. 2024-03-25 22:18:12 0 [Note] /home/buildbot/amd64-debian-11-msan/build/sql/mariadbd: ready for connections. Version: '10.6.18-MariaDB-debug-log' socket: '/home/buildbot/amd64-debian-11-msan/build/mysql-test/var/tmp/42/mysqld.1.sock' port: 16780 Source distribution ==183829==WARNING: MemorySanitizer: use-of-uninitialized-value #0 0x561cfe07adcb in rtr_pcur_getnext_from_path(dtuple_t const*, page_cur_mode_t, btr_cur_t*, unsigned long, unsigned long, bool, mtr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/gis/gis0sea.cc:292:3 #1 0x561d00ddac40 in rtr_search(dtuple_t const*, btr_latch_mode, btr_pcur_t*, mtr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/gis/gis0sea.cc:1087:8 #2 0x561d00e2013f in row_undo_ins_remove_sec_low(btr_latch_mode, dict_index_t*, dtuple_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:283:7 #3 0x561d00e18c39 in row_undo_ins_remove_sec(dict_index_t*, dtuple_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:353:8 #4 0x561d00e18c39 in row_undo_ins_remove_sec_rec(undo_node_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:547:10 #5 0x561d00e18c39 in row_undo_ins(undo_node_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0uins.cc:599:9 #6 0x561d007eaad7 in row_undo(undo_node_t*, que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0undo.cc:399:5 #7 0x561d007eaad7 in row_undo_step(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/row/row0undo.cc:440:8 #8 0x561d00563a58 in que_thr_step(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/que/que0que.cc:586:9 #9 0x561d00563a58 in que_run_threads_low(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/que/que0que.cc:644:25 #10 0x561d00563a58 in que_run_threads(que_thr_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/que/que0que.cc:664:2 #11 0x561d008fbb1e in trx_t::rollback_low(trx_savept_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/trx/trx0roll.cc:125:5 #12 0x561d008f2680 in trx_rollback_for_mysql(trx_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/trx/trx0roll.cc #13 0x561d00199880 in innobase_rollback(handlerton*, THD*, bool) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/handler/ha_innodb.cc:4697:11 #14 0x561cff1a16da in ha_rollback_trans(THD*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/handler.cc:2237:17 #15 0x561cfebb575b in trans_rollback(THD*) /home/buildbot/amd64-debian-11-msan/build/sql/transaction.cc:387:8 #16 0x561cfe58dd21 in mysql_execute_command(THD*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:5777:27 #17 0x561cfe569cb9 in mysql_parse(THD*, char*, unsigned int, Parser_state*) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:8139:18 #18 0x561cfe5600d3 in dispatch_command(enum_server_command, THD*, char*, unsigned int, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:1896:7 #19 0x561cfe56b3e2 in do_command(THD*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_parse.cc:1409:17 #20 0x561cfeb5a5c6 in do_handle_one_connection(CONNECT*, bool) /home/buildbot/amd64-debian-11-msan/build/sql/sql_connect.cc:1415:11 #21 0x561cfeb59bc9 in handle_one_connection /home/buildbot/amd64-debian-11-msan/build/sql/sql_connect.cc:1317:5 #22 0x561cffe7191e in pfs_spawn_thread /home/buildbot/amd64-debian-11-msan/build/storage/perfschema/pfs.cc:2201:3 #23 0x7f8f950cbea6 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x7ea6) (BuildId: 255e355c207aba91a59ae1f808e3b4da443abf0c) #24 0x7f8f94ad3a6e in __clone (/lib/x86_64-linux-gnu/libc.so.6+0xfba6e) (BuildId: 090256e8388c10b0a5a367e269cc0ed39d15d20b) Memory was marked as uninitialized #0 0x561cfe0b6bbd in __msan_allocated_memory (/home/buildbot/amd64-debian-11-msan/build/sql/mariadbd+0x85fbbd) (BuildId: dee61be51ef1ed50047fddc8092700f8514a3cbd) #1 0x561d00b38f94 in buf_LRU_block_free_non_file_page(buf_block_t*) /home/buildbot/amd64-debian-11-msan/build/storage/innobase/buf/buf0lru.cc:975:2 SUMMARY: MemorySanitizer: use-of-uninitialized-value /home/buildbot/amd64-debian-11-msan/build/storage/innobase/gis/gis0sea.cc:292:3 in rtr_pcur_getnext_from_path(dtuple_t const*, page_cur_mode_t, btr_cur_t*, unsigned long, unsigned long, bool, mtr_t*) Exiting 240325 22:18:45 [ERROR] mysqld got signal 6 ; Sorry, we probably made a mistake, and this is a bug. Core file in https://ci.mariadb.org/44762/logs/amd64-debian-11-msan/ var.tar.gz
            danblack Daniel Black made changes -
            marko Marko Mäkelä made changes -
            Component/s GIS [ 10105 ]
            Fix Version/s 10.5 [ 23123 ]
            Fix Version/s 10.6 [ 24028 ]
            Affects Version/s 10.5 [ 23123 ]
            Affects Version/s 10.6 [ 24028 ]
            Labels not-10.5+
            alice Alice Sherepa made changes -
            Status Open [ 1 ] Confirmed [ 10101 ]
            marko Marko Mäkelä added a comment -

            The assertion failure in MDEV-33476.test is related to CREATE TEMPORARY TABLE with SPATIAL INDEX. At the end of the test there is the following section (slightly cleaned up below) where it crashes:

            CREATE  TEMPORARY TABLE tmp LIKE t1;
            		 
            begin;
            		 
            INSERT INTO tmp SELECT * FROM t1;
            		 
            rollback;

            The function rtr_update_mbr_field_in_place() was removed in MDEV-12353.

            marko Marko Mäkelä added a comment - The assertion failure in MDEV-33476.test is related to CREATE TEMPORARY TABLE with SPATIAL INDEX . At the end of the test there is the following section (slightly cleaned up below) where it crashes: CREATE TEMPORARY TABLE tmp LIKE t1; begin ; INSERT INTO tmp SELECT * FROM t1; rollback ; The function rtr_update_mbr_field_in_place() was removed in MDEV-12353 .
            marko Marko Mäkelä made changes -
            Component/s Data Definition - Temporary [ 10123 ]
            Fix Version/s 10.5 [ 23123 ]
            Fix Version/s 10.6 [ 24028 ]
            Affects Version/s 10.5 [ 23123 ]
            Affects Version/s 10.6 [ 24028 ]
            marko Marko Mäkelä made changes -
            issue.field.resolutiondate 2024-04-08 14:05:21.0 2024-04-08 14:05:20.74
            marko Marko Mäkelä made changes -
            Fix Version/s 10.5.2 [ 24030 ]
            Fix Version/s 10.4 [ 22408 ]
            Resolution Won't Fix [ 2 ]
            Status Confirmed [ 10101 ] Closed [ 6 ]
            marko Marko Mäkelä added a comment -

            I filed MDEV-33855 for the unrelated 10.6 bug that danblack mentioned.

            marko Marko Mäkelä added a comment - I filed MDEV-33855 for the unrelated 10.6 bug that danblack mentioned.

            People

              marko Marko Mäkelä
              alice Alice Sherepa
              Votes:
              0 Vote for this issue
              Watchers:
              3 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved:

                Git Integration

                  Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.