Bug #45411 RPL tests fail to retrieve binlog position on Windows
Submitted: 9 Jun 2009 18:46 Modified: 10 Jan 2013 12:11
Reporter: Alexander Nozdrin Email Updates:
Status: Can't repeat Impact on me:
None 
Category:MySQL Server: Replication Severity:S3 (Non-critical)
Version:5.4 OS:Windows
Assigned to: Assigned Account CPU Architecture:Any
Tags: pb2, test failure, tf54

[9 Jun 2009 18:46] Alexander Nozdrin
Description:
The following tests fail in PB2:
  - rpl.rpl_init_slave
  - rpl.rpl_extraCol_innodb

Symptoms:
CURRENT_TEST: rpl.rpl_extraCol_innodb
mysqltest: In included file ".\extra\rpl_tests\rpl_extraSlave_Col.test": At line 752: failed in 'select master_pos_wait('master-bin.000001', 531, 300)': 2013: Lost connection to MySQL server during query

090605 17:54:24 [Note] Slave: received end packet from server, apparent master shutdown: 
090605 17:54:24 [Note] Slave I/O thread: Failed reading log event, reconnecting to retry, log 'master-bin.000001' at postion 6233

How to repeat:
http://pb2.norway.sun.com/web.py?template=mysql_show_test_failure&test_failure_id=2196302

http://pb2.norway.sun.com/web.py?template=mysql_show_test_failure&test_failure_id=2196306
[6 Oct 2009 18:36] Sveta Smirnova
Backtrace:

ntdll!RtlpLowFragHeapFree
ntdll!RtlFreeHeap
kernel32!HeapFree
mysqld!free [f:\dd\vctools\crt_bld\self_x86\crt\src\free.c @ 110]
mysqld!mysql_create_frm [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\unireg.cc @ 419]
mysqld!rea_create_table [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\unireg.cc @ 505]
mysqld!mysql_create_table_no_lock [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\sql_table.cc @ 3712]
mysqld!create_temporary_table [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\sql_table.cc @ 5903]
mysqld!create_altered_table [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\sql_table.cc @ 5955]
mysqld!mysql_alter_table [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\sql_table.cc @ 7129]
mysqld!mysql_execute_command [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\sql_parse.cc @ 2930]
mysqld!mysql_parse [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\sql_parse.cc @ 5999]
mysqld!Query_log_event::do_apply_event [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\log_event.cc @ 3135]
mysqld!Query_log_event::do_apply_event [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\log_event.cc @ 2936]
mysqld!apply_event_and_update_pos [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\slave.cc @ 2191]
mysqld!exec_relay_log_event [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\slave.cc @ 2318]
mysqld!handle_slave_sql [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\sql\slave.cc @ 3049]
mysqld!pthread_start [g:\pb2\build\sb_0-566648-1244209369.17\mysql-5.4.4-alpha-win-x86\mysys\my_winthread.c @ 61]
mysqld!_callthreadstartex [f:\dd\vctools\crt_bld\self_x86\crt\src\threadex.c @ 348]
mysqld!_threadstartex [f:\dd\vctools\crt_bld\self_x86\crt\src\threadex.c @ 326]
kernel32!BaseThreadInitThunk
ntdll!__RtlUserThreadStart
ntdll!_RtlUserThreadStart

Test output:

rpl.rpl_extraCol_innodb                  [ fail ]
        Test ended at 2009-06-05 16:45:52

CURRENT_TEST: rpl.rpl_extraCol_innodb
mysqltest: In included file ".\extra\rpl_tests\rpl_extraSlave_Col.test": At line 752: failed in 'select master_pos_wait('master-bin.000001', 531, 300)': 2013: Lost connection to MySQL server during query

The result from queries just before the failure was:
< snip >
6	b1b1b1b1b1b1b1b1
*** Select on Slave ****
SELECT * FROM t14a ORDER BY c1;
c1	c4	c5	c6	c7
1	b1b1b1b1b1b1b1b1	Kyle	1	CURRENT_TIMESTAMP
2	b1b1b1b1b1b1b1b1	JOE	1	CURRENT_TIMESTAMP
3	b1b1b1b1b1b1b1b1	QA	1	CURRENT_TIMESTAMP
4	b1b1b1b1b1b1b1b1	NULL	1	CURRENT_TIMESTAMP
5	b1b1b1b1b1b1b1b1	NULL	1	CURRENT_TIMESTAMP
6	b1b1b1b1b1b1b1b1	NULL	1	CURRENT_TIMESTAMP
*** connect to master and drop columns ***
ALTER TABLE t14 DROP COLUMN c2;
ALTER TABLE t14 DROP COLUMN c4;
*** Select from Master ***
SELECT * FROM t14 ORDER BY c1;
c1	c3	c5
1	Replication Testing Extra Col	Kyle
2	This Test Should work	JOE
3	If is does not, I will open a bug	QA
*** Select from Slave ***
[6 Oct 2009 18:39] Sveta Smirnova
Thank you for the report.

Verified as described. Stack trace looks similar to bug #45449
[10 Jan 2013 12:11] Erlend Dahl
Not repeatable on recent sources.