db/pgbackrest
1
0
Fork 0
mirror of https://github.com/pgbackrest/pgbackrest.git synced 2026-05-22 10:15:16 +02:00
Code Issues Releases Activity

Refactor database version identification for archive and backup commands.

Browse Source 
Added database version constants and changed version identification code to use hash tables instead of if-else.  Propagated the db version constants to the rest of the code and in passing fixed some path/filename constants.

Added new regression tests to check that specific files are never copied.
This commit is contained in:
David Steele
2016-05-14 10:33:12 -04:00
parent 4d9920cc48
commit 512d006346
18 changed files with 483 additions and 378 deletions
Download Patch File Download Diff File Expand all files Collapse all files
test/expect/backup-synthetic-001.log
+16 -10
View File
@@ -39,7 +39,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -273,7 +273,7 @@ full backup (abort backup - local)
DEBUG: BackupInfo->current(): strBackup = [BACKUP-FULL-1]
DEBUG: BackupInfo->current=>: bTest = true
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -374,9 +374,9 @@ start (local)
DEBUG: Common:::Lock::lockRelease(): bFailOnNoLock = false
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --no-compress --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --no-compress --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --force --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: File->new(): iThreadIdx = [undef], oProtocol = [object], strBackupPath = [TEST_PATH]/backrest, strDefaultFileMode = <0640>, strDefaultPathMode = <0750>, strRemote = none, strStanza = db
@@ -389,10 +389,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 0, oManifestHashRef = [hash], strPathFileOp = [undef], strPathOp = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
@@ -689,11 +690,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -769,7 +773,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -990,7 +996,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1212,7 +1218,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-002.log
+15 -9
View File
@@ -39,7 +39,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -251,9 +251,9 @@ db-version="9.3"
1={"db-catalog-version":201306121,"db-control-version":937,"db-system-id":6156904820763115222,"db-version":"9.3"}
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --no-compress --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --no-compress --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --force --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: File->new(): iThreadIdx = [undef], oProtocol = [object], strBackupPath = [TEST_PATH]/backrest, strDefaultFileMode = <0640>, strDefaultPathMode = <0750>, strRemote = none, strStanza = db
@@ -266,10 +266,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 0, oManifestHashRef = [hash], strPathFileOp = [undef], strPathOp = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
@@ -560,11 +561,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -640,7 +644,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -786,7 +792,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1032,7 +1038,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-003.log
+15 -9
View File
@@ -39,7 +39,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -249,9 +249,9 @@ db-version="9.3"
1={"db-catalog-version":201306121,"db-control-version":937,"db-system-id":6156904820763115222,"db-version":"9.3"}
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --force --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: File->new(): iThreadIdx = [undef], oProtocol = [object], strBackupPath = [TEST_PATH]/backrest, strDefaultFileMode = <0640>, strDefaultPathMode = <0750>, strRemote = none, strStanza = db
@@ -264,10 +264,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 0, oManifestHashRef = [hash], strPathFileOp = [undef], strPathOp = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
@@ -556,11 +557,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -636,7 +640,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -782,7 +788,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1003,7 +1009,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-004.log
+15 -9
View File
@@ -39,7 +39,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -250,9 +250,9 @@ db-version="9.3"
1={"db-catalog-version":201306121,"db-control-version":937,"db-system-id":6156904820763115222,"db-version":"9.3"}
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/db/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --config=[TEST_PATH]/db/pgbackrest.conf --config-remote=[TEST_PATH]/backrest/pgbackrest.conf --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --force --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: File->new(): iThreadIdx = [undef], oProtocol = [object], strBackupPath = [TEST_PATH]/backrest, strDefaultFileMode = <0640>, strDefaultPathMode = <0750>, strRemote = none, strStanza = db
@@ -265,10 +265,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 0, oManifestHashRef = [hash], strPathFileOp = [undef], strPathOp = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
@@ -558,11 +559,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -638,7 +642,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -784,7 +790,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1029,7 +1035,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-005.log
+18 -12
View File
@@ -41,7 +41,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -280,7 +280,7 @@ full backup (protocol timeout)
DEBUG: BackupInfo->current(): strBackup = [BACKUP-FULL-1]
DEBUG: BackupInfo->current=>: bTest = true
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -336,7 +336,7 @@ full backup (abort backup - local)
DEBUG: BackupInfo->current(): strBackup = [BACKUP-FULL-1]
DEBUG: BackupInfo->current=>: bTest = true
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -478,7 +478,7 @@ full backup (abort backup - remote)
DEBUG: BackupInfo->current(): strBackup = [BACKUP-FULL-1]
DEBUG: BackupInfo->current=>: bTest = true
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -539,9 +539,9 @@ start (remote)
DEBUG: Common:::Lock::lockRelease(): bFailOnNoLock = false
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --cmd-remote=[BACKREST_BIN] --no-compress --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --cmd-remote=[BACKREST_BIN] --no-compress --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --force --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: Protocol::RemoteMaster->new(): iBufferMax = 4194304, iCompressLevel = 6, iCompressLevelNetwork = 3, iProtocolTimeout = 1830, strCommand = [BACKREST_BIN] --command=backup --config=[TEST_PATH]/db/pgbackrest.conf --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --repo-path=[TEST_PATH]/backrest --stanza=db remote, strHost = 127.0.0.1, strUser = [USER-1]
@@ -556,10 +556,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common, strPathType = db:absolute
@@ -869,11 +870,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -949,7 +953,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -1097,7 +1103,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1330,7 +1336,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-006.log
+15 -9
View File
@@ -41,7 +41,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -264,9 +264,9 @@ db-version="9.3"
1={"db-catalog-version":201306121,"db-control-version":937,"db-system-id":6156904820763115222,"db-version":"9.3"}
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --cmd-remote=[BACKREST_BIN] --no-compress --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --cmd-remote=[BACKREST_BIN] --no-compress --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --force --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: Protocol::RemoteMaster->new(): iBufferMax = 4194304, iCompressLevel = 6, iCompressLevelNetwork = 3, iProtocolTimeout = 1830, strCommand = [BACKREST_BIN] --command=backup --config=[TEST_PATH]/db/pgbackrest.conf --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --repo-path=[TEST_PATH]/backrest --stanza=db remote, strHost = 127.0.0.1, strUser = [USER-1]
@@ -281,10 +281,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common, strPathType = db:absolute
@@ -588,11 +589,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -668,7 +672,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -816,7 +822,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1073,7 +1079,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-007.log
+15 -9
View File
@@ -41,7 +41,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -261,9 +261,9 @@ db-version="9.3"
1={"db-catalog-version":201306121,"db-control-version":937,"db-system-id":6156904820763115222,"db-version":"9.3"}
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --cmd-remote=[BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --cmd-remote=[BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --force --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: Protocol::RemoteMaster->new(): iBufferMax = 4194304, iCompressLevel = 6, iCompressLevelNetwork = 3, iProtocolTimeout = 1830, strCommand = [BACKREST_BIN] --command=backup --config=[TEST_PATH]/db/pgbackrest.conf --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --repo-path=[TEST_PATH]/backrest --stanza=db remote, strHost = 127.0.0.1, strUser = [USER-1]
@@ -278,10 +278,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common, strPathType = db:absolute
@@ -582,11 +583,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -662,7 +666,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -810,7 +816,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1041,7 +1047,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
test/expect/backup-synthetic-008.log
+15 -9
View File
@@ -41,7 +41,7 @@ full backup
DEBUG: BackupCommon::backupRegExpGet(): bAnchor = <true>, bDifferential = true, bFull = true, bIncremental = true
DEBUG: BackupCommon::backupRegExpGet=>: strRegExp = ^[0-9]{8}\-[0-9]{6}F(\_[0-9]{8}\-[0-9]{6}(D|I)){0,1}$
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -262,9 +262,9 @@ db-version="9.3"
1={"db-catalog-version":201306121,"db-control-version":937,"db-system-id":6156904820763115222,"db-version":"9.3"}
full backup (resume)
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
> [BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --no-online --force --type=full --stanza=db backup --test --test-delay=0.2 --test-point=backup-resume=y
------------------------------------------------------------------------------------------------------------------------------------
INFO: backup start: --cmd-remote=[BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
INFO: backup start: --cmd-remote=[BACKREST_BIN] --config=[TEST_PATH]/backrest/pgbackrest.conf --config-remote=[TEST_PATH]/db/pgbackrest.conf --db-host=127.0.0.1 --db-path=[TEST_PATH]/db/common --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --db-user=vagrant --force --hardlink --lock-path=[TEST_PATH]/backrest/lock --log-level-console=debug --log-level-file=trace --log-path=[TEST_PATH]/backrest/log --no-online --repo-path=[TEST_PATH]/backrest --stanza=db --start-fast --test --test-delay=0.2 --test-point=backup-resume=y --type=full
DEBUG: Common:::Lock::lockAquire(): bFailOnNoLock = <true>, bRemote = <false>, iProcessIdx = [undef], strLockType = backup
DEBUG: Common:::Lock::lockAquire=>: bResult = true
DEBUG: Protocol::RemoteMaster->new(): iBufferMax = 4194304, iCompressLevel = 6, iCompressLevelNetwork = 3, iProtocolTimeout = 1830, strCommand = [BACKREST_BIN] --command=backup --config=[TEST_PATH]/db/pgbackrest.conf --db-port=[PORT-1] --db-socket-path=[TEST_PATH]/db --repo-path=[TEST_PATH]/backrest --stanza=db remote, strHost = 127.0.0.1, strUser = [USER-1]
@@ -279,10 +279,11 @@ full backup (resume)
WARN: backup [BACKUP-FULL-1] missing in repository removed from backup.info
DEBUG: BackupInfo->delete(): strBackupLabel = [BACKUP-FULL-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
WARN: --no-online passed and postmaster.pid exists but --force was passed so backup will continue though it looks like the postmaster is running and the backup will probably not be consistent
DEBUG: Manifest->build(): bOnline = false, bTablespace = [undef], oDatabaseMapRef = [undef], oFile = [object], oLastManifest = [undef], oTablespaceMapRef = [undef], strFilter = [undef], strLevel = [undef], strParentPath = [undef], strPath = [TEST_PATH]/db/common
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common/pg_tblspc, strPathType = db:absolute
DEBUG: File->manifest(): oManifestHashRef = [hash], strPath = [TEST_PATH]/db/common, strPathType = db:absolute
@@ -584,11 +585,14 @@ DETAIL: check [TEST_PATH]/db/pg_config exists
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = deleteme, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = global, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DEBUG: File->manifestRecurse(): iDepth = 1, oManifestHashRef = [hash], strPathFileOp = pg_tblspc, strPathOp = [TEST_PATH]/db/common, strPathType = db:absolute
DETAIL: remove file [TEST_PATH]/db/common/recovery.done
DETAIL: preserve file [TEST_PATH]/db/common/recovery.conf
DETAIL: remove link [TEST_PATH]/db/common/pg_stat - destination changed
DETAIL: remove file [TEST_PATH]/db/common/deleteme/deleteme.txt
DETAIL: remove path [TEST_PATH]/db/common/deleteme
DETAIL: set mode 0700 on [TEST_PATH]/db/common/base
INFO: cleanup removed 1 file, 1 path
DETAIL: remove file [TEST_PATH]/db/common/backup_label.old
INFO: cleanup removed 3 files, 1 path
DEBUG: Restore->build(): oManifest = [object]
DEBUG: File->exists(): strPath = [TEST_PATH]/db/pg_stat, strPathType = db:absolute
DEBUG: File->exists=>: bExists = true
@@ -664,7 +668,9 @@ DETAIL: restore file [TEST_PATH]/db/common/base/1/PG_VERSION - exists and matche
DEBUG: File->hashSize=>: iSize = 3, strHash = e1f7a3a299f62225cba076fc6d3d6e677f303482
DETAIL: restore file [TEST_PATH]/db/common/PG_VERSION - exists and matches backup (3B, 100%) checksum e1f7a3a299f62225cba076fc6d3d6e677f303482
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
DEBUG: File->exists=>: bExists = true
DEBUG: File->remove(): bIgnoreMissing = <true>, bTemp = [undef], strPath = [TEST_PATH]/db/common/recovery.conf, strPathType = db:absolute
DEBUG: File->remove=>: bRemoved = true
INFO: wrote [TEST_PATH]/db/common/recovery.conf
INFO: restore global/pg_control (copied last to ensure aborted restores cannot be started)
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/global/pg_control, strPathType = db:absolute
@@ -812,7 +818,7 @@ incr backup (add tablespace 1)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false
@@ -1067,7 +1073,7 @@ incr backup (resume and add tablespace 2)
DEBUG: BackupInfo->last=>: strBackup = [BACKUP-FULL-2]
INFO: last backup label = [BACKUP-FULL-2], version = [VERSION-1]
DEBUG: Db->info(): oFile = [object], strDbPath = [TEST_PATH]/db/common
DEBUG: Db->info=>: fDbVersion = 9.3, iCatalogVersion = 201306121, iControlVersion = 937, ullDbSysId = 6156904820763115222
DEBUG: Db->info=>: iCatalogVersion = 201306121, iControlVersion = 937, strDbVersion = 9.3, ullDbSysId = 6156904820763115222
DEBUG: BackupInfo->check=>: iDbHistoryId = 1
DEBUG: File->exists(): strPath = [TEST_PATH]/db/common/postmaster.pid, strPathType = db:absolute
DEBUG: File->exists=>: bExists = false