Details
-
Bug
-
Status: Closed (View Workflow)
-
Critical
-
Resolution: Fixed
-
10.5.2
-
None
-
ubuntu-1604
Description
galera.galera_gra_log failed on CI: "[ERROR] Slave SQL: Error 'Table 't1' already exists'".
|
10.5.2-0 022c86e4b886e4d87cfcbfc5c5c0cdcb7e4eb3fa, RelWithDebInfo, ubuntu-1604 |
galera.galera_gra_log 'innodb' w4 [ fail ]
|
Test ended at 2020-04-10 15:07:51
|
|
|
CURRENT_TEST: galera.galera_gra_log
|
|
|
|
|
Server [mysqld.2 - pid: 17845, winpid: 17845, exit: 256] failed during test run
|
Server log from this test:
|
----------SERVER LOG START-----------
|
2020-04-10 15:07:48 2 [ERROR] Slave SQL: Error 'Table 't1' already exists' on query. Default database: 'test'. Query: 'CREATE TABLE t1 (f1 INTEGER)', Internal MariaDB error code: 1050
|
2020-04-10 15:07:48 2 [Warning] WSREP: Event 1 Query apply failed: 1, seqno 109
|
2020-04-10 15:07:48 0 [Note] WSREP: Member 1(jw-xenial-1604-paiuhs) initiates vote on e80ccc91-7b3c-11ea-947c-4f2fa0a83401:109,83d3ac64c660f550: Table 't1' already exists, Error_code: 1050;
|
2020-04-10 15:07:48 0 [Note] WSREP: Votes over e80ccc91-7b3c-11ea-947c-4f2fa0a83401:109:
|
83d3ac64c660f550: 1/2
|
Waiting for more votes.
|
2020-04-10 15:07:48 0 [Note] WSREP: Member 0(jw-xenial-1604-paiuhs) responds to vote on e80ccc91-7b3c-11ea-947c-4f2fa0a83401:109,0000000000000000: Success
|
2020-04-10 15:07:48 0 [Note] WSREP: Votes over e80ccc91-7b3c-11ea-947c-4f2fa0a83401:109:
|
0000000000000000: 1/2
|
83d3ac64c660f550: 1/2
|
Winner: 0000000000000000
|
2020-04-10 15:07:48 2 [ERROR] WSREP: Inconsistency detected: Inconsistent by consensus on e80ccc91-7b3c-11ea-947c-4f2fa0a83401:109
|
at galera/src/replicator_smm.cpp:process_apply_error():1343
|
2020-04-10 15:07:48 2 [Note] WSREP: Closing send monitor...
|
2020-04-10 15:07:48 2 [Note] WSREP: Closed send monitor.
|
2020-04-10 15:07:48 2 [Note] WSREP: gcomm: terminating thread
|
2020-04-10 15:07:48 2 [Note] WSREP: gcomm: joining thread
|
2020-04-10 15:07:48 2 [Note] WSREP: gcomm: closing backend
|
2020-04-10 15:07:49 2 [Note] WSREP: view(view_id(NON_PRIM,e80bdbc3-bf38,4) memb {
|
f85dcba0-a156,0
|
} joined {
|
} left {
|
} partitioned {
|
e80bdbc3-bf38,0
|
})
|
2020-04-10 15:07:49 2 [Note] WSREP: PC protocol downgrade 1 -> 0
|
2020-04-10 15:07:49 2 [Note] WSREP: view((empty))
|
2020-04-10 15:07:49 2 [Note] WSREP: gcomm: closed
|
2020-04-10 15:07:49 0 [Note] WSREP: New COMPONENT: primary = no, bootstrap = no, my_idx = 0, memb_num = 1
|
2020-04-10 15:07:49 0 [Note] WSREP: Flow-control interval: [16, 16]
|
2020-04-10 15:07:49 0 [Note] WSREP: Received NON-PRIMARY.
|
2020-04-10 15:07:49 0 [Note] WSREP: Shifting SYNCED -> OPEN (TO: 109)
|
2020-04-10 15:07:49 0 [Note] WSREP: New SELF-LEAVE.
|
2020-04-10 15:07:49 0 [Note] WSREP: Flow-control interval: [0, 0]
|
2020-04-10 15:07:49 0 [Note] WSREP: Received SELF-LEAVE. Closing connection.
|
2020-04-10 15:07:49 0 [Note] WSREP: Shifting OPEN -> CLOSED (TO: -1)
|
2020-04-10 15:07:49 0 [Note] WSREP: RECV thread exiting 0: Success
|
2020-04-10 15:07:49 2 [Note] WSREP: recv_thread() joined.
|
2020-04-10 15:07:49 2 [Note] WSREP: Closing replication queue.
|
2020-04-10 15:07:49 2 [Note] WSREP: Closing slave action queue.
|
2020-04-10 15:07:49 2 [Note] WSREP: ================================================
|
View:
|
id: e80ccc91-7b3c-11ea-947c-4f2fa0a83401:-1
|
status: non-primary
|
protocol_version: 4
|
capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
|
final: no
|
own_index: 0
|
members(1):
|
0: f85dcba0-7b3c-11ea-a156-fff5783deb6c, jw-xenial-1604-paiuhs
|
=================================================
|
2020-04-10 15:07:49 2 [Note] WSREP: Non-primary view
|
2020-04-10 15:07:49 2 [Note] WSREP: Server status change synced -> connected
|
2020-04-10 15:07:49 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-04-10 15:07:49 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-04-10 15:07:49 2 [Note] WSREP: ================================================
|
View:
|
id: e80ccc91-7b3c-11ea-947c-4f2fa0a83401:-1
|
status: non-primary
|
protocol_version: 4
|
capabilities: MULTI-MASTER, CERTIFICATION, PARALLEL_APPLYING, REPLAY, ISOLATION, PAUSE, CAUSAL_READ, INCREMENTAL_WS, UNORDERED, PREORDERED, STREAMING, NBO
|
final: yes
|
own_index: -1
|
members(0):
|
=================================================
|
2020-04-10 15:07:49 2 [Note] WSREP: Non-primary view
|
2020-04-10 15:07:49 2 [Note] WSREP: Server status change connected -> disconnected
|
2020-04-10 15:07:49 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-04-10 15:07:49 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
|
2020-04-10 15:07:49 0 [Note] WSREP: Service thread queue flushed.
|
2020-04-10 15:07:49 2 [Note] WSREP: ####### Assign initial position for certification: 00000000-0000-0000-0000-000000000000:-1, protocol version: 5
|
2020-04-10 15:07:49 2 [Note] WSREP: Applier thread exiting ret: 0 thd: 2
|
2020-04-10 15:07:49 2 [Warning] Aborted connection 2 to db: 'unconnected' user: 'unauthenticated' host: '' (This connection closed normally without authentication)
|
2020-04-10 15:07:51 0 [Warning] WSREP: option --wsrep-causal-reads is deprecated
|
2020-04-10 15:07:51 0 [Note] /home/jenkins/workspace/10.5e-MTR-GALERA/BuildType/RelWithDebInfo/label/ubuntu-1604/bin/mysqld (mysqld 10.5.2-0-MariaDB-enterprise-log) starting as process 17846 ...
|
2020-04-10 15:07:51 0 [Warning] Could not increase number of max_open_files to more than 1024 (request: 32190)
|
2020-04-10 15:07:51 0 [Warning] Changed limits: max_open_files: 1024 max_connections: 151 (was 151) table_cache: 421 (was 2000)
|
2020-04-10 15:07:51 0 [Note] mysqld: Aria engine: starting recovery
|
recovered pages: 0%
|
Table ./mysql/event.MAD has wrong LSN: (1,0xaa4b) on page: 1
|
12% 24% 36% 46% 57% 68%
|
Got error 175 when executing record redo_index
|
2020-04-10 15:07:51 0 [ERROR] mysqld: Aria engine: Redo phase failed
|
tables to flush: 1 0
|
2020-04-10 15:07:51 0 [ERROR] mysqld: Aria recovery failed. Please run aria_chk -r on all Aria tables and delete all aria_log.######## files
|
2020-04-10 15:07:51 0 [ERROR] Plugin 'Aria' init function returned error.
|
2020-04-10 15:07:51 0 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
|
2020-04-10 15:07:51 0 [ERROR] Failed to initialize plugins.
|
2020-04-10 15:07:51 0 [ERROR] Aborting
|
----------SERVER LOG END-------------
|
mysqltest failed but provided no output
|
The result from queries just before the failure was:
|
< snip >
|
ROLLBACK/*!*/;
|
ROLLBACK/*!*/;
|
use `test`/*!*/;
|
SET TIMESTAMP=<TIMESTAMP>/*!*/;
|
SET @@session.pseudo_thread_id=<PSEUDO_THREAD_ID>/*!*/;
|
SET @@session.foreign_key_checks=1, @@session.sql_auto_is_null=0, @@session.unique_checks=1, @@session.autocommit=1, @@session.check_constraint_checks=1, @@session.sql_if_exists=0/*!*/;
|
SET @@session.sql_mode=1411383296/*!*/;
|
SET @@session.auto_increment_increment=1, @@session.auto_increment_offset=1/*!*/;
|
/*!\C latin1 *//*!*/;
|
SET @@session.character_set_client=8,@@session.collation_connection=8,@@session.collation_server=8/*!*/;
|
SET @@session.lc_time_names=0/*!*/;
|
SET @@session.collation_database=DEFAULT/*!*/;
|
CREATE TABLE t1 (f1 INTEGER)
|
/*!*/;
|
DELIMITER ;
|
# End of log file
|
ROLLBACK /* added by mysqlbinlog */;
|
/*!50003 SET COMPLETION_TYPE=@OLD_COMPLETION_TYPE*/;
|
/*!50530 SET @@SESSION.PSEUDO_SLAVE_MODE=0*/;
|
Killing server ...
|
|
|
|
|
|
|
- saving '/var/tmp/mtr/4/log/galera.galera_gra_log-innodb/' to '/var/tmp/mtr/log/galera.galera_gra_log-innodb/'
|
***Warnings generated in error logs during shutdown after running tests: galera.galera_gra_log
|
|
|
2020-04-10 15:07:48 2 [ERROR] WSREP: Inconsistency detected: Inconsistent by consensus on e80ccc91-7b3c-11ea-947c-4f2fa0a83401:109
|
2020-04-10 15:07:51 0 [ERROR] mysqld: Aria engine: Redo phase failed
|
2020-04-10 15:07:51 0 [ERROR] mysqld: Aria recovery failed. Please run aria_chk -r on all Aria tables and delete all aria_log.######## files
|
2020-04-10 15:07:51 0 [ERROR] Plugin 'Aria' init function returned error.
|
2020-04-10 15:07:51 0 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
|
2020-04-10 15:07:51 0 [ERROR] Failed to initialize plugins.
|
2020-04-10 15:07:51 0 [ERROR] Aborting
|