intermittent rpl_deadlock_innodb failures

Bug #800035 reported by Laurynas Biveinis
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
MariaDB
New
Undecided
Unassigned
MySQL Server
Unknown
Unknown
Percona Server moved to https://jira.percona.com/projects/PS
Fix Released
High
Stewart Smith
5.1
Fix Released
High
Stewart Smith
5.5
Fix Released
High
Stewart Smith

Bug Description

For example:

http://jenkins.percona.com/job/percona-server-5.5-trunk/BUILD_TYPE=release,Host=ubuntu-maverick-64bit/18/console

rpl.rpl_deadlock_innodb 'mix' w7 [ retry-fail ]
        Test ended at 2011-06-21 03:34:19

CURRENT_TEST: rpl.rpl_deadlock_innodb
mysqltest: In included file "./include/wait_for_slave_param.inc":
included from ./include/wait_for_slave_param.inc at line 115:
included from ./include/wait_for_slave_sql_error.inc at line 41:
included from ./extra/rpl_tests/rpl_deadlock.test at line 84:
At line 115: Timeout in include/wait_for_slave_param.inc

The result from queries just before the failure was:
< snip >
master-bin.000001 845

**** SHOW BINLOG EVENTS on server_1 ****
binlog_name = 'master-bin.000001'
SHOW BINLOG EVENTS IN 'master-bin.000001';
Log_name Pos Event_type Server_id End_log_pos Info
master-bin.000001 4 Format_desc 1 107 Server ver: 5.5.13-log, Binlog ver: 4
master-bin.000001 107 Query 1 224 use `test`; CREATE TABLE t1 (a INT NOT NULL, KEY(a)) ENGINE=innodb
master-bin.000001 224 Query 1 324 use `test`; CREATE TABLE t2 (a INT) ENGINE=innodb
master-bin.000001 324 Query 1 441 use `test`; CREATE TABLE t3 (a INT NOT NULL, KEY(a)) ENGINE=innodb
master-bin.000001 441 Query 1 509 BEGIN
master-bin.000001 509 Query 1 597 use `test`; INSERT INTO t1 VALUES (1)
master-bin.000001 597 Query 1 730 use `test`; INSERT INTO t2 VALUES (2), (2), (2), (2), (2), (2), (2), (2), (2), (2)
master-bin.000001 730 Query 1 818 use `test`; INSERT INTO t3 VALUES (3)
master-bin.000001 818 Xid 1 845 COMMIT /* xid=384 */

**** SHOW RELAYLOG EVENTS on server_1 ****
relaylog_name = 'No such row'
SHOW RELAYLOG EVENTS IN 'No such row';
Log_name Pos Event_type Server_id End_log_pos Info

More results from queries before failure can be found in /mnt/workspace/percona-server-5.5-trunk/BUILD_TYPE/release/Host/ubuntu-maverick-64bit/Percona-Server-5.5.13-rel20.4/mysql-test/var/7/log/rpl_deadlock_innodb.log

 - saving '/mnt/workspace/percona-server-5.5-trunk/BUILD_TYPE/release/Host/ubuntu-maverick-64bit/Percona-Server-5.5.13-rel20.4/mysql-test/var/7/log/rpl.rpl_deadlock_innodb-mix/' to '/mnt/workspace/percona-server-5.5-trunk/BUILD_TYPE/release/Host/ubuntu-maverick-64bit/Percona-Server-5.5.13-rel20.4/mysql-test/var/log/rpl.rpl_deadlock_innodb-mix/'

Another instance on a branch with unrelated change:
http://jenkins.percona.com/job/percona-server-5.5-param/BUILD_TYPE=debug,Host=ubuntu-natty-64bit/8/console

Related branches

Revision history for this message
Stewart Smith (stewart) wrote :

currently trying this patch to see if it may help:

--- a/mysql-test/include/wait_for_slave_param.inc 2011-04-12 22:38:45.000000000 +1000
+++ b/mysql-test/include/wait_for_slave_param.inc 2011-06-21 22:59:13.804854682 +1000
@@ -79,7 +79,7 @@

 # mysqltest doesn't provide any better way to multiply by 10
 --let $_wait_for_slave_param_zero= 0
---let $_slave_timeout_counter= $_slave_timeout$zero
+--let $_slave_timeout_counter= $_slave_timeout$_wait_for_slave_param_zero
 --let $_slave_continue= 1
 while ($_slave_continue)
 {

Revision history for this message
Stewart Smith (stewart) wrote :

Not sure if this affects Maria or not... but it's possible that you may be hitting it, depending on your build+test setup I guess.

Revision history for this message
Shahriyar Rzayev (rzayev-sehriyar) wrote :

Percona now uses JIRA for bug reports so this bug report is migrated to: https://jira.percona.com/browse/PS-485

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.