CURRENT_TEST: galera.MW-284

2019-11-12 10:06:00 139955606861952 [Note] /__w/1/s/bin/mysqld (mysqld 10.2.29-4-MariaDB-enterprise-log) starting as process 86856 ...

2019-11-12 10:06:00 139955606861952 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4184)

2019-11-12 10:06:00 139955606861952 [Warning] Changed limits: max_open_files: 1024  max_connections: 151 (was 151)  table_cache: 421 (was 2000)

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'partition' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'SEQUENCE' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Uses event mutexes

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Compressed tables use zlib 1.2.11

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Using Linux native AIO

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Number of pools: 1

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Using SSE2 crc32 instructions

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Completed initialization of buffer pool

2019-11-12 10:06:00 139955309364992 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Highest supported file format is Barracuda.

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: 128 out of 128 rollback segments are active.

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Creating shared tablespace for temporary tables

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: File './ibtmp1' size is now 12 MB.

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: Waiting for purge to start

2019-11-12 10:06:00 139955606861952 [Note] InnoDB: 5.7.28 started; log sequence number 1624427

2019-11-12 10:06:00 139955300972288 [Note] InnoDB: Loading buffer pool(s) from /var/tmp/mtr/1/mysqld.3/data/ib_buffer_pool

2019-11-12 10:06:00 139955300972288 [Note] InnoDB: Buffer pool(s) load completed at 191112 10:06:00

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_MUTEXES' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_CMP' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_FT_DELETED' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_CMP_RESET' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'FEEDBACK' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'user_variables' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.

2019-11-12 10:06:00 139955606861952 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.

2019-11-12 10:06:00 139955606861952 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-feedback-debug-startup-interval=20'

2019-11-12 10:06:00 139955606861952 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-feedback-debug-first-interval=60'

2019-11-12 10:06:00 139955606861952 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-feedback-debug-interval=60'

2019-11-12 10:06:00 139955606861952 [Warning] /__w/1/s/bin/mysqld: unknown option '--loose-pam-debug'

2019-11-12 10:06:00 139955606861952 [Warning] /__w/1/s/bin/mysqld: unknown option '--loose-aria'

2019-11-12 10:06:00 139955606861952 [Warning] /__w/1/s/bin/mysqld: unknown variable 'loose-debug-sync-timeout=300'

2019-11-12 10:06:00 139955606861952 [Note] Server socket created on IP: '127.0.0.1'.

2019-11-12 10:06:00 139955606861952 [Note] Reading of all Master_info entries succeeded

2019-11-12 10:06:00 139955606861952 [Note] Added new Master_info '' to hash table

2019-11-12 10:06:00 139955606861952 [Note] /__w/1/s/bin/mysqld: ready for connections.

Version: '10.2.29-4-MariaDB-enterprise-log'  socket: '/var/tmp/mtr/tmp/1/mysqld.3.sock'  port: 16022  MariaDB Enterprise Server

2019-11-12 10:06:07 139955433940736 [Note] Master connection name: ''  Master_info_file: 'master.info'  Relay_info_file: 'relay-log.info'

2019-11-12 10:06:07 139955433940736 [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='16020', master_log_file='', master_log_pos='4'.

2019-11-12 10:06:13 139955433326336 [Note] Slave SQL thread initialized, starting replication in log 'FIRST' at position 0, relay log './mysqld-relay-bin.000001' position: 4

2019-11-12 10:06:13 139955433633536 [Note] Slave I/O thread: connected to master 'root@127.0.0.1:16020',replication started in log 'FIRST' at position 4

2019-11-12 10:06:13 139955433633536 [ERROR] Error reading packet from server: WSREP has not yet prepared node for application use (server_errno=1047)

2019-11-12 10:06:13 139955433633536 [Note] Slave I/O thread: Failed reading log event, reconnecting to retry, log 'FIRST' at position 4

2019-11-12 10:06:13 139955433633536 [ERROR] Error reading packet from server: WSREP has not yet prepared node for application use (server_errno=1047)

2019-11-12 10:06:14 139955433633536 [Note] Slave I/O thread: Failed reading log event, reconnecting to retry, log 'FIRST' at position 4

2019-11-12 10:06:14 139955433633536 [ERROR] Error reading packet from server: WSREP has not yet prepared node for application use (server_errno=1047)

2019-11-12 10:06:15 139955433633536 [Note] Slave I/O thread: Failed reading log event, reconnecting to retry, log 'FIRST' at position 4

2019-11-12 10:06:16 139955433326336 [Note] Error reading relay log event: slave SQL thread was killed

2019-11-12 10:06:16 139955433326336 [Note] Slave SQL thread exiting, replication stopped in log 'mysqld-bin.000002' at position 878

2019-11-12 10:06:16 139955433633536 [Note] Slave I/O thread exiting, read up to log 'mysqld-bin.000002', position 878

2019-11-12 10:06:16 139955433940736 [Note] Deleted Master_info file '/var/tmp/mtr/1/mysqld.3/data/master.info'.

2019-11-12 10:06:16 139955433940736 [Note] Deleted Master_info file '/var/tmp/mtr/1/mysqld.3/data/relay-log.info'.

2019-11-12 10:06:16 139955433633536 [Note] /__w/1/s/bin/mysqld (initiated by: root[root] @ localhost [127.0.0.1]): Normal shutdown

2019-11-12 10:06:16 139955175147264 [Note] InnoDB: FTS optimize thread exiting.

2019-11-12 10:06:16 139955433633536 [Note] Event Scheduler: Purging the queue. 0 events

2019-11-12 10:06:16 139955433633536 [Note] InnoDB: Starting shutdown...

2019-11-12 10:06:16 139955300972288 [Note] InnoDB: Dumping buffer pool(s) to /var/tmp/mtr/1/mysqld.3/data/ib_buffer_pool

2019-11-12 10:06:16 139955300972288 [Note] InnoDB: Instance 0, restricted to 128 pages due to innodb_buf_pool_dump_pct=25

2019-11-12 10:06:16 139955300972288 [Note] InnoDB: Buffer pool(s) dump completed at 191112 10:06:16

2019-11-12 10:06:17 139955433633536 [Note] InnoDB: Shutdown completed; log sequence number 1629269

2019-11-12 10:06:17 139955433633536 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"

2019-11-12 10:06:17 139955433633536 [Note] /__w/1/s/bin/mysqld: Shutdown complete