Bug #54121 events_scheduling.test times out sporadically
Submitted: 1 Jun 2010 3:17 Modified: 1 Jun 2010 5:40
Reporter: Alexander Nozdrin Email Updates:
Status: Verified Impact on me:
None 
Category:MySQL Server: General Severity:S2 (Serious)
Version:M3 (Celosia), M4 (Dahlia), 6.0 OS:Any
Assigned to: CPU Architecture:Any
Tags: pb2, sporadic, test failure, timeout
Triage: Triaged: D3 (Medium)

[1 Jun 2010 3:17] Alexander Nozdrin
Description:
events_scheduling times out sporadically.

The timeout usually happens during first run within
the main test suite. The test usually passes second
and third run.

Stack trace:
Thread 4 (process 10366):
#0  0x000000324be0dba8 in do_sigwait () from /lib64/libpthread.so.0
#1  0x000000324be0dc4d in sigwait () from /lib64/libpthread.so.0
#2  0x00000000004fabee in signal_hand (arg=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/mysqld.cc:2949
#3  0x0000000000887a4a in pfs_spawn_thread (arg=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/storage/perfschema/pfs.cc:1011
#4  0x000000324be062f7 in start_thread () from /lib64/libpthread.so.0
#5  0x000000324b2d1b6d in clone () from /lib64/libc.so.6

Thread 3 (process 12210):
#0  0x000000324be0a496 in pthread_cond_wait@@GLIBC_2.3.2 ()
   from /lib64/libpthread.so.0
#1  0x000000000075e44a in Event_scheduler::cond_wait (this=0x1c689410, 
    thd=0x1c639d30, abstime=0x0, msg=<value optimized out>, 
    func=0x98e778 "stop", line=655)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/include/mysql/psi/mysql_thread.h:784
#2  0x000000000075e880 in Event_scheduler::stop (this=0x1c689410)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/event_scheduler.cc:655
#3  0x00000000005e9303 in Events::stop ()
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/events.cc:1040
#4  0x0000000000606e66 in event_scheduler_update (self=<value optimized out>, 
    thd=<value optimized out>, type=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sys_vars.cc:660
#5  0x000000000050b0f9 in sys_var::update (this=0xf7d360, thd=0x1c639d30, 
    var=0x1c68afd8)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/set_var.cc:174
#6  0x000000000050b88a in set_var::update (this=0xfffffffffffffffc, thd=0x0)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/set_var.cc:641
#7  0x000000000050b019 in sql_set_variables (thd=0x1c639d30, 
    var_list=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/set_var.cc:545
#8  0x0000000000567240 in mysql_execute_command (thd=0x1c639d30)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sql_parse.cc:3242
#9  0x000000000056905e in mysql_parse (thd=0x1c639d30, 
    inBuf=0x1c68ae90 "SET GLOBAL event_scheduler=0", length=28, 
    found_semicolon=0x41765a10)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sql_parse.cc:5593
#10 0x000000000056a12f in dispatch_command (command=COM_QUERY, thd=0x1c639d30, 
    packet=0x1c668f31 "SET GLOBAL event_scheduler=0", 
    packet_length=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sql_parse.cc:1023
#11 0x000000000056ad22 in do_command (thd=0x1c639d30)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sql_parse.cc:709
#12 0x00000000005fa1e2 in do_handle_one_connection (thd_arg=0x1c639d30)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sql_connect.cc:1174
#13 0x00000000005fa733 in handle_one_connection (arg=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/sql_connect.cc:1113
#14 0x0000000000887a4a in pfs_spawn_thread (arg=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/storage/perfschema/pfs.cc:1011
#15 0x000000324be062f7 in start_thread () from /lib64/libpthread.so.0
#16 0x000000324b2d1b6d in clone () from /lib64/libc.so.6

Thread 2 (process 12211):
#0  0x000000324be0a496 in pthread_cond_wait@@GLIBC_2.3.2 ()
   from /lib64/libpthread.so.0
#1  0x000000000075fe31 in Event_queue::cond_wait (this=0x1c689330, 
    thd=0x1c7541b0, abstime=0x0, msg=<value optimized out>, 
    func=0x98e9d0 "get_top_for_execution_if_time", line=589)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/include/mysql/psi/mysql_thread.h:784
#2  0x000000000075ff63 in Event_queue::get_top_for_execution_if_time (
    this=0x1c689330, thd=0x1c7541b0, event_name=0x41bcc0a0)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/event_queue.cc:589
#3  0x000000000075f23b in Event_scheduler::run (this=0x1c689410, 
    thd=0x1c7541b0)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/event_scheduler.cc:470
#4  0x000000000075f39d in event_scheduler_thread (arg=0x1c6533b0)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/event_scheduler.cc:238
#5  0x0000000000887a4a in pfs_spawn_thread (arg=<value optimized out>)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/storage/perfschema/pfs.cc:1011
#6  0x000000324be062f7 in start_thread () from /lib64/libpthread.so.0
#7  0x000000324b2d1b6d in clone () from /lib64/libc.so.6

Thread 1 (process 10363):
#0  0x000000324be0b122 in pthread_kill () from /lib64/libpthread.so.0
#1  0x00000000004f7cff in handle_segfault (sig=6)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/mysqld.cc:2748
#2  <signal handler called>
#3  0x000000324b2c9016 in poll () from /lib64/libc.so.6
#4  0x00000000004fb959 in handle_connections_sockets ()
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/mysqld.cc:5401
#5  0x00000000004ffb18 in mysqld_main (argc=46, argv=0x1c5d1c68)
    at /export/home3/pb2/build/sb_2-1476309-1267261428.83/mysql-5.5.99-m3/sql/mysqld.cc:4863
#6  0x000000324b21d8b4 in __libc_start_main () from /lib64/libc.so.6
#7  0x00000000004f6129 in _start ()

How to repeat:
PB XRef: http://tinyurl.com/3yauhk7
[1 Jun 2010 5:40] Sveta Smirnova
Thank you for the report.

Verified using PB link.