last full backup took 45 mins with a bzip2 process using one CPU between 60 and 98% and produced a files.tar.bz2 of 5.5 GB
2010-05-29 01:54:08,838 - INFO in BackupManager.__fillSnapshot(394): Maximum free size required is '7991 MiB 167 KiB 150'.
2010-05-29 01:54:08,839 - INFO in BackupManager.__fillSnapshot(395): Available disk size is '47090 MiB 832 KiB 0'.
2010-05-29 01:54:08,839 - INFO in BackupManager.__fillSnapshot(396): Number of directories: 5422.
2010-05-29 01:54:08,839 - INFO in BackupManager.__fillSnapshot(397): Number of symlinks: 4689.
2010-05-29 01:54:08,839 - INFO in BackupManager.__fillSnapshot(398): Total number of files: 50093.
2010-05-29 01:54:08,840 - INFO in BackupManager.__fillSnapshot(399): Number of files included in snapshot: 50093.
2010-05-29 01:54:08,840 - INFO in BackupManager.__fillSnapshot(400): Number of new files (also included): 0.
2010-05-29 01:54:08,840 - INFO in BackupManager.__fillSnapshot(401): Number of files skipped in incremental snapshot: 0.
2010-05-29 01:54:08,840 - INFO in BackupManager.__fillSnapshot(402): Number of items forced to be excluded: 124.
2010-05-29 01:54:08,841 - INFO in BackupManager.__fillSnapshot(403): Number of items to be excluded by config: 51.
2010-05-29 01:54:08,847 - DEBUG in Snapshot.commitbasefile(545): WARNING: Attempt of committing base file for full snapshot '2010-05-29_01.53.15.785702.lucid.ful'.
2010-05-29 01:54:08,853 - INFO in tar.makeTarFullBackup(326): Launching TAR to make a full backup.
2010-05-29 01:54:08,853 - DEBUG in tar.__prepareTarCommonOpts(241): ['-cS', '--bzip2', '--directory=/', '--ignore-failed-read', '--files-from=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/includes.list.tmp', '--exclude-from=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/excludes.list.tmp', '--file=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/files.tar.bz2']
2010-05-29 01:54:08,853 - DEBUG in tar.__prepareTarCommonOpts(243): Common TAR options : ['-cS', '--bzip2', '--directory=/', '--ignore-failed-read', '--files-from=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/includes.list.tmp', '--exclude-from=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/excludes.list.tmp', '--file=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/files.tar.bz2']
2010-05-29 01:54:08,854 - DEBUG in tar.makeTarFullBackup(338): Snapshot's snarfile: /media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/files.snar
2010-05-29 01:54:08,854 - DEBUG in tar.makeTarFullBackup(339): Temporary snarfile: /tmp/nssbackup/files.snar
2010-05-29 01:54:08,855 - DEBUG in __init__.launch(295): Lauching : ['tar', '-cS', '--bzip2', '--directory=/', '--ignore-failed-read', '--files-from=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/includes.list.tmp', '--exclude-from=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/excludes.list.tmp', '--file=/media/backup/dailybackup/2010-05-29_01.53.15.785702.lucid.ful/files.tar.bz2', '--listed-incremental=/tmp/nssbackup/files.snar']
2010-05-29 02:42:14,935 - DEBUG in tar.makeTarFullBackup(350): TAR Output :
2010-05-29 02:42:14,942 - INFO in tar.__finish_backup(365): TAR has been finished successfully.
2010-05-29 02:42:14,943 - DEBUG in BackupManager.__unsetlockfile(447): Lock file '/var/lock/nssbackup.lock' removed.
2010-05-29 02:42:14,976 - INFO in FuseFAM.terminate(248): Terminating FUSE File Access Manager.
2010-05-29 02:42:15,104 - INFO in BackupManager.endSBsession(482): Backup process finished.
last full backup took 45 mins with a bzip2 process using one CPU between 60 and 98% and produced a files.tar.bz2 of 5.5 GB
2010-05-29 01:54:08,838 - INFO in BackupManager. __fillSnapshot( 394): Maximum free size required is '7991 MiB 167 KiB 150'. __fillSnapshot( 395): Available disk size is '47090 MiB 832 KiB 0'. __fillSnapshot( 396): Number of directories: 5422. __fillSnapshot( 397): Number of symlinks: 4689. __fillSnapshot( 398): Total number of files: 50093. __fillSnapshot( 399): Number of files included in snapshot: 50093. __fillSnapshot( 400): Number of new files (also included): 0. __fillSnapshot( 401): Number of files skipped in incremental snapshot: 0. __fillSnapshot( 402): Number of items forced to be excluded: 124. __fillSnapshot( 403): Number of items to be excluded by config: 51. commitbasefile( 545): WARNING: Attempt of committing base file for full snapshot '2010-05- 29_01.53. 15.785702. lucid.ful' . Backup( 326): Launching TAR to make a full backup. rCommonOpts( 241): ['-cS', '--bzip2', '--directory=/', '--ignore- failed- read', '--files- from=/media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ includes. list.tmp' , '--exclude- from=/media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ excludes. list.tmp' , '--file= /media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ files.tar. bz2'] rCommonOpts( 243): Common TAR options : ['-cS', '--bzip2', '--directory=/', '--ignore- failed- read', '--files- from=/media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ includes. list.tmp' , '--exclude- from=/media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ excludes. list.tmp' , '--file= /media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ files.tar. bz2'] Backup( 338): Snapshot's snarfile: /media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ files.snar Backup( 339): Temporary snarfile: /tmp/nssbackup/ files.snar _.launch( 295): Lauching : ['tar', '-cS', '--bzip2', '--directory=/', '--ignore- failed- read', '--files- from=/media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ includes. list.tmp' , '--exclude- from=/media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ excludes. list.tmp' , '--file= /media/ backup/ dailybackup/ 2010-05- 29_01.53. 15.785702. lucid.ful/ files.tar. bz2', '--listed- incremental= /tmp/nssbackup/ files.snar' ] Backup( 350): TAR Output : backup( 365): TAR has been finished successfully. __unsetlockfile (447): Lock file '/var/lock/ nssbackup. lock' removed. terminate( 248): Terminating FUSE File Access Manager. endSBsession( 482): Backup process finished.
2010-05-29 01:54:08,839 - INFO in BackupManager.
2010-05-29 01:54:08,839 - INFO in BackupManager.
2010-05-29 01:54:08,839 - INFO in BackupManager.
2010-05-29 01:54:08,839 - INFO in BackupManager.
2010-05-29 01:54:08,840 - INFO in BackupManager.
2010-05-29 01:54:08,840 - INFO in BackupManager.
2010-05-29 01:54:08,840 - INFO in BackupManager.
2010-05-29 01:54:08,840 - INFO in BackupManager.
2010-05-29 01:54:08,841 - INFO in BackupManager.
2010-05-29 01:54:08,847 - DEBUG in Snapshot.
2010-05-29 01:54:08,853 - INFO in tar.makeTarFull
2010-05-29 01:54:08,853 - DEBUG in tar.__prepareTa
2010-05-29 01:54:08,853 - DEBUG in tar.__prepareTa
2010-05-29 01:54:08,854 - DEBUG in tar.makeTarFull
2010-05-29 01:54:08,854 - DEBUG in tar.makeTarFull
2010-05-29 01:54:08,855 - DEBUG in __init_
2010-05-29 02:42:14,935 - DEBUG in tar.makeTarFull
2010-05-29 02:42:14,942 - INFO in tar.__finish_
2010-05-29 02:42:14,943 - DEBUG in BackupManager.
2010-05-29 02:42:14,976 - INFO in FuseFAM.
2010-05-29 02:42:15,104 - INFO in BackupManager.