[Nssbackup-team] [Bug 585358] Re: Merge of incremental snapshot metadata is much too slow (Python process runs 100% CPU)
-Processors- Intel(R) Core(TM)2 CPU 6600 @ 2.40GHz : 1596.00MHz Intel(R) Core(TM)2 CPU 6600 @ 2.40GHz : 1596.00MHz -Memory- Total Memory: 2035272 kB last incremental backup 2010-05-28 21:50:49,315 - INFO in BackupManager.__fillSnapshot(394): Maximum free size required is '393 MiB 139 KiB 847'. 2010-05-28 21:50:49,316 - INFO in BackupManager.__fillSnapshot(395): Available disk size is '47189 MiB 780 KiB 0'. 2010-05-28 21:50:49,316 - INFO in BackupManager.__fillSnapshot(396): Number of directories: 5421. 2010-05-28 21:50:49,317 - INFO in BackupManager.__fillSnapshot(397): Number of symlinks: 4688. 2010-05-28 21:50:49,317 - INFO in BackupManager.__fillSnapshot(398): Total number of files: 50092. 2010-05-28 21:50:49,318 - INFO in BackupManager.__fillSnapshot(399): Number of files included in snapshot: 376. 2010-05-28 21:50:49,318 - INFO in BackupManager.__fillSnapshot(400): Number of new files (also included): 51. 2010-05-28 21:50:49,318 - INFO in BackupManager.__fillSnapshot(401): Number of files skipped in incremental snapshot: 49716. 2010-05-28 21:50:49,320 - INFO in BackupManager.__fillSnapshot(402): Number of items forced to be excluded: 125. 2010-05-28 21:50:49,320 - INFO in BackupManager.__fillSnapshot(403): Number of items to be excluded by config: 51. 2010-05-28 21:50:49,341 - INFO in tar.makeTarIncBackup(272): Launching TAR to make incremental backup. 2010-05-28 21:50:49,341 - DEBUG in tar.__prepareTarCommonOpts(241): ['-cS', '--bzip2', '--directory=/', '--ignore-failed-read', '--files-from=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/includes.list.tmp', '--exclude-from=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/excludes.list.tmp', '--file=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/files.tar.bz2'] 2010-05-28 21:50:49,341 - DEBUG in tar.__prepareTarCommonOpts(243): Common TAR options : ['-cS', '--bzip2', '--directory=/', '--ignore-failed-read', '--files-from=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/includes.list.tmp', '--exclude-from=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/excludes.list.tmp', '--file=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/files.tar.bz2'] 2010-05-28 21:50:49,342 - DEBUG in tar.makeTarIncBackup(285): Snapshot's base snarfile: /media/backup/dailybackup/2010-05-28_07.23.53.568803.lucid.inc/files.snar 2010-05-28 21:50:49,342 - DEBUG in tar.makeTarIncBackup(286): Snapshot's snarfile: /media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/files.snar 2010-05-28 21:50:49,342 - DEBUG in tar.makeTarIncBackup(287): Temporary snarfile: /tmp/nssbackup/files.snar 2010-05-28 21:50:49,347 - DEBUG in __init__.launch(295): Lauching : ['tar', '-cS', '--bzip2', '--directory=/', '--ignore-failed-read', '--files-from=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/includes.list.tmp', '--exclude-from=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/excludes.list.tmp', '--file=/media/backup/dailybackup/2010-05-28_21.49.36.643084.lucid.inc/files.tar.bz2', '--listed-incremental=/tmp/nssbackup/files.snar'] files.snar : 1.7 MB (1781181 bytes) I don't know how long the full backup takes. I guess 20 mins ... - just a guess. -- Merge of incremental snapshot metadata is much too slow (Python process runs 100% CPU) https://bugs.launchpad.net/bugs/585358 You received this bug notification because you are a member of NSsbackup team, which is subscribed to NSsbackup. ___ Mailing list: https://launchpad.net/~nssbackup-team Post to : nssbackup-team@lists.launchpad.net Unsubscribe : https://launchpad.net/~nssbackup-team More help : https://help.launchpad.net/ListHelp
[Nssbackup-team] [Bug 585358] [NEW] nssbackup causes python process to run on 100% CPU in a loop
Public bug reported: Since 2 days backups fails and nssbackupd causes at startup a 100% CPU load with a process called python and the process doesn't lead anywhere. It needs to be killed to bring computer back to normal state. Lucid 32 bit fully updated Not So Simple Backup Suite 0.2-0 python 2.6.5-0ubuntu1 http://ppa.launchpad.net/nssbackup-team/ppa/ubuntu log: NSSBackup 'Default Profile' Logger == ** Affects: nssbackup Importance: Undecided Status: New -- nssbackup causes python process to run on 100% CPU in a loop https://bugs.launchpad.net/bugs/585358 You received this bug notification because you are a member of NSsbackup team, which is subscribed to NSsbackup. ___ Mailing list: https://launchpad.net/~nssbackup-team Post to : nssbackup-team@lists.launchpad.net Unsubscribe : https://launchpad.net/~nssbackup-team More help : https://help.launchpad.net/ListHelp
[Nssbackup-team] [Bug 585358] Re: nssbackup causes python process to run on 100% CPU in a loop
NSSBackup 'Default Profile' Logger == 2010-05-25 17:48:04,773 - INFO in ConfigManager.__create_logger(713): Log output for [Default Profile] is directed to file '/var/log/nssbackup.log'. 2010-05-25 17:48:04,774 - DEBUG in ConfigManager.validateConfigFileOpts(760): Validating config file. 2010-05-25 17:48:04,774 - INFO in ConfigManager.__init__(324): Profile settings are being read from file '/etc/nssbackup.conf'. 2010-05-25 17:48:04,774 - DEBUG in nssbackupd.__init__(84): Not So Simple Backup Suite 0.2-0 2010-05-25 17:48:04,824 - DEBUG in BackupManager.__init__(249): Instance of BackupManager created. 2010-05-25 17:48:04,835 - INFO in BackupManager.makeBackup(268): Backup process is being started. 2010-05-25 17:48:04,836 - DEBUG in BackupManager.__setlockfile(441): Created lockfile at '/var/lock/nssbackup.lock' with info '2925' 2010-05-25 17:48:04,836 - INFO in FuseFAM.initialize(176): Initializing FUSE File Access Manager. 2010-05-25 17:48:04,837 - DEBUG in FuseFAM.initialize(242): [log] file = '/var/log/nssbackup.log' level = '10' [places] prefix = '/usr' [schedule] anacron = 'daily' [dirconfig] /media/ = '0' /home/. /home/. /var/cache/ = '0' /home/... /var/spool/ = '0' /var/tmp/ = '0' /home/... /etc/ = '1' [general] splitsize = '0' target = '/media/backup/dailybackup' format = 'bzip2' mountdir = '/mnt/nssbackup' maxincrement = '7' purge = '10' followlinks = '0' lockfile = '/var/lock/nssbackup.lock' [report] from = 'NSsbackup Daemon r...@lucid.home' to = '..' smtppassword = '...' smtptls = '1' smtpuser = '.' smtpport = '587' smtpserver = '.' [exclude] regex = '\\.mkv,/home/[^/]+?/\\.thumbnails/,/home/[^/]+?/\\.Trash,/home/[^/]+?/\\..+/[cC]ache,\\..vdi' maxsize = '157286400' 2010-05-25 17:48:04,837 - INFO in UpgradeManager.need_upgrade(140): Checking need for upgrading in '/media/backup/dailybackup' 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(204): [Snapshots Listing - current format] 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-23_10.03.24.877220.lucid.inc 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-21_06.28.06.547394.lucid.inc 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-20_06.27.39.167673.lucid.ful 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-19_20.54.48.455397.lucid.inc 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-18_06.31.59.387443.lucid.inc 2010-05-25 17:48:04,840 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-17_06.18.56.506006.lucid.inc 2010-05-25 17:48:04,841 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-16_13.21.05.248497.lucid.inc 2010-05-25 17:48:04,841 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-15_07.54.49.296694.lucid.inc 2010-05-25 17:48:04,841 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-14_06.44.49.111514.lucid.inc 2010-05-25 17:48:04,841 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-13_18.31.50.714097.lucid.ful 2010-05-25 17:48:04,841 - INFO in SnapshotManager._do_cutoff_purge(993): Simple purge - remove all backups older then 10 days. 2010-05-25 17:48:04,841 - DEBUG in SnapshotManager.get_snapshots(204): [Snapshots Listing - current format] 2010-05-25 17:48:04,841 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-23_10.03.24.877220.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-21_06.28.06.547394.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-20_06.27.39.167673.lucid.ful 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-19_20.54.48.455397.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-18_06.31.59.387443.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-17_06.18.56.506006.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-16_13.21.05.248497.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-15_07.54.49.296694.lucid.inc 2010-05-25 17:48:04,842 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-14_06.44.49.111514.lucid.inc 2010-05-25 17:48:04,843 - DEBUG in SnapshotManager.get_snapshots(206): 2010-05-13_18.31.50.714097.lucid.ful 2010-05-25 17:48:04,843 - DEBUG in SnapshotManager._do_cutoff_purge(996): Checking snapshot '2010-05-23_10.03.24.877220.lucid.inc' for simple purge! 2010-05-25 17:48:04,843 - DEBUG in SnapshotManager._do_cutoff_purge(996): Checking snapshot '2010-05-21_06.28.06.547394.lucid.inc' for simple purge! 2010-05-25 17:48:04,843 - DEBUG in SnapshotManager._do_cutoff_purge(996): Checking snapshot '2010-05-20_06.27.39.167673.lucid.ful' for simple purge! 2010-05-25 17:48:04,843 - DEBUG in SnapshotManager._do_cutoff_purge(996): Checking
[Nssbackup-team] [Bug 585358] Re: nssbackup causes python process to run on 100% CPU in a loop
Dear Jean-Peer, the problem is solved. I noticed after reading the debig log (I am not a programmer ;-) ) that it was kind of connected with the removal of old backups. Then I remembered tha the old backups were done by sbackup and not nssbackup before I upgraded to Lucid. After removing those backups everything is fine and works smoothly. Thanks your taking the time :-) -- nssbackup causes python process to run on 100% CPU in a loop https://bugs.launchpad.net/bugs/585358 You received this bug notification because you are a member of NSsbackup team, which is subscribed to NSsbackup. ___ Mailing list: https://launchpad.net/~nssbackup-team Post to : nssbackup-team@lists.launchpad.net Unsubscribe : https://launchpad.net/~nssbackup-team More help : https://help.launchpad.net/ListHelp
[Nssbackup-team] [Bug 585358] Re: nssbackup causes python process to run on 100% CPU in a loop
How do I mark this as solved? -- nssbackup causes python process to run on 100% CPU in a loop https://bugs.launchpad.net/bugs/585358 You received this bug notification because you are a member of NSsbackup team, which is subscribed to NSsbackup. ___ Mailing list: https://launchpad.net/~nssbackup-team Post to : nssbackup-team@lists.launchpad.net Unsubscribe : https://launchpad.net/~nssbackup-team More help : https://help.launchpad.net/ListHelp
