Attachment 229446 Details for Bug 259795 – complete error log

complete error log

galera-error.log (text/plain), 8.52 KB, created by Lapo Luchini on 2021-11-12 11:12:01 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Lapo Luchini

Created: 2021-11-12 11:12:01 UTC

Size: 8.52 KB

patch

obsolete

>2021-11-12 12:08:37 0 [Note] WSREP: wsrep_guess_ip() : 192.168.2.71
>2021-11-12 12:08:37 0 [Note] WSREP: wsrep_guess_ip() : 192.168.2.71
>2021-11-12 12:08:37 0 [Note] WSREP: Server initial position: 00000000-0000-0000-0000-000000000000:-1
>2021-11-12 12:08:37 0 [Note] WSREP: Loading provider /usr/local/lib/libgalera.so initial position: 00000000-0000-0000-0000-000000000000:-1
>2021-11-12 12:08:37 0 [Note] WSREP: wsrep_load(): loading provider library '/usr/local/lib/libgalera.so'
>2021-11-12 12:08:37 0 [Note] WSREP: wsrep_load(): Galera 4.9(rXXXX) by Codership Oy <info@codership.com> loaded successfully.
>2021-11-12 12:08:37 0 [Note] WSREP: CRC-32C: using 64-bit x86 acceleration.
>2021-11-12 12:08:37 0 [Warning] WSREP: Could not open state file for reading: '/var/db/mysql//grastate.dat'
>2021-11-12 12:08:37 0 [Note] WSREP: Found saved state: 00000000-0000-0000-0000-000000000000:-1, safe_to_bootstrap: 1
>2021-11-12 12:08:37 0 [Note] WSREP: GCache DEBUG: opened preamble:
>Version: 0
>UUID: 00000000-0000-0000-0000-000000000000
>Seqno: -1 - -1
>Offset: -1
>Synced: 0
>2021-11-12 12:08:37 0 [Note] WSREP: Skipped GCache ring buffer recovery: could not determine history UUID.
>2021-11-12 12:08:37 0 [Note] WSREP: Passing config to GCS: base_dir = /var/db/mysql/; base_host = 192.168.2.71; base_port = 4567; cert.log_conflicts = no; cert.optimistic_pa = yes; debug = no; evs.auto_evict = 0; evs.delay_margin = PT1S; evs.delayed_keep_period = PT30S; evs.inactive_check_period = PT0.5S; evs.inactive_timeout = PT15S; evs.join_retrans_period = PT1S; evs.max_install_timeouts = 3; evs.send_window = 4; evs.stats_report_period = PT1M; evs.suspect_timeout = PT5S; evs.user_send_window = 2; evs.view_forget_timeout = PT24H; gcache.dir = /var/db/mysql/; gcache.keep_pages_size = 0; gcache.mem_size = 0; gcache.name = galera.cache; gcache.page_size = 128M; gcache.recover = yes; gcache.size = 128M; gcomm.thread_prio = ; gcs.fc_debug = 0; gcs.fc_factor = 1.0; gcs.fc_limit = 16; gcs.fc_master_slave = no; gcs.max_packet_size = 64500; gcs.max_throttle = 0.25; gcs.recv_q_hard_limit = 9223372036854775807; gcs.recv_q_soft_limit = 0.25; gcs.sync_donor = no; gmcast.segment = 0; gmcast.version = 0; pc.announce_timeout = PT3S; pc.checksum = fa
>2021-11-12 12:08:37 0 [Note] WSREP: SR storage init for: table
>2021-11-12 12:08:37 0 [Note] WSREP: wsrep_start_replication
>2021-11-12 12:08:37 0 [Note] WSREP: Start replication
>2021-11-12 12:08:37 0 [Note] WSREP: Connecting with bootstrap option: 1
>2021-11-12 12:08:37 0 [Note] WSREP: Setting GCS initial position to 00000000-0000-0000-0000-000000000000:-1
>2021-11-12 12:08:37 0 [Note] WSREP: protonet asio version 0                                                                                                                                                                                                                                 2021-11-12 12:08:37 0 [Note] WSREP: Using CRC-32C for message checksums.
>2021-11-12 12:08:37 0 [Note] WSREP: backend: asio
>2021-11-12 12:08:37 0 [Note] WSREP: gcomm thread scheduling priority set to other:0
>2021-11-12 12:08:37 0 [Warning] WSREP: access file(/var/db/mysql//gvwstate.dat) failed(No such file or directory)
>2021-11-12 12:08:37 0 [Note] WSREP: restore pc from disk failed
>2021-11-12 12:08:37 0 [Note] WSREP: GMCast version 0
>2021-11-12 12:08:37 0 [Note] WSREP: (e28b84a8-bc39, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
>2021-11-12 12:08:37 0 [Note] WSREP: (e28b84a8-bc39, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
>2021-11-12 12:08:37 0 [Note] WSREP: EVS version 1
>2021-11-12 12:08:37 0 [Note] WSREP: gcomm: bootstrapping new group 'testname'
>2021-11-12 12:08:37 0 [Note] WSREP: start_prim is enabled, turn off pc_recovery
>2021-11-12 12:08:37 0 [Note] WSREP: EVS version upgrade 0 -> 1
>2021-11-12 12:08:37 0 [Note] WSREP: PC protocol upgrade 0 -> 1
>2021-11-12 12:08:37 0 [Note] WSREP: Node e28b84a8-bc39 state prim
>2021-11-12 12:08:37 0 [Note] WSREP: view(view_id(PRIM,e28b84a8-bc39,1) memb {
>        e28b84a8-bc39,0
>} joined {
>} left {
>} partitioned {
>})
>2021-11-12 12:08:37 0 [Note] WSREP: save pc into disk
>2021-11-12 12:08:37 0 [Note] WSREP: discarding pending addr without UUID: tcp://192.168.2.70:4567
>2021-11-12 12:08:37 0 [Note] WSREP: discarding pending addr proto entry 0x802235460
>2021-11-12 12:08:37 0 [Note] WSREP: discarding pending addr without UUID: tcp://192.168.2.71:4567
>2021-11-12 12:08:37 0 [Note] WSREP: discarding pending addr proto entry 0x802235540
>2021-11-12 12:08:37 0 [Note] WSREP: discarding pending addr without UUID: tcp://192.168.2.72:4567
>2021-11-12 12:08:37 0 [Note] WSREP: discarding pending addr proto entry 0x802235620
>2021-11-12 12:08:37 0 [Note] WSREP: gcomm: connected
>2021-11-12 12:08:37 0 [ERROR] WSREP: exception from gcomm, backend must be restarted: failed to set FD_CLOEXEC: 9 (Bad file descriptor)
>         at /wrkdirs/usr/ports/databases/galera26/work/galera-release_26.4.9/galerautils/src/gu_asio_socket_util.hpp:set_fd_options():41
>2021-11-12 12:08:37 0 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
>2021-11-12 12:08:37 0 [Note] WSREP: gcomm: terminating thread                                                                                                                                                                                                                               2021-11-12 12:08:37 0 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
>2021-11-12 12:08:37 0 [Note] WSREP: gcomm: joining thread                                                                                                                                                                                                                                   2021-11-12 12:08:37 0 [Note] WSREP: Opened channel 'testname'                                                                                                                                                                                                                               2021-11-12 12:08:37 0 [Note] WSREP: gcomm: closing backend
>2021-11-12 12:08:37 0 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
>2021-11-12 12:08:37 0 [Note] WSREP: Forced PC close
>2021-11-12 12:08:37 1 [Note] WSREP: wsrep system thread 1, 0x80c438558 starting
>2021-11-12 12:08:37 2 [Note] WSREP: wsrep system thread 2, 0x80c46f398 starting
>2021-11-12 12:08:37 0 [Note] WSREP: Starting new group from scratch: e28c40ce-43a8-11ec-a57a-3fb284dccd0d                                                                                                                                                                                   2021-11-12 12:08:37 0 [Note] WSREP: gcomm: closed
>2021-11-12 12:08:37 1 [Note] WSREP: Starting rollbacker thread 1
>2021-11-12 12:08:37 2 [Note] WSREP: Starting applier thread 2
>2021-11-12 12:08:37 0 [Warning] WSREP: Failed to send state UUID: -53 (Software caused connection abort)
>2021-11-12 12:08:37 0 [Note] WSREP: New SELF-LEAVE.
>2021-11-12 12:08:37 2 [Note] WSREP: Closing send monitor...
>2021-11-12 12:08:37 0 [Note] WSREP: Shifting OPEN -> CLOSED (TO: 0)
>2021-11-12 12:08:37 2 [Note] WSREP: Closed send monitor.
>2021-11-12 12:08:37 0 [Note] WSREP: RECV thread exiting -53: Software caused connection abort
>2021-11-12 12:08:37 2 [Note] WSREP: recv_thread() joined.
>2021-11-12 12:08:37 2 [Note] WSREP: Closing replication queue.
>2021-11-12 12:08:37 2 [Note] WSREP: Closing slave action queue.
>2021-11-12 12:08:37 2 [Note] WSREP: ================================================
>View:
>  id: 00000000-0000-0000-0000-000000000000:-1
>  status: non-primary
>  protocol_version: -1
>  capabilities:
>  final: yes
>  own_index: -1
>  members(0):
>=================================================
>2021-11-12 12:08:37 2 [Note] WSREP: Non-primary view
>2021-11-12 12:08:37 2 [Warning] WSREP: server: fqdn.domain.it unallowed state transition: disconnected -> disconnected
>
>2021-11-12 12:08:37 2 [Note] WSREP: server fqdn.domain.it state change: disconnected -> disconnected
>2021-11-12 12:08:37 2 [Note] WSREP: Server status change disconnected -> disconnected
>2021-11-12 12:08:37 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>2021-11-12 12:08:37 2 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
>2021-11-12 12:08:37 2 [Note] WSREP: Applier thread exiting ret: 6 thd: 2
>2021-11-12 12:08:37 2 [Note] WSREP: closing applier 2
>2021-11-12 12:08:37 2 [Note] WSREP: wsrep system thread: 2, 0x80c46f398 closing
>2021-11-12 12:08:37 2 [Warning] Aborted connection 2 to db: 'unconnected' user: 'unauthenticated' host: '' (This connection closed normally without authentication)
>2021-11-12 12:08:37 2 [Note] WSREP: wsrep running threads now: 1

Actions: View

Attachments on bug 259795: 229446 | 229954