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

Failed test: binlog_encryption.encrypted_master, crash

    XMLWordPrintable

    Details

      Description

      Failed in both ES and CS

      binlog_encryption.encrypted_master 'cbc,innodb,row' w6 [ fail ]
              Test ended at 2020-10-02 12:53:43
       
      CURRENT_TEST: binlog_encryption.encrypted_master
       
       
      Server [mysqld.1 - pid: 27411, winpid: 27411, exit: 256] failed during test run
      Server log from this test:
      ----------SERVER LOG START-----------
      2020-10-02 12:47:47 0 [Note] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd (mysqld 10.5.6-MariaDB-log) starting as process 27414 ...
      2020-10-02 12:47:47 0 [Warning] Could not increase number of max_open_files to more than 1012 (request: 32190)
      2020-10-02 12:47:47 0 [Warning] Changed limits: max_open_files: 1012  max_connections: 151 (was 151)  table_cache: 415 (was 2000)
      2020-10-02 12:47:48 0 [Note] Plugin 'SEQUENCE' is disabled.
      2020-10-02 12:47:48 0 [Note] InnoDB: Using Linux native AIO
      2020-10-02 12:47:48 0 [Note] InnoDB: Uses event mutexes
      2020-10-02 12:47:48 0 [Note] InnoDB: Compressed tables use zlib 1.2.7
      2020-10-02 12:47:49 0 [Note] InnoDB: Number of pools: 1
      2020-10-02 12:47:49 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions
      2020-10-02 12:47:49 0 [Note] mariadbd: O_TMPFILE is not supported on /var/tmp/mtr/tmp/6/mysqld.1 (disabling future attempts)
      2020-10-02 12:47:49 0 [Note] InnoDB: Initializing buffer pool, total size = 8388608, chunk size = 8388608
      2020-10-02 12:47:49 0 [Note] InnoDB: Completed initialization of buffer pool
      2020-10-02 12:47:49 0 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority().
      2020-10-02 12:47:49 0 [Note] InnoDB: 128 rollback segments are active.
      2020-10-02 12:47:50 0 [Note] InnoDB: Creating shared tablespace for temporary tables
      2020-10-02 12:47:50 0 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
      2020-10-02 12:47:50 0 [Note] InnoDB: File './ibtmp1' size is now 12 MB.
      2020-10-02 12:47:50 0 [Note] InnoDB: 10.5.6 started; log sequence number 47235; transaction id 27
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_CMP' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'THREAD_POOL_WAITS' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'THREAD_POOL_QUEUES' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'FEEDBACK' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'THREAD_POOL_GROUPS' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_MUTEXES' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'user_variables' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'THREAD_POOL_STATS' is disabled.
      2020-10-02 12:47:50 0 [Note] Plugin 'unix_socket' is disabled.
      2020-10-02 12:47:50 0 [Note] InnoDB: Loading buffer pool(s) from /var/tmp/mtr/6/mysqld.1/data/ib_buffer_pool
      2020-10-02 12:47:50 0 [Warning] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: unknown variable 'loose-feedback-debug-startup-interval=20'
      2020-10-02 12:47:50 0 [Warning] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: unknown variable 'loose-feedback-debug-first-interval=60'
      2020-10-02 12:47:50 0 [Warning] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: unknown variable 'loose-feedback-debug-interval=60'
      2020-10-02 12:47:50 0 [Warning] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: unknown option '--loose-pam-debug'
      2020-10-02 12:47:50 0 [Warning] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: unknown option '--loose-aria'
      2020-10-02 12:47:50 0 [Warning] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: unknown variable 'loose-debug-sync-timeout=300'
      2020-10-02 12:47:51 0 [Note] InnoDB: Buffer pool(s) load completed at 201002 12:47:51
      2020-10-02 12:47:51 0 [Note] Server socket created on IP: '127.0.0.1'.
      2020-10-02 12:47:52 0 [Note] Reading of all Master_info entries succeeded
      2020-10-02 12:47:52 0 [Note] Added new Master_info '' to hash table
      2020-10-02 12:47:52 0 [Note] /home/timofey_turenko_mariadb_com/MariaDBEnterprise/bin/mariadbd: ready for connections.
      Version: '10.5.6-MariaDB-log'  socket: '/var/tmp/mtr/tmp/6/mysqld.1.sock'  port: 16120  Source distribution
      2020-10-02 12:47:57 6 [Note] Deleted Master_info file '/var/tmp/mtr/6/mysqld.1/data/master.info'.
      2020-10-02 12:47:57 6 [Note] Deleted Master_info file '/var/tmp/mtr/6/mysqld.1/data/relay-log.info'.
      2020-10-02 12:47:58 8 [Note] Start binlog_dump to slave_server(2), pos(master-bin.000001, 4), using_gtid(0), gtid('')
      ----------SERVER LOG END-------------
      mysqltest failed but provided no output
      The result from queries just before the failure was:
      < snip >
      DROP DATABASE database_name_to_encrypt;
      DROP USER new_user_name_to_encrypt;
      DROP SERVER server_name_to_encrypt;
      #############################
      # Final checks for the master
      #############################
      NOT FOUND /_to_encrypt.*/ in master-bin.0*
      NOT FOUND /COMMIT.*/ in master-bin.0*
      NOT FOUND /TIMESTAMP.*/ in master-bin.0*
      include/save_master_pos.inc
      #############################
      # Final checks for the slave
      #############################
      connection server_2;
      include/sync_io_with_master.inc
      FOUND 1 /_to_encrypt.*/ in slave-relay-bin.0*
      FOUND 1 /COMMIT.*/ in slave-relay-bin.0*
      FOUND 1 /TIMESTAMP.*/ in slave-relay-bin.0*
      include/start_slave.inc
      include/sync_slave_sql_with_io.inc
       
       
       
       - saving '/var/tmp/mtr/6/log/binlog_encryption.encrypted_master-cbc,innodb,row/' to '/var/tmp/mtr/log/binlog_encryption.encrypted_master-cbc,innodb,row/'
      

        Attachments

        1. mtr.log
          977 kB
          Timofey Turenko

          Issue Links

            Activity

              People

              Assignee:
              Elkin Andrei Elkin
              Reporter:
              tturenko Timofey Turenko
              Votes:
              0 Vote for this issue
              Watchers:
              3 Start watching this issue

                Dates

                Created:
                Updated: