10.0	a4b271496888e1f8628d0af36309e352	bld-dan-debug	2016-02-19 12:27:44	2896	nm	Debug run, no --ps-protocol	rpl.rpl_sync	innodb_plugin,mi	

rpl.rpl_sync 'innodb_plugin,mix'         w1 [ fail ]

        Test ended at 2016-02-19 12:29:46

CURRENT_TEST: rpl.rpl_sync

Server [mysqld.2 - pid: 24922, winpid: 24922, exit: 256] failed during test run

Server log from this test:

----------SERVER LOG START-----------

160219 12:29:40 [Note] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld (mysqld 10.0.24-MariaDB-debug) starting as process 24811 ...

160219 12:29:40 [Note] Plugin 'ARCHIVE' is disabled.

160219 12:29:40 [Note] Plugin 'SEQUENCE' is disabled.

160219 12:29:40 [Note] Plugin 'CONNECT' is disabled.

160219 12:29:40 [Note] Plugin 'TEST_SQL_DISCOVERY' is disabled.

160219 12:29:40 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.

160219 12:29:40 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.

160219 12:29:40 [Note] Plugin 'XTRADB_RSEG' is disabled.

160219 12:29:40 [Note] Plugin 'SPHINX' is disabled.

160219 12:29:40 [Note] Plugin 'BLACKHOLE' is disabled.

160219 12:29:40 [Note] Plugin 'FEDERATED' is disabled.

160219 12:29:40 [Note] Plugin 'METADATA_LOCK_INFO' is disabled.

160219 12:29:40 [Note] Plugin 'FEEDBACK' is disabled.

160219 12:29:40 [Note] Plugin 'QUERY_RESPONSE_TIME' is disabled.

160219 12:29:40 [Note] Plugin 'QUERY_RESPONSE_TIME_AUDIT' is disabled.

160219 12:29:40 [Note] Plugin 'LOCALES' is disabled.

160219 12:29:40 [Note] Plugin 'rpl_semi_sync_master' is disabled.

160219 12:29:40 [Note] Plugin 'rpl_semi_sync_slave' is disabled.

160219 12:29:40 [Note] Plugin 'QUERY_CACHE_INFO' is disabled.

160219 12:29:40 [Note] Plugin 'unix_socket' is disabled.

160219 12:29:40 [Note] Plugin 'partition' is disabled.

160219 12:29:40 [Note] InnoDB: Using mutexes to ref count buffer pool pages

2016-02-19 12:29:40 7fa75f5b8780 InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!

2016-02-19 12:29:40 7fa75f5b8780 InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!

160219 12:29:40 [Note] InnoDB: The InnoDB memory heap is disabled

160219 12:29:40 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins

160219 12:29:40 [Note] InnoDB: Memory barrier is not used

160219 12:29:40 [Note] InnoDB: Compressed tables use zlib 1.2.8

160219 12:29:40 [Note] InnoDB: Using CPU crc32 instructions

160219 12:29:40 [Note] InnoDB: Initializing buffer pool, size = 8.0M

160219 12:29:40 [Note] InnoDB: Completed initialization of buffer pool

160219 12:29:40 [Note] InnoDB: Highest supported file format is Barracuda.

160219 12:29:41 [Note] InnoDB: 128 rollback segment(s) are active.

160219 12:29:41 [Note] InnoDB: Waiting for purge to start

160219 12:29:41 [Note] InnoDB: 5.6.29 started; log sequence number 1629444

160219 12:29:41 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_CMP_RESET' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_FT_DELETED' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.

160219 12:29:41 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.

160219 12:29:41 [Warning] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'

160219 12:29:41 [Note] Server socket created on IP: '127.0.0.1'.

160219 12:29:41 [Note] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld: ready for connections.

Version: '10.0.24-MariaDB-debug'  socket: '/opt/buildbot-slave/mariadb/dan_demeter1/build/mysql-test/var/tmp/1/mysqld.2.sock'  port: 16001  Source distribution

160219 12:29:42 [Note] 'CHANGE MASTER TO executed'. Previous state master_host='', master_port='3306', master_log_file='', master_log_pos='4'. New state master_host='127.0.0.1', master_port='16000', master_log_file='master-bin.000001', master_log_pos='4'.

160219 12:29:42 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16000',replication started in log 'master-bin.000001' at position 4

160219 12:29:42 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 4, relay log './slave-relay-bin.000001' position: 4

160219 12:29:43 [Note] Error reading relay log event: slave SQL thread was killed

160219 12:29:43 [ERROR] Error reading packet from server: Lost connection to MySQL server during query ( server_errno=2013)

160219 12:29:43 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 2397

SIGKILL myself

160219 12:29:43 [Note] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld (mysqld 10.0.24-MariaDB-debug) starting as process 24884 ...

160219 12:29:43 [Note] Plugin 'ARCHIVE' is disabled.

160219 12:29:43 [Note] Plugin 'SEQUENCE' is disabled.

160219 12:29:43 [Note] Plugin 'CONNECT' is disabled.

160219 12:29:43 [Note] Plugin 'TEST_SQL_DISCOVERY' is disabled.

160219 12:29:43 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.

160219 12:29:43 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.

160219 12:29:43 [Note] Plugin 'XTRADB_RSEG' is disabled.

160219 12:29:43 [Note] Plugin 'SPHINX' is disabled.

160219 12:29:43 [Note] Plugin 'BLACKHOLE' is disabled.

160219 12:29:43 [Note] Plugin 'FEDERATED' is disabled.

160219 12:29:43 [Note] Plugin 'METADATA_LOCK_INFO' is disabled.

160219 12:29:43 [Note] Plugin 'FEEDBACK' is disabled.

160219 12:29:43 [Note] Plugin 'QUERY_RESPONSE_TIME' is disabled.

160219 12:29:43 [Note] Plugin 'QUERY_RESPONSE_TIME_AUDIT' is disabled.

160219 12:29:43 [Note] Plugin 'LOCALES' is disabled.

160219 12:29:43 [Note] Plugin 'rpl_semi_sync_master' is disabled.

160219 12:29:43 [Note] Plugin 'rpl_semi_sync_slave' is disabled.

160219 12:29:43 [Note] Plugin 'QUERY_CACHE_INFO' is disabled.

160219 12:29:43 [Note] Plugin 'unix_socket' is disabled.

160219 12:29:43 [Note] Plugin 'partition' is disabled.

160219 12:29:43 [Note] InnoDB: Using mutexes to ref count buffer pool pages

2016-02-19 12:29:43 7f5f16089780 InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!

2016-02-19 12:29:43 7f5f16089780 InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!

160219 12:29:43 [Note] InnoDB: The InnoDB memory heap is disabled

160219 12:29:43 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins

160219 12:29:43 [Note] InnoDB: Memory barrier is not used

160219 12:29:43 [Note] InnoDB: Compressed tables use zlib 1.2.8

160219 12:29:43 [Note] InnoDB: Using CPU crc32 instructions

160219 12:29:43 [Note] InnoDB: Initializing buffer pool, size = 8.0M

160219 12:29:43 [Note] InnoDB: Completed initialization of buffer pool

160219 12:29:43 [Note] InnoDB: Highest supported file format is Barracuda.

160219 12:29:43 [Note] InnoDB: Log scan progressed past the checkpoint lsn 1629444

160219 12:29:43 [Note] InnoDB: Database was not shutdown normally!

160219 12:29:43 [Note] InnoDB: Starting crash recovery.

160219 12:29:43 [Note] InnoDB: Reading tablespace information from the .ibd files...

160219 12:29:43 [Note] InnoDB: Restoring possible half-written data pages 

160219 12:29:43 [Note] InnoDB: from the doublewrite buffer...

InnoDB: Doing recovery: scanned up to log sequence number 1643547

160219 12:29:43 [Note] InnoDB: Starting an apply batch of log records to the database...

InnoDB: Progress in percent: 20 21 22 23 24 25 26 27 28 29 30 31 32 33 34 35 36 37 38 39 40 41 42 43 44 45 46 47 48 49 50 51 52 53 54 55 56 57 58 59 60 61 62 63 64 65 66 67 68 69 70 71 72 73 74 75 76 77 78 79 80 81 82 83 84 85 86 87 88 89 90 91 92 93 94 95 96 97 98 99 

InnoDB: Apply batch completed

InnoDB: Last MySQL binlog file position 0 1931, file name ./slave-bin.000001

160219 12:29:45 [Note] InnoDB: 128 rollback segment(s) are active.

160219 12:29:45 [Note] InnoDB: Waiting for purge to start

160219 12:29:45 [Note] InnoDB: 5.6.29 started; log sequence number 1643547

160219 12:29:45 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_CMP_RESET' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_FT_DELETED' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.

160219 12:29:45 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.

160219 12:29:45 [Warning] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'

160219 12:29:45 [Note] Recovering after a crash using slave-bin

160219 12:29:45 [Note] Starting crash recovery...

160219 12:29:45 [Note] Crash recovery finished.

160219 12:29:45 [Note] Server socket created on IP: '127.0.0.1'.

160219 12:29:45 [Warning] Recovery from master pos 1932 and file master-bin.000001.

160219 12:29:45 [Note] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld: ready for connections.

Version: '10.0.24-MariaDB-debug'  socket: '/opt/buildbot-slave/mariadb/dan_demeter1/build/mysql-test/var/tmp/1/mysqld.2.sock'  port: 16001  Source distribution

160219 12:29:45 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16000',replication started in log 'master-bin.000001' at position 1932

160219 12:29:45 [Note] Slave SQL thread initialized, starting replication in log 'master-bin.000001' at position 1932, relay log './slave-relay-bin.000003' position: 4

160219 12:29:46 [Note] Error reading relay log event: slave SQL thread was killed

/opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld: read looped with error 4, aborting thread

160219 12:29:46 [ERROR] Error reading packet from server: Lost connection to MySQL server during query ( server_errno=2013)

160219 12:29:46 [Note] Slave I/O thread exiting, read up to log 'master-bin.000001', position 2397

SIGKILL myself

160219 12:29:46 [Note] /opt/buildbot-slave/mariadb/dan_demeter1/build/sql/mysqld (mysqld 10.0.24-MariaDB-debug) starting as process 24923 ...

160219 12:29:46 [Note] Plugin 'ARCHIVE' is disabled.

160219 12:29:46 [Note] Plugin 'SEQUENCE' is disabled.

160219 12:29:46 [Note] Plugin 'CONNECT' is disabled.

160219 12:29:46 [Note] Plugin 'TEST_SQL_DISCOVERY' is disabled.

160219 12:29:46 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.

160219 12:29:46 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.

160219 12:29:46 [Note] Plugin 'XTRADB_RSEG' is disabled.

160219 12:29:46 [Note] Plugin 'SPHINX' is disabled.

160219 12:29:46 [Note] Plugin 'BLACKHOLE' is disabled.

160219 12:29:46 [Note] Plugin 'FEDERATED' is disabled.

160219 12:29:46 [Note] Plugin 'METADATA_LOCK_INFO' is disabled.

160219 12:29:46 [Note] Plugin 'FEEDBACK' is disabled.

160219 12:29:46 [Note] Plugin 'QUERY_RESPONSE_TIME' is disabled.

160219 12:29:46 [Note] Plugin 'QUERY_RESPONSE_TIME_AUDIT' is disabled.

160219 12:29:46 [Note] Plugin 'LOCALES' is disabled.

160219 12:29:46 [Note] Plugin 'rpl_semi_sync_master' is disabled.

160219 12:29:46 [Note] Plugin 'rpl_semi_sync_slave' is disabled.

160219 12:29:46 [Note] Plugin 'QUERY_CACHE_INFO' is disabled.

160219 12:29:46 [Note] Plugin 'unix_socket' is disabled.

160219 12:29:46 [Note] Plugin 'partition' is disabled.

160219 12:29:46 [Note] InnoDB: Using mutexes to ref count buffer pool pages

2016-02-19 12:29:46 7fd63feb9780 InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!

2016-02-19 12:29:46 7fd63feb9780 InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!

160219 12:29:46 [Note] InnoDB: The InnoDB memory heap is disabled

160219 12:29:46 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins

160219 12:29:46 [Note] InnoDB: Memory barrier is not used

160219 12:29:46 [Note] InnoDB: Compressed tables use zlib 1.2.8

160219 12:29:46 [Note] InnoDB: Using CPU crc32 instructions

160219 12:29:46 [Note] InnoDB: Initializing buffer pool, size = 8.0M

160219 12:29:46 [Note] InnoDB: Completed initialization of buffer pool

160219 12:29:46 [Note] InnoDB: Highest supported file format is Barracuda.

160219 12:29:46 [Note] InnoDB: Log scan progressed past the checkpoint lsn 1629444

160219 12:29:46 [Note] InnoDB: Database was not shutdown normally!

160219 12:29:46 [Note] InnoDB: Starting crash recovery.

160219 12:29:46 [Note] InnoDB: Reading tablespace information from the .ibd files...

160219 12:29:46 [Note] InnoDB: Restoring possible half-written data pages 

160219 12:29:46 [Note] InnoDB: from the doublewrite buffer...

InnoDB: Doing recovery: scanned up to log sequence number 1648475

InnoDB: Database page corruption on disk or a failed

InnoDB: file read of page 334.

InnoDB: You may have to recover from a backup.

2016-02-19 12:29:46 7fd63feb9780 InnoDB: Page dump in ascii and hex (16384 bytes):