Test rpl.rpl_backup_locks_mts is unstable
Affects | Status | Importance | Assigned to | Milestone | ||
---|---|---|---|---|---|---|
Percona Server moved to https://jira.percona.com/projects/PS | Status tracked in 5.7 | |||||
5.5 |
Invalid
|
Undecided
|
Unassigned | |||
5.6 |
Fix Released
|
Low
|
Laurynas Biveinis | |||
5.7 |
Fix Released
|
Low
|
Laurynas Biveinis |
Bug Description
On 5.6 trunk:
rpl.rpl_
...
**** SHOW PROCESSLIST on slave ****
SHOW PROCESSLIST;
Id User Host db Command Time State Info Rows_sent Rows_examined
2 root localhost:34887 test Sleep 31 NULL 1 0
3 root localhost:34888 test Sleep 31 NULL 1 0
6 root localhost:34895 test Query 0 init SHOW PROCESSLIST 0 0
7 root localhost:34896 test Sleep 31 NULL 1 0
8 system user NULL Connect 31 Waiting for master to send event NULL 0 0
9 system user NULL Connect 31 Waiting for binlog lock NULL 0 0
10 system user NULL Connect 31 Waiting for an event from Coordinator NULL 0 0
11 system user NULL Connect 31 Waiting for an event from Coordinator NULL 0 0
...
The testcase expects the slave parallel worker threads to wait for the binlog lock, but sometimes it is the SQL coordinator slave thread which waits for it.
summary: |
- Test rpl.rpl_backup_locks is unstable + Test rpl.rpl_backup_locks_mts is unstable |
tags: | added: backup-locks ci |
(lldb) bt kernel. dylib`_ _psynch_ cvwait + 10, stop reason = signal SIGSTOP kernel. dylib`_ _psynch_ cvwait + 10 pthread. dylib`_ pthread_ cond_wait + 767 debug`safe_ cond_timedwait( cond=0x00007fb4 2e846848, mp=0x00007fb42e 8467a8, abstime= 0x0000700000a04 0b8, file="/ Users/laurynas/ percona/ mysql-server/ include/ mysql/psi/ mysql_thread. h", line=1188) + 213 at thr_mutex.c:278 debug`inline_ mysql_cond_ timedwait( that=0x00007fb4 2e846848, mutex=0x00007fb 42e8467a8, abstime= 0x0000700000a04 0b8, src_file= "/Users/ laurynas/ percona/ mysql-server/ sql/mdl. cc", src_line=1439) + 132 at mysql_thread.h:1188 debug`MDL_ wait::timed_ wait(this= 0x00007fb42e846 7a8, owner=0x00007fb 42e846600, abs_timeout= 0x0000700000a04 0b8, set_status_ on_timeout= false, wait_state_ name=0x00000001 09aaf3d0) + 311 at mdl.cc:1438 debug`MDL_ context: :acquire_ lock(this= 0x00007fb42e846 7a8, mdl_request= 0x0000700000a04 190, lock_wait_ timeout= 31536000) + 903 at mdl.cc:2379 debug`Global_ backup_ lock::acquire_ protection( this=0x00007fb4 2e8481b0, thd=0x00007fb42 e846600, duration= MDL_EXPLICIT, lock_wait_ timeout= 31536000) + 279 at lock.cc:1227 debug`Relay_ log_info: :inc_group_ relay_log_ pos(this= 0x00007fb42e820 000, log_pos=0, need_data_ lock=true) + 393 at rpl_rli.cc:997 debug`Relay_ log_info: :stmt_done( this=0x00007fb4 2e820000, event_master_ log_pos= 0) + 374 at rpl_rli.cc:1521 debug`Log_ event:: do_update_ pos(this= 0x00007fb42e007 cf0, rli=0x00007fb42 e820000) + 182 at log_event.cc:875 debug`Format_ description_ log_event: :do_update_ pos(this= 0x00007fb42e007 cf0, rli=0x00007fb42 e820000) + 84 at log_event.cc:5834 debug`Log_ event:: update_ pos(this= 0x00007fb42e007 cf0, rli=0x00007fb42 e820000) + 50 at log_event.h:1577 debug`apply_ event_and_ update_ pos(ptr_ ev=0x0000700000 a046f8, thd=0x00007fb42 e846600, rli=0x00007fb42 e820000) + 2847 at rpl_slave.cc:4143 debug`exec_ relay_log_ event(thd= 0x00007fb42e846 600, rli=0x00007fb42 e820000) + 1352 at rpl_slave.cc:4479 debug`: :handle_ slave_sql( arg=0x00007fb42 c83ca00) + 3442 at rpl_slave.cc:6408 debug`: :pfs_spawn_ thread( arg=0x00007fb42 e0018b0) + 333 at pfs.cc:1860 pthread. dylib`_ pthread_ body + 131 pthread. dylib`_ pthread_ start + 168 pthread. dylib`thread_ start + 13
* thread #25: tid = 0x0018, 0x00007fff95a47db6 libsystem_
* frame #0: 0x00007fff95a47db6 libsystem_
frame #1: 0x00007fff986f4728 libsystem_
frame #2: 0x0000000109377fb5 mysqld-
frame #3: 0x0000000108f5d064 mysqld-
frame #4: 0x0000000108f5cf27 mysqld-
frame #5: 0x0000000108f5e6a7 mysqld-
frame #6: 0x0000000108f4e5d7 mysqld-
frame #7: 0x000000010932bc99 mysqld-
frame #8: 0x000000010932d4c6 mysqld-
frame #9: 0x00000001092916d6 mysqld-
frame #10: 0x00000001092a0714 mysqld-
frame #11: 0x0000000109322d32 mysqld-
frame #12: 0x000000010930ffbf mysqld-
frame #13: 0x0000000109319c88 mysqld-
frame #14: 0x00000001093090e2 mysqld-
frame #15: 0x00000001097553dd mysqld-
frame #16: 0x00007fff986f399d libsystem_
frame #17: 0x00007fff986f391a libsystem_
frame #18: 0x00007fff986f1351 libsystem_