Bug #39900 sporadic pb failure: "Can't open and lock privilege tables: Can't find file:"
Submitted: 7 Oct 2008 8:11 Modified: 30 Mar 2009 16:24
Reporter: Sven Sandberg Email Updates:
Status: Closed Impact on me:
None 
Category:Tests: Replication Severity:S7 (Test Cases)
Version:5.1-rpl OS:Windows (vm-win2003-64-b)
Assigned to: Andrei Elkin CPU Architecture:Any
Tags: 5.1-rpl-green, privileges, pushbuild, sporadic, test failure

[7 Oct 2008 8:11] Sven Sandberg
Description:
Pushbuild fails with strange logs like the following:

-------- BEGIN LOG --------
rpl.rpl000011                            [ fail ]

Got exception in exception handler!
1:57:18 [Warning] The syntax 'for replication startup options' is deprecated and will be removed in MySQL 5.2. Please use 'CHANGE MASTER' instead.
080929 11:57:18 [Note] Plugin 'InnoDB' disabled by command line option
080929 11:57:18 [Note] Event Scheduler: Loaded 0 events
080929 11:57:18 [Note] C:/cygwin/home/pushbuild/pb1/pb/bzr_mysql-5.1-rpl/61/mysql-5.1.30-pb61/sql/release/mysqld.exe: ready for connections.
Version: '5.1.30-pb61-log'  socket: ''  port: 11011  MySQL Pushbuild Edition, build 61
080929 11:57:19 [Note] Slave SQL thread initialized, starting replication in log 'FIRST' at position 0, relay log '.\slave-relay-bin.000001' position: 4
080929 11:57:19 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:11010',replication started in log 'FIRST' at position 4
080929 11:57:21 [Note] C:/cygwin/home/pushbuild/pb1/pb/bzr_mysql-5.1-rpl/61/mysql-5.1.30-pb61/sql/release/mysqld.exe: Normal shutdown

080929 11:57:21 [Note] Event Scheduler: Purging the queue. 0 events
080929 11:57:21 [ERROR] Error reading packet from server: Lost connection to MySQL server during query ( server_errno=2013)
080929 11:57:21 [Note] Slave I/O thread killed while reading event
080929 11:57:21 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 728
080929 11:57:21 [Note] Error reading relay log event: slave SQL thread was killed
080929 11:57:21 [Note] C:/cygwin/home/pushbuild/pb1/pb/bzr_mysql-5.1-rpl/61/mysql-5.1.30-pb61/sql/release/mysqld.exe: Shutdown complete

080929 11:57:21 [Note] Plugin 'InnoDB' disabled by command line option
080929 11:57:21 [Note] Event Scheduler: Loaded 0 events
080929 11:57:21 [Note] C:/cygwin/home/pushbuild/pb1/pb/bzr_mysql-5.1-rpl/61/mysql-5.1.30-pb61/sql/release/mysqld.exe: ready for connections.
Version: '5.1.30-pb61-log'  socket: ''  port: 11011  MySQL Pushbuild Edition, build 61
CURRENT_TEST: rpl.rpl000011
080929 11:57:43 [Warning] The syntax 'for replication startup options' is deprecated and will be removed in MySQL 5.2. Please use 'CHANGE MASTER' instead.
080929 11:57:43 [Note] Plugin 'InnoDB' disabled by command line option
080929 11:57:43 [ERROR] Fatal error: Can't open and lock privilege tables: Can't find file: 'db' (errno: 2)

Failed to start mysqld.2

 - saving 'e:/var-ps_row-101/log/rpl.rpl000011/' to 'e:/var-ps_row-101/log/rpl.rpl000011/'

Retrying test, attempt(2/3)...

-------- END LOG --------

Some notes:

 - the error message is either:

[ERROR] Fatal error: Can't open and lock privilege tables: Can't find file: 'db' (errno: 2)

or:

[ERROR] Fatal error: Can't open and lock privilege tables: Can't find file: 'host' (errno: 2)

 - happens only in 5.1-rpl

 - the first occurrence was in this push: https://intranet.mysql.com/secure/pushbuild/showpush.pl?dir=bzr_mysql-5.1-rpl&order=46

 - happens only on vm-win2003-64-b

 - happens in various tests; rpl tests are more common but it also happens in the main suite

 - it seems to correlate with BUG#39859: both BUG#39859 and this bug can happen on their own, but the combination is more common than could be expected if they were independent

How to repeat:
e.g., rpl.rpl_server_id1 on https://intranet.mysql.com/secure/pushbuild/showpush.pl?dir=bzr_mysql-5.1-rpl&order=61 vm-win2003-64-b/n_mix

xref is really slow when no test case is specified, it can even block intranet.mysql.com . I'll attach a downloaded xref page instead of linking to it.
[7 Oct 2008 8:12] Sven Sandberg
saved xref search

Attachment: xref.pl.html (text/html), 84.87 KiB.

[21 Oct 2008 8:29] Magnus BlÄudd
Fixed october 8 by
https://intranet.mysql.com/secure/pushbuild/showpush.pl?dir=bzr_mysql-5.1-rpl&order=65