MySQL Bugs: #36616: rpl tests without 'source include/have_log

Bug #36616	rpl tests without 'source include/have_log_bin.inc' fail starting server
Submitted:	9 May 2008 8:06	Modified:	30 Jan 2009 17:05
Reporter:	Sven Sandberg	Email Updates:
Status:	Closed	Impact on me:	None
Category:	Tests: Replication	Severity:	S3 (Non-critical)
Version:	5.1-new-rpl	OS:	Any
Assigned to:	Magnus Blåudd	CPU Architecture:	Any
Tags:	51rpl, have_log_bin.inc, master-slave.inc, mysqld died, replication test

Description:
If you create a test case in mysql-test/suite/rpl which does not do 'source include/have_log_bin.inc', it gives the following error message:

mysql-test-run: WARNING: Process [mysqld.2 - pid: 11391, exit: 256] died
rpl.rpl_testbug 'row'          [ fail ]

Notes:
 - The error goes away if the test is moved to mysql-test/t
 - The error does not happen if 'source include/have_log_bin.inc' is done, or if 'source include/master-slave.inc' is done.

How to repeat:
E.g., an empty test case or a test case containing a single line "use test;" will fail this way.

Running with --verbose:

$ ./mtr --verbose rpl_testbug
Logging: ./mtr  --verbose rpl_testbug
Using MR_BUILD_THREAD 12, with reserved ports 10120..10129
> exe_name: mysqld
MySQL Version 5.1.25
Checking supported features...
 - using ndbcluster when necessary, mysqld supports it
 - SSL connections supported
 - binaries are debug compiled
Collecting tests...
> Collecting: main
> testdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/t
> resdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/r
> Collecting: binlog
> suitedir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/binlog
> testdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/binlog/t
> resdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/binlog/r
> Collecting: federated
> suitedir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/federated
> testdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/federated
> resdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/federated
> Collecting: rpl
> suitedir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl
> testdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl/t
> resdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl/r
> Read combinations file
 - adding combinations for rpl
> Collecting: rpl_ndb
> suitedir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl_ndb
> testdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl_ndb/t
> resdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl_ndb/r
> Collecting: ndb
> suitedir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/ndb
> testdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/ndb/t
> resdir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/ndb/r
Checking leftover processes...
Checking ports...
> mtr_ping_port: 10120
> FREE
> mtr_ping_port: 10121
> FREE
> mtr_ping_port: 10122
> FREE
> mtr_ping_port: 10123
> FREE
> mtr_ping_port: 10124
> FREE
> mtr_ping_port: 10125
> FREE
> mtr_ping_port: 10126
> FREE
> mtr_ping_port: 10127
> FREE
> mtr_ping_port: 10128
> FREE
> mtr_ping_port: 10129
> FREE
Removing old var directory...
> opt_vardir: /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/var
> Removing /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/var/
Creating var directory...
> Creating /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/var
Installing system database...
> result: , file_mode: 0

============================================================

TEST                            RESULT        TIME (ms)
------------------------------------------------------------

> Running test: rpl.rpl_testbug
> Setting timezone: GMT-3
> Cleaning datadirs...
> Generating my.cnf from '/home/sven/bk/debug-max/5.1-new-rpl/mysql-test/suite/rpl/my.cnf'
> MASTER_MYPORT = 10120
> MASTER_MYSOCK = /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/var/tmp/mysqld.1.sock
> SLAVE_MYPORT = 10121
> SLAVE_MYSOCK = /home/sven/bk/debug-max/5.1-new-rpl/mysql-test/var/tmp/mysqld.2.sock
> mysqld_start:  [' --loose-skip-innodb', '--loose-skip-log-bin', '--binlog-format=row ']

> Started [mysqld.1 - pid: 11787]
> mysqld_start:  [' --loose-skip-innodb', '--loose-skip-log-bin', '--binlog-format=row ']

> Started [mysqld.2 - pid: 11789]
mysql-test-run: WARNING: Process [mysqld.2 - pid: 11789, exit: 256] died
rpl.rpl_testbug 'row'          [ fail ]

ERROR: Failed to start mysqld.2

mysql-test-run: *** ERROR: Test 'rpl.rpl_testbug' failed. To continue, re-run with '--force'
Killing: [timer - pid: 11785]
Killing: [mysqld.1 - pid: 11787]

Suggested fix:
.

It will now at least show the error log of the server that failed. Will see if anything else can be done.

rpl.rpl_testbug 'row'                    [ fail ]

CURRENT_TEST: rpl.rpl_testbug
080829 14:12:49 [Warning] The syntax 'for replication startup options' is deprecated and will be removed in MySQL 5.2. Please use 'CHANGE MASTER' instead.
080829 14:12:49 [ERROR] You need to use --log-bin to make --log-slave-updates work.
080829 14:12:49 [ERROR] Aborting

080829 14:12:49 [Note] /home/msvensson/mysql/5.1-rpl-latest/sql/mysqld: Shutdown complete

Failed to start mysqld.2

 - saving '/home/msvensson/mysql/5.1-rpl-latest/mysql-test/var/2/log/rpl.rpl_testbug-row/' to '/home/msvensson/mysql/5.1-rpl-latest/mysql-test/var/log/rpl.rpl_testbug-row/'

Only  1  of 3 completed.

A patch for this bug has been committed. After review, it may
be pushed to the relevant source trees for release in the next
version. You can access the patch from:

  http://lists.mysql.com/commits/52900

2665 Magnus Svensson	2008-08-29
      Bug#36616  rpl tests without 'source include/have_log_bin.inc' fail starting server

A patch for this bug has been committed. After review, it may
be pushed to the relevant source trees for release in the next
version. You can access the patch from:

  http://lists.mysql.com/commits/52901

2665 Magnus Svensson	2008-08-29
      Bug#36616  rpl tests without 'source include/have_log_bin.inc' fail starting server

Pushed into 6.0.10-alpha (revid:luis.soares@sun.com-20090129165607-wiskabxm948yx463) (version source revid:luis.soares@sun.com-20090129163120-e2ntks4wgpqde6zt) (merge vers: 6.0.10-alpha) (pib:6)

Pushed into 5.1.32 (revid:luis.soares@sun.com-20090129165946-d6jnnfqfokuzr09y) (version source revid:msvensson@mysql.com-20080829124622-1glj787383smd2pl) (merge vers: 5.1.28) (pib:6)

Test case changes. No changelog entry needed.

Pushed into 5.1.32-ndb-6.3.23 (revid:tomas.ulin@sun.com-20090217131017-6u8qz1edkjfiobef) (version source revid:tomas.ulin@sun.com-20090203133556-9rclp06ol19bmzs4) (merge vers: 5.1.32-ndb-6.3.22) (pib:6)

Pushed into 5.1.32-ndb-6.4.3 (revid:tomas.ulin@sun.com-20090217134419-5ha6xg4dpedrbmau) (version source revid:tomas.ulin@sun.com-20090203133556-9rclp06ol19bmzs4) (merge vers: 5.1.32-ndb-6.3.22) (pib:6)

Pushed into 5.1.32-ndb-6.2.17 (revid:tomas.ulin@sun.com-20090217134216-5699eq74ws4oxa0j) (version source revid:tomas.ulin@sun.com-20090201210519-vehobc4sy3g9s38e) (merge vers: 5.1.32-ndb-6.2.17) (pib:6)