[MDEV-15662] mariabackup.huge_lsn fails sporadically with "log sequence number is in the future" - Jira

Details

Type: Bug
Status: Closed (View Workflow)
Priority: Major
Resolution: Fixed
Affects Version/s: 10.3.5, 10.1(EOL), 10.2(EOL), 10.4(EOL), 10.5
Fix Version/s: 10.1.46, 10.2.33, 10.3.24, 10.4.14, 10.5.5
Component/s: Backup, Tests
Labels:
None
Environment:
CentOS 7.4

Description

maridb mtr mariabackup.huge_lsn test fails with [ERROR] InnoDB: Page [page id: space=0, page number=7] log sequence number 17596481014082 is in the future! Current system log sequence number 17596481010709.

The result from queries just before the failure was:
~~MDEV-13416~~ mariabackup fails with EFAULT "Bad Address"

The result from queries just before the failure was:

# MDEV-13416 mariabackup fails with EFAULT "Bad Address"

FOUND 1 /InnoDB: New log files created, LSN=175964\d{8}/ in mysqld.1.err

CREATE TABLE t(i INT) ENGINE INNODB;

INSERT INTO t VALUES(1);

# xtrabackup backup

SET GLOBAL innodb_flush_log_at_trx_commit=1;

INSERT INTO t VALUES(2);

# xtrabackup prepare

# shutdown server

# remove datadir

# xtrabackup move back

# restart server

SELECT * FROM t;

 - saving '/usr/share/mysql-test/var/log/mariabackup.huge_lsn/' to '/usr/share/mysql-test/var/log/mariabackup.huge_lsn/'

***Warnings generated in error logs during shutdown after running tests: mariabackup.huge_lsn

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=7] log sequence number 17596481014082 is in the future! Current system log sequence number 17596481010709.

mariabackup.huge_lsn                     [ pass ]   7715

mariabackup.huge_lsn                     [ fail ]

        Test ended at 2018-03-22 14:13:30

CURRENT_TEST: mariabackup.huge_lsn

/usr/bin/mariabackup based on MariaDB server 10.3.5-MariaDB Linux (x86_64)

180322 14:13:29 [01] Copying ibdata1 to /usr/share/mysql-test/var/mysqld.1/data/ibdata1

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./xtrabackup_binlog_pos_innodb to /usr/share/mysql-test/var/mysqld.1/data/xtrabackup_binlog_pos_innodb

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./xtrabackup_info to /usr/share/mysql-test/var/mysqld.1/data/xtrabackup_info

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./ib_buffer_pool to /usr/share/mysql-test/var/mysqld.1/data/ib_buffer_pool

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./aria_log_control to /usr/share/mysql-test/var/mysqld.1/data/aria_log_control

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./aria_log.00000001 to /usr/share/mysql-test/var/mysqld.1/data/aria_log.00000001

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/global_suppressions.TRG to /usr/share/mysql-test/var/mysqld.1/data/mtr/global_suppressions.TRG

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/gs_insert.TRN to /usr/share/mysql-test/var/mysqld.1/data/mtr/gs_insert.TRN

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/global_suppressions.MYD to /usr/share/mysql-test/var/mysqld.1/data/mtr/global_suppressions.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/global_suppressions.MYI to /usr/share/mysql-test/var/mysqld.1/data/mtr/global_suppressions.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/global_suppressions.frm to /usr/share/mysql-test/var/mysqld.1/data/mtr/global_suppressions.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/test_suppressions.TRG to /usr/share/mysql-test/var/mysqld.1/data/mtr/test_suppressions.TRG

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/ts_insert.TRN to /usr/share/mysql-test/var/mysqld.1/data/mtr/ts_insert.TRN

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/test_suppressions.MYD to /usr/share/mysql-test/var/mysqld.1/data/mtr/test_suppressions.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/test_suppressions.MYI to /usr/share/mysql-test/var/mysqld.1/data/mtr/test_suppressions.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/test_suppressions.frm to /usr/share/mysql-test/var/mysqld.1/data/mtr/test_suppressions.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mtr/db.opt to /usr/share/mysql-test/var/mysqld.1/data/mtr/db.opt

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./performance_schema/db.opt to /usr/share/mysql-test/var/mysqld.1/data/performance_schema/db.opt

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./test/t.frm to /usr/share/mysql-test/var/mysqld.1/data/test/t.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./test/t.ibd to /usr/share/mysql-test/var/mysqld.1/data/test/t.ibd

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/gtid_slave_pos.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/gtid_slave_pos.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/gtid_slave_pos.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/gtid_slave_pos.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/gtid_slave_pos.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/gtid_slave_pos.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/index_stats.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/index_stats.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/index_stats.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/index_stats.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/index_stats.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/index_stats.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/column_stats.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/column_stats.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/column_stats.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/column_stats.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/column_stats.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/column_stats.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/table_stats.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/table_stats.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/table_stats.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/table_stats.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/table_stats.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/table_stats.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/proxies_priv.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/proxies_priv.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/proxies_priv.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/proxies_priv.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/proxies_priv.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/proxies_priv.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/transaction_registry.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/transaction_registry.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/innodb_index_stats.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/innodb_index_stats.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/innodb_table_stats.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/innodb_table_stats.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/event.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/event.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/event.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/event.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/event.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/event.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/slow_log.CSV to /usr/share/mysql-test/var/mysqld.1/data/mysql/slow_log.CSV

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/slow_log.CSM to /usr/share/mysql-test/var/mysqld.1/data/mysql/slow_log.CSM

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/slow_log.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/slow_log.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/general_log.CSV to /usr/share/mysql-test/var/mysqld.1/data/mysql/general_log.CSV

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/general_log.CSM to /usr/share/mysql-test/var/mysqld.1/data/mysql/general_log.CSM

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/general_log.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/general_log.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/procs_priv.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/procs_priv.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/procs_priv.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/procs_priv.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/procs_priv.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/procs_priv.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/proc.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/proc.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/proc.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/proc.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/proc.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/proc.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_leap_second.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_leap_second.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_leap_second.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_leap_second.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_leap_second.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_leap_second.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_transition_type.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_transition_type.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_transition_type.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_transition_type.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_transition_type.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_transition_type.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_transition.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_transition.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_transition.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_transition.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_transition.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_transition.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_name.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_name.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_name.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_name.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/time_zone_name.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/time_zone_name.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_keyword.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_keyword.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_keyword.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_keyword.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_keyword.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_keyword.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_relation.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_relation.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_relation.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_relation.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_relation.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_relation.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_category.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_category.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_category.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_category.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_category.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_category.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_topic.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_topic.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_topic.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_topic.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/help_topic.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/help_topic.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/columns_priv.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/columns_priv.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/columns_priv.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/columns_priv.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/columns_priv.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/columns_priv.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/tables_priv.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/tables_priv.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/tables_priv.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/tables_priv.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/tables_priv.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/tables_priv.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/servers.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/servers.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/servers.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/servers.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/servers.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/servers.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/plugin.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/plugin.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/plugin.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/plugin.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/plugin.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/plugin.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/func.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/func.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/func.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/func.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/func.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/func.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/roles_mapping.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/roles_mapping.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/roles_mapping.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/roles_mapping.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/roles_mapping.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/roles_mapping.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/user.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/user.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/user.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/user.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/user.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/user.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/host.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/host.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/host.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/host.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/host.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/host.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/db.MYD to /usr/share/mysql-test/var/mysqld.1/data/mysql/db.MYD

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/db.MYI to /usr/share/mysql-test/var/mysqld.1/data/mysql/db.MYI

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/db.frm to /usr/share/mysql-test/var/mysqld.1/data/mysql/db.frm

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/transaction_registry.ibd to /usr/share/mysql-test/var/mysqld.1/data/mysql/transaction_registry.ibd

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/innodb_index_stats.ibd to /usr/share/mysql-test/var/mysqld.1/data/mysql/innodb_index_stats.ibd

180322 14:13:29 [01]        ...done

180322 14:13:29 [01] Copying ./mysql/innodb_table_stats.ibd to /usr/share/mysql-test/var/mysqld.1/data/mysql/innodb_table_stats.ibd

180322 14:13:29 [01]        ...done

180322 14:13:29 completed OK!

mysqltest: At line 50: query 'SELECT * FROM t' failed: 1932: Table 'test.t' doesn't exist in engine

The result from queries just before the failure was:

# MDEV-13416 mariabackup fails with EFAULT "Bad Address"

FOUND 1 /InnoDB: New log files created, LSN=175964\d{8}/ in mysqld.1.err

CREATE TABLE t(i INT) ENGINE INNODB;

INSERT INTO t VALUES(1);

# xtrabackup backup

SET GLOBAL innodb_flush_log_at_trx_commit=1;

INSERT INTO t VALUES(2);

# xtrabackup prepare

# shutdown server

# remove datadir

# xtrabackup move back

# restart server

SELECT * FROM t;

 - saving '/usr/share/mysql-test/var/log/mariabackup.huge_lsn/' to '/usr/share/mysql-test/var/log/mariabackup.huge_lsn/'

***Warnings generated in error logs during shutdown after running tests: mariabackup.huge_lsn

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=7] log sequence number 17596481014082 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=11] log sequence number 17596481015608 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=46] log sequence number 17596481015591 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=309] log sequence number 17596481015591 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=47] log sequence number 17596481014310 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=311] log sequence number 17596481014310 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=8] log sequence number 17596481015623 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=10] log sequence number 17596481015613 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=307] log sequence number 17596481015597 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Page [page id: space=0, page number=308] log sequence number 17596481015603 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:25 1 [ERROR] InnoDB: Page [page id: space=0, page number=9] log sequence number 17596481015618 is in the future! Current system log sequence number 17596481010709.

2018-03-22 14:13:25 1 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=11] log sequence number 17596481015608 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=46] log sequence number 17596481015591 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=309] log sequence number 17596481015591 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=8] log sequence number 17596481015623 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=10] log sequence number 17596481015613 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=307] log sequence number 17596481015597 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Page [page id: space=0, page number=308] log sequence number 17596481015603 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 0 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

2018-03-22 14:13:30 2 [ERROR] InnoDB: Page [page id: space=0, page number=9] log sequence number 17596481015618 is in the future! Current system log sequence number 17596481014805.

2018-03-22 14:13:30 2 [ERROR] InnoDB: Your database may be corrupt or you may have copied the InnoDB tablespace but not the InnoDB log files. Please refer to https://mariadb.com/kb/en/library/xtradbinnodb-recovery-modes/ for information about forcing recovery.

mariabackup.huge_lsn                     [ pass ]   7613

Attachments

- Sort By Name
- Sort By Date
- Ascending
- Descending
- Thumbnails
- List
- Download All

mdev-15562.patch
2020-07-09 10:26
1 kB
Thirunarayanan Balathandayuthapani

Activity

Ascending order - Click to sort in descending order

Marko Mäkelä added a comment - 2018-04-07 01:39

This should be a bug in the test, not in mariabackup. The test is fast-forwarding the LSN of the server, and it is possible that there is some fault in that logic. The test also fails with

./mtr --repeat=2 mariabackup.huge_lsn

Marko Mäkelä added a comment - 2018-04-07 01:39 This should be a bug in the test, not in mariabackup. The test is fast-forwarding the LSN of the server, and it is possible that there is some fault in that logic. The test also fails with ./mtr --repeat=2 mariabackup.huge_lsn

Marko Mäkelä added a comment - 2018-10-22 11:24

Note: The ~~MDEV-15562~~ (instant DROP COLUMN) was mistakenly pushed with this MDEV number.

Marko Mäkelä added a comment - 2018-10-22 11:24 Note: The MDEV-15562 (instant DROP COLUMN) was mistakenly pushed with this MDEV number.

Thirunarayanan Balathandayuthapani added a comment - 2020-07-09 10:27

mdev-15562.patch

The attached patch solves the issue by taking backup of earlier data. Problem is that test case recreates the iblogfile and the ibdata pages could point to
future LSN.

Thirunarayanan Balathandayuthapani added a comment - 2020-07-09 10:27 mdev-15562.patch The attached patch solves the issue by taking backup of earlier data. Problem is that test case recreates the iblogfile and the ibdata pages could point to future LSN.

Marko Mäkelä added a comment - 2020-07-13 06:32

Looks OK. Thank you!

Marko Mäkelä added a comment - 2020-07-13 06:32 Looks OK. Thank you!

People

Assignee:: Thirunarayanan Balathandayuthapani

Reporter:: Zdravelina Sokolovska (Inactive)

Votes:: 0 Vote for this issue

Watchers:: 4 Start watching this issue

Dates

Created:: 2018-03-26 09:19

Updated:: 2020-07-14 07:55

Resolved:: 2020-07-14 07:55

Git Integration

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

MariaDB Server

Details

Description

Attachments

Attachments

Activity

People

Dates

Git Integration