Uploaded image for project: 'MariaDB Server'
  1. MariaDB Server
  2. MDEV-15317

galera_new_cluster does not return error with sst mariabackup or xtrabackup-v2 nevertheless MariaDB-backup or percona-xtrabackup are not installed

    XMLWordPrintable

Details

    • Bug
    • Status: Closed (View Workflow)
    • Major
    • Resolution: Fixed
    • 10.2.13
    • N/A
    • Galera SST
    • None

    Description

      galera_new_cluster does not return error with sst mariabackup or xtrabackup-v2 nevertheless MariaDB-backup or percona-xtrabackup are not installed

      that's followed by joiner nodes not be able to establish cluster but
      the reason to fail to join it's not clear from logs

      with sst
      wsrep_sst_method=mariabackup
      or
      wsrep_sst_method=xtrabackup-v2

      1.run galera_new_cluster on Node where mariabackup or xtrabackup are not installed
      2. join node where the related backup is installed – fails but reason to fail to join it's not clear from logs

      mariabackup --version
      -bash: mariabackup: command not found

      1. xtrabackup --version
        -bash: xtrabackup: command not found
      1. galera_new_cluster

      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Read nil XID from storage engines, skipping position init
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: wsrep_load(): loading provider library '/usr/lib64/galera/libgalera_smm.so'
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: wsrep_load(): Galera 25.3.22(r3764) by Codership Oy <info@codership.com> loaded successfully.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: CRC-32C: using "slicing-by-8" algorithm.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Found saved state: 68dc3337-1198-11e8-b694-afb950b338bc:0, safe_to_bootstrap: 1
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Passing config to GCS: base_dir = /var/lib/mysql/; base_host = 192.168.104.191; base_port = 456            7; cert.log_conflicts = no; 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/lib/mysql/; gcache.keep_pages_s            ize = 0; gcache.mem_size = 0; gcache.name = /var/lib/mysql//galera.cache; gcache.page_size = 128M; gcache.recover = no; 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_throttl            e = 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 = false; p
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Assign initial position for certification: 0, protocol version: -1
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: wsrep_sst_grab()
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Start replication
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: 'wsrep-new-cluster' option used, bootstrapping the cluster
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Setting initial position to 68dc3337-1198-11e8-b694-afb950b338bc:0
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: protonet asio version 0
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Using CRC-32C for message checksums.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: backend: asio
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: gcomm thread scheduling priority set to other:0
      		 
      2018-02-14 17:16:24 140197224081536 [Warning] WSREP: access file(/var/lib/mysql//gvwstate.dat) failed(No such file or directory)
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: restore pc from disk failed
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: GMCast version 0
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: (0526b743, 'tcp://0.0.0.0:4567') listening at tcp://0.0.0.0:4567
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: (0526b743, 'tcp://0.0.0.0:4567') multicast: , ttl: 1
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: EVS version 0
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: gcomm: bootstrapping new group 'cluster1'
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: start_prim is enabled, turn off pc_recovery
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Node 0526b743 state prim
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: view(view_id(PRIM,0526b743,1) memb {
      		 
              0526b743,0
      		 
      } joined {
      		 
      } left {
      		 
      } partitioned {
      		 
      })
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: save pc into disk
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: discarding pending addr without UUID: tcp://192.168.104.191:4567
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: discarding pending addr proto entry 0x55e6b65640c0
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: discarding pending addr without UUID: tcp://192.168.104.196:4567
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: discarding pending addr proto entry 0x55e6b656c870
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: gcomm: connected
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Changing maximum packet size to 64500, resulting msg size: 32636
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Shifting CLOSED -> OPEN (TO: 0)
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Opened channel 'cluster1'
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: Waiting for SST to complete.
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: New COMPONENT: primary = yes, bootstrap = no, my_idx = 0, memb_num = 1
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: STATE_EXCHANGE: sent state UUID: 05278619-119a-11e8-b2d2-1aba46c66d59
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: STATE EXCHANGE: sent state msg: 05278619-119a-11e8-b2d2-1aba46c66d59
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: STATE EXCHANGE: got state msg: 05278619-119a-11e8-b2d2-1aba46c66d59 from 0 (t4w1)
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: Quorum results:
      		 
              version    = 4,
      		 
              component  = PRIMARY,
      		 
              conf_id    = 0,
      		 
              members    = 1/1 (joined/total),
      		 
              act_id     = 0,
      		 
              last_appl. = -1,
      		 
              protocols  = 0/7/3 (gcs/repl/appl),
      		 
              group UUID = 68dc3337-1198-11e8-b694-afb950b338bc
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: Flow-control interval: [16, 16]
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: Trying to continue unpaused monitor
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: Restored state OPEN -> JOINED (0)
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: Member 0.0 (t4w1) synced with group.
      		 
      2018-02-14 17:16:24 140196884485888 [Note] WSREP: Shifting JOINED -> SYNCED (TO: 0)
      		 
      2018-02-14 17:16:24 140197131990784 [Note] WSREP: New cluster view: global state: 68dc3337-1198-11e8-b694-afb950b338bc:0, view# 1: Primary, numbe            r of nodes: 1, my index: 0, protocol version 3
      		 
      2018-02-14 17:16:24 140197224081536 [Note] WSREP: SST complete, seqno: 0
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: For Galera, using innodb_lock_schedule_algorithm=fcfs
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Uses event mutexes
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Compressed tables use zlib 1.2.7
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Using Linux native AIO
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Number of pools: 1
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Using generic crc32 instructions
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Initializing buffer pool, total size = 128M, instances = 1, chunk size = 128M
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Completed initialization of buffer pool
      		 
      2018-02-14 17:16:24 140196001666816 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See t            he man page of setpriority().
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Highest supported file format is Barracuda.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: 128 out of 128 rollback segments are active.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Creating shared tablespace for temporary tables
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: Waiting for purge to start
      		 
      2018-02-14 17:16:24 140197224081536 [Note] InnoDB: 5.7.21 started; log sequence number 1620290
      		 
      2018-02-14 17:16:24 140195626206976 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
      		 
      2018-02-14 17:16:24 140197224081536 [Note] Plugin 'FEEDBACK' is disabled.
      		 
      2018-02-14 17:16:24 140195626206976 [Note] InnoDB: Buffer pool(s) load completed at 180214 17:16:24
      		 
      2018-02-14 17:16:24 140197224081536 [Note] Server socket created on IP: '0.0.0.0'.
      		 
      2018-02-14 17:16:24 140197224081536 [Note] Reading of all Master_info entries succeded
      		 
      2018-02-14 17:16:24 140197224081536 [Note] Added new Master_info '' to hash table
      		 
      2018-02-14 17:16:24 140197224081536 [Note] /usr/sbin/mysqld: ready for connections.
      		 
      Version: '10.2.13-MariaDB'  socket: '/var/lib/mysql/mysql.sock'  port: 3306  MariaDB Server
      		 
      2018-02-14 17:16:24 140197131990784 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.
      		 
      2018-02-14 17:16:24 140197131990784 [Note] WSREP: REPL Protocols: 7 (3, 2)
      		 
      2018-02-14 17:16:24 140197131990784 [Note] WSREP: Assign initial position for certification: 0, protocol version: 3
      		 
      2018-02-14 17:16:24 140196926449408 [Note] WSREP: Service thread queue flushed.
      		 
      2018-02-14 17:16:24 140197131990784 [Note] WSREP: Synchronized with group, ready for connections
      		 
      2018-02-14 17:16:24 140197131990784 [Note] WSREP: wsrep_notify_cmd is not defined, skipping notification.

      Attachments

        Activity

          People

            jplindst Jan Lindström (Inactive)
            winstone Zdravelina Sokolovska (Inactive)
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved:

              Git Integration

                Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.