[MDEV-4223] Galera: InnoDB assertion failure !mutex_own(mutex) in file sync0sync.ic line 207 Created: 2013-03-02  Updated: 2013-11-27  Resolved: 2013-11-27

Status: Closed
Project: MariaDB Server
Component/s: None
Affects Version/s: 5.5.28a-galera
Fix Version/s: 5.5.34-galera

Type: Bug Priority: Major
Reporter: Elena Stepanova Assignee: Jan Lindström (Inactive)
Resolution: Fixed Votes: 0
Labels: galera

Issue Links:
Relates

 Description   

Apparently the patch for MDEV-4176 hasn't fixed the problem completely.

130302  2:35:04  InnoDB: Assertion failure in thread 140316583900928 in file sync0sync.ic line 207
 
InnoDB: Failing assertion: !mutex_own(mutex)
 
InnoDB: We intentionally generate a memory trap.
 

# 2013-03-02T02:35:11 #5  0x00007f9dfec3cb0b in __GI_abort () at abort.c:92
 
# 2013-03-02T02:35:11 #6  0x0000000000a3926f in mutex_enter_func (mutex=0x237a378, file_name=0xe47410 "maria-5.5-galera/storage/xtradb/handler/ha_innodb.cc", line=3868) at maria-5.5-galera/storage/xtradb/include/sync0sync.ic:207
 
# 2013-03-02T02:35:11 #7  0x0000000000a3938e in pfs_mutex_enter_func (mutex=0x237a378, file_name=0xe47410 "maria-5.5-galera/storage/xtradb/handler/ha_innodb.cc", line=3868) at maria-5.5-galera/storage/xtradb/include/sync0sync.ic:251
 
# 2013-03-02T02:35:11 #8  0x0000000000a3f812 in innobase_kill_query (hton=0x22b4bd0, thd=0x7f9dcc0085f0, level=THD_ABORT_SOFTLY) at maria-5.5-galera/storage/xtradb/handler/ha_innodb.cc:3868
 
# 2013-03-02T02:35:11 #9  0x00000000007e728f in kill_handlerton (thd=0x7f9dcc0085f0, plugin=0x7f9e00236af8, level=0x7f9e00236b34) at maria-5.5-galera/sql/handler.cc:685
 
# 2013-03-02T02:35:11 #10 0x0000000000633017 in plugin_foreach_with_mask (thd=0x7f9dcc0085f0, func=0x7e720e <kill_handlerton(THD*, plugin_ref, void*)>, type=1, state_mask=4294967287, arg=0x7f9e00236b34) at maria-5.5-galera/sql/sql_plugin.cc:2351
 
# 2013-03-02T02:35:11 #11 0x00000000007e72e8 in ha_kill_query (thd=0x7f9dcc0085f0, level=THD_ABORT_SOFTLY) at maria-5.5-galera/sql/handler.cc:692
 
# 2013-03-02T02:35:11 #12 0x00000000005de962 in THD::awake (this=0x7f9dcc0085f0, state_to_set=KILL_QUERY) at maria-5.5-galera/sql/sql_class.cc:1844
 
# 2013-03-02T02:35:11 #13 0x00000000005db976 in wsrep_thd_awake (bf_thd=0x0, thd=0x7f9dcc0085f0, signal=1 '\001') at maria-5.5-galera/sql/sql_class.cc:902
 
# 2013-03-02T02:35:11 #14 0x0000000000a528c3 in wsrep_innobase_kill_one_trx (bf_trx=0x0, victim_trx=0x37c59c8, signal=1) at maria-5.5-galera/storage/xtradb/handler/ha_innodb.cc:13670
 
# 2013-03-02T02:35:11 #15 0x0000000000a52f51 in wsrep_abort_transaction (hton=0x22b4bd0, bf_thd=0x7f9dcc01ccb0, victim_thd=0x7f9dcc0085f0, signal=1 '\001') at maria-5.5-galera/storage/xtradb/handler/ha_innodb.cc:13753
 
# 2013-03-02T02:35:11 #16 0x00000000007f054e in ha_wsrep_abort_transaction (bf_thd=0x7f9dcc01ccb0, victim_thd=0x7f9dcc0085f0, signal=1 '\001') at maria-5.5-galera/sql/handler.cc:5342
 
# 2013-03-02T02:35:11 #17 0x000000000062ae9f in wsrep_abort_thd (bf_thd_ptr=0x7f9dcc01ccb0, victim_thd_ptr=0x7f9dcc0085f0, signal=1 '\001') at maria-5.5-galera/sql/sql_parse.cc:8522
 
# 2013-03-02T02:35:11 #18 0x0000000000777811 in wsrep_grant_mdl_exception (requestor_ctx=0x7f9dcc01cda0, ticket=0x3794060) at maria-5.5-galera/sql/wsrep_mysqld.cc:1317
 
# 2013-03-02T02:35:11 #19 0x0000000000727e81 in MDL_lock::can_grant_lock (this=0x3758e90, type_arg=MDL_EXCLUSIVE, requestor_ctx=0x7f9dcc01cda0, ignore_lock_priority=false) at maria-5.5-galera/sql/mdl.cc:1679
 
# 2013-03-02T02:35:11 #20 0x000000000072885a in MDL_context::try_acquire_lock_impl (this=0x7f9dcc01cda0, mdl_request=0x37b2fd8, out_ticket=0x7f9e002388a0) at maria-5.5-galera/sql/mdl.cc:1998
 
# 2013-03-02T02:35:11 #21 0x0000000000728d03 in MDL_context::acquire_lock (this=0x7f9dcc01cda0, mdl_request=0x37b2fd8, lock_wait_timeout=31536000) at maria-5.5-galera/sql/mdl.cc:2152
 
# 2013-03-02T02:35:11 #22 0x00000000007293a8 in MDL_context::acquire_locks (this=0x7f9dcc01cda0, mdl_requests=0x7f9e00238a30, lock_wait_timeout=31536000) at maria-5.5-galera/sql/mdl.cc:2320
 
# 2013-03-02T02:35:11 #23 0x00000000005bcbd5 in lock_table_names (thd=0x7f9dcc01ccb0, tables_start=0x37b25f0, tables_end=0x0, lock_wait_timeout=31536000, flags=128) at maria-5.5-galera/sql/sql_base.cc:4783
 
# 2013-03-02T02:35:11 #24 0x0000000000640d68 in mysql_rename_tables (thd=0x7f9dcc01ccb0, table_list=0x37b25f0, silent=false) at maria-5.5-galera/sql/sql_rename.cc:143
 
# 2013-03-02T02:35:11 #25 0x0000000000621fce in execute_rename_table (thd=0x7f9dcc01ccb0, first_table=0x37b25f0, all_tables=0x37b25f0) at maria-5.5-galera/sql/sql_parse.cc:5083
 
# 2013-03-02T02:35:11 #26 0x000000000061ab25 in mysql_execute_command (thd=0x7f9dcc01ccb0) at maria-5.5-galera/sql/sql_parse.cc:2995
 

Trying to get some variables.
 
Some pointers may be invalid and cause the dump to abort.
 
Query (0x37b2308): RENAME TABLE /* testdb_S . t1_merge2_N  */  /* testdb_N . t1_merge1_N  */  testdb_S . t1_merge2_N TO testdb_N . t1_merge1_N , /* testdb_S . t1_part2_N  */  /* testdb_S . t1_part3_N  */  testdb_S . t1_part2_N TO testdb_S . t1_part3_N
 
Connection ID (thread ID): 67
 
Status: NOT_KILLED

I have a single node started as 

sql/mysqld --no-defaults --basedir=maria-5.5-galera --lc-messages-dir=maria-5.5-galera/sql/share/ --core --datadir=maria-5.5-galera/data1 --tmpdir=maria-5.5-galera/data1/tmp --port=8306 --socket=maria-5.5-galera/data1/tmp/node1.sock --wsrep-provider=galera/libgalera_smm.so --wsrep-cluster-address=gcomm:// --binlog-format=row --wsrep-sst-method=rsync --log-error=maria-5.5-galera/data1/log.err --innodb_autoinc_lock_mode=2 --innodb_locks_unsafe_for_binlog=1 --general-log=1

To reproduce the problem, run the RQG test:

perl ./gentest.pl \
 
--dsn=dbi:mysql:host=127.0.0.1:port=8306:user=root:database=test \
 
--gendata=conf/runtime/concurrency_1.zz \
 
--engine=InnoDB \
 
--threads=4 \
 
--queries=100M \
 
--duration=400 \
 
--grammar=conf/runtime/concurrency_1.yy
 

revision-id: daniel@gandalf-20130301022556-h2fqksol83zg35b2
 
revno: 3386
 
branch-nick: maria-5.5-galera

Server built as cmake . -DCMAKE_BUILD_TYPE=Debug && make

 Comments   
Comment by Elena Stepanova [ 2013-09-28 ]

Still reproducible on 5.5.33a-galera

Comment by Jan Lindström (Inactive) [ 2013-11-27 ]

Fix completed and tested.

Generated at Thu Feb 08 06:54:44 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.