[MDEV-24624] main.lock_tables_lost_commit failed in buildbot with timeout, Trying to lock mutex at sql/sql_base.cc, line 958, when the mutex was already locked Created: 2021-01-19  Updated: 2023-04-11  Resolved: 2023-04-11

Status: Closed
Project: MariaDB Server
Component/s: Storage Engine - InnoDB, Tests
Affects Version/s: 10.2, 10.3, 10.4, 10.5
Fix Version/s: N/A

Type: Bug Priority: Major
Reporter: Alice Sherepa Assignee: Jan Lindström (Inactive)
Resolution: Fixed Votes: 0
Labels: None

Issue Links:
Relates
relates to MDEV-23536 Race condition between KILL and trans... Closed

 Description   

10.5 7c052cdf0bc53f8ee3387186 http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/26495/steps/mtr_emb/logs/stdio

main.lock_tables_lost_commit 'innodb'    w4 [ fail ]
        Test ended at 2021-01-17 10:42:34
 
CURRENT_TEST: main.lock_tables_lost_commit
Warning: /mnt/buildbot/build/mariadb-10.5.9/libmysqld/examples/mysqltest_embedded: unknown variable 'loose-ssl-ca=/mnt/buildbot/build/mariadb-10.5.9/mysql-test/std_data/cacert.pem'
Warning: /mnt/buildbot/build/mariadb-10.5.9/libmysqld/examples/mysqltest_embedded: unknown variable 'loose-ssl-cert=/mnt/buildbot/build/mariadb-10.5.9/mysql-test/std_data/client-cert.pem'
Warning: /mnt/buildbot/build/mariadb-10.5.9/libmysqld/examples/mysqltest_embedded: unknown variable 'loose-ssl-key=/mnt/buildbot/build/mariadb-10.5.9/mysql-test/std_data/client-key.pem'
Warning: /mnt/buildbot/build/mariadb-10.5.9/libmysqld/examples/mysqltest_embedded: unknown option '--loose-skip-ssl'
Got ERROR: "InnoDB: Operating system error number 2 in a file operation." errno: 2000
Got ERROR: "InnoDB: The error means the system cannot find the path specified." errno: 2000
Got ERROR: "InnoDB: If you are installing InnoDB, remember that you must create directories yourself, InnoDB does not create them." errno: 2000
Got ERROR: "InnoDB: Cannot open datafile for read-only: './mysql/innodb_index_stats.ibd' OS error: 71" errno: 2000
Got ERROR: "InnoDB: Operating system error number 2 in a file operation." errno: 2000
Got ERROR: "InnoDB: The error means the system cannot find the path specified." errno: 2000
Got ERROR: "InnoDB: If you are installing InnoDB, remember that you must create directories yourself, InnoDB does not create them." errno: 2000
Got ERROR: "InnoDB: Cannot open datafile for read-only: './mysql/innodb_table_stats.ibd' OS error: 71" errno: 2000
Got ERROR: "InnoDB: Operating system error number 2 in a file operation." errno: 2000
Got ERROR: "InnoDB: The error means the system cannot find the path specified." errno: 2000
Got ERROR: "InnoDB: If you are installing InnoDB, remember that you must create directories yourself, InnoDB does not create them." errno: 2000
Got ERROR: "InnoDB: Cannot open datafile for read-only: './mysql/transaction_registry.ibd' OS error: 71" errno: 2000
safe_mutex: Trying to lock mutex at /home/buildbot/buildbot/build/mariadb-10.5.9/sql/sql_base.cc, line 958, when the mutex was already locked at /home/buildbot/buildbot/build/mariadb-10.5.9/sql/sql_class.cc, line 1645 in thread T@20
mysqltest got signal 6
read_command_buf (0x834c36b8): disc
 
conn->name (0x83754618): con1
 
conn->cur_query (0x837e60d8): INSERT INTO t1 VALUES(10)
 
Attempting backtrace...
stack_bottom = 0x0 thread_stack 0x49000
mysys/stacktrace.c:212(my_print_stacktrace)[0x804f17a5]
client/mysqltest.cc:9024(dump_backtrace())[0x804979e6]
client/mysqltest.cc:9041(signal_handler)[0x80497a24]
addr2line: '': No such file
[0xb77d4c14]
[0xb77d4c31]
??:0(gsignal)[0xb70bee89]
??:0(abort)[0xb70c03e7]
mysys/thr_mutex.c:265(safe_mutex_lock)[0x804ebf8b]
psi/mysql_thread.h:765(inline_mysql_mutex_lock)[0x8086abc3]
sql/sql_base.cc:958(close_thread_table(THD*, TABLE**))[0x8086cbce]
sql/sql_base.cc:919(close_thread_tables(THD*))[0x8086c8d5]
sql/sql_base.cc:2376(Locked_tables_list::unlock_locked_tables(THD*))[0x8086fad7]
sql/sql_class.cc:1562(THD::cleanup(bool))[0x80847b04]
sql/sql_class.cc:1661(THD::free_connection())[0x80847fa1]
sql/sql_class.cc:1731(THD::~THD())[0x808482a0]
sql/sql_class.cc:1792(THD::~THD())[0x80848743]
libmysqld/lib_sql.cc:440(emb_free_embedded_thd)[0x804bd52d]
sql-common/client.c:3515(mysql_close)[0x804a8f72]
client/mysqltest.cc:946(connection_thread)[0x80486276]
??:0(start_thread)[0xb77ab2b5]
??:0(clone)[0xb717a16e]
Writing a core file...

10.2 http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/26370/steps/mtr_ps_emb/logs/stdio



 Comments   
Comment by Ramesh Sivaraman [ 2022-02-04 ]

jplindst MTR test case looks good in latest buildbot run. Local run also looks good.
http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/33580/steps/mtr_ps_emb/logs/stdio
http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/33517/steps/mtr_ps_emb/logs/stdio

10.5.14 fb40a2fabf8d8cf765c83a0b8e609dd893c75ec3 (Debug)

vardir: /test/GAL_MD030222-mariadb-10.5.14-linux-x86_64-dbg/mysql-test/var
Removing old var directory...
Creating var directory '/test/GAL_MD030222-mariadb-10.5.14-linux-x86_64-dbg/mysql-test/var'...
Checking supported features...
MariaDB Version 10.5.14-MariaDB-debug
 - SSL connections supported
 - binaries are debug compiled
 - binaries built with wsrep patch
Collecting tests...
Installing system database...
 
==============================================================================
 
TEST                                      RESULT   TIME (ms) or COMMENT
--------------------------------------------------------------------------
 
worker[1] Using MTR_BUILD_THREAD 300, with reserved ports 16000..16019
main.lock_tables_lost_commit 'innodb'    [ pass ]     30
--------------------------------------------------------------------------
The servers were restarted 0 times
Spent 0.030 of 2 seconds executing testcases
 
Completed: All 1 tests were successful.

Generated at Thu Feb 08 09:31:24 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.