Shirt Pocket Discussions

Shirt Pocket Discussions (https://www.shirt-pocket.com/forums/index.php)
-   General (https://www.shirt-pocket.com/forums/forumdisplay.php?f=6)
-   -   Schedule automatic network backup. (https://www.shirt-pocket.com/forums/showthread.php?t=5491)

zickzhou 07-29-2009 02:05 PM

Schedule automatic network backup.
 
Hi there.
I have some problem with the scheduled auto backup. What i would like to do it, for every 3 days, I do a complete system back up, and each day between the complete system back up, I do incremental backup.

So yesterday i setup a testing environment, and I have the configuration as the following:
--Every day at 5:10 pm, I schedule a complete system backup, writing to a sparse image on the network storage. The sparse image is named as "backup". The backup type is "back up all files" with "erase and copy" option.

-Every day at 2:30 am, 4:30am and 6:30 am, I scheduled 3 different incremental backups. The settings are identical except starting time. They have the following settings: the destination is also "backup". Backup type is "backup all files " with "Copy different" option.

I left my office at 5 yesterday and allow my mac to do the back up testing scheme it self. When I came back this morning...

Only the initial full system backup was successful. All incremental backups were failed.

I will post the backup log. and please tell me why this is happening. Thanks.

zickzhou 07-29-2009 02:07 PM

Backup log for complete backup

| 05:10:16 PM | Info | SuperDuper!, 2.5 (84), path: /Applications/SuperDuper!.app, Mac OS 10.5.7 build 9J61 (ppc)
| 05:10:16 PM | Info | Started on Tue, Jul 28, 2009 at 5:10 PM
| 05:10:16 PM | Info | Source Volume: Leopard, mount: /, device: /dev/disk0s5, media: TOSHIBA MK6025GAS TOSHIBA MK6025GAS, interconnect: Internal ATA, file system: "Journaled HFS+", OS: 10.5.7 (9J61), capacity: 39.82 GB, used: 20.51 GB, directories: 145370, files: 682167, ejectable: NO, ACLs: Enabled
| 05:10:16 PM | Info | Target Image: /Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage, name: LEWISIbookG4
| 05:10:16 PM | Info | Copy Mode : Erase, then copy files
| 05:10:16 PM | Info | Copy Script : Backup - all files.dset
| 05:10:16 PM | Info | Transcript : BuildTranscript.plist
| 05:10:17 PM | Info | PHASE: 1. Prepare to Copy Files
| 05:10:17 PM | Info | ...ACTION: Preparing Leopard
| 05:10:17 PM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 05:10:17 PM | Info | volinfo.database OK
| 05:10:17 PM | Info | ......COMMAND => Enabling permissions on Leopard
| 05:10:18 PM | Info | Refreshing Disk Arbitration ...
| 05:10:18 PM | Info | ......COMMAND => Verifying that permissions are enabled for Leopard
| 05:10:18 PM | Info | Permissions on '/' are enabled.
| 05:10:18 PM | Info | ...ACTION: Mounting LEWISIbookG4
| 05:10:18 PM | Info | ......COMMAND => Preparing LEWISIbookG4
| 05:10:33 PM | Info | created: /Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage
| 05:10:33 PM | Info | ......COMMAND => Setting ownership and access modes for '/Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage'
| 05:10:33 PM | Info | ......COMMAND => Mounting LEWISIbookG4
| 05:10:38 PM | Info | /dev/disk1 Apple_partition_scheme /dev/disk1s1 Apple_partition_map /dev/disk1s2 Apple_HFS /Volumes/LEWISIbookG4
| 05:10:38 PM | Info | ......COMMAND => Mounting LEWISIbookG4
| 05:10:39 PM | Info | ...ACTION: Erasing LEWISIbookG4
| 05:10:39 PM | Info | ......COMMAND => Preserving LEWISIbookG4 UUID
| 05:10:39 PM | Info | D32FB3F93E866B8F
| 05:10:39 PM | Info | ......COMMAND => Preserving spotlight indexing state
| 05:10:39 PM | Info | ......COMMAND => Erasing LEWISIbookG4
| 05:11:00 PM | Info | ......COMMAND => Restoring LEWISIbookG4 UUID (SDUUID.hexString)
| 05:11:01 PM | Info | D32FB3F93E866B8F
| 05:11:01 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on LEWISIbookG4
| 05:11:01 PM | Info | ...ACTION: Preparing LEWISIbookG4
| 05:11:01 PM | Info | ......COMMAND => Enabling permissions on LEWISIbookG4
| 05:11:01 PM | Info | Refreshing Disk Arbitration ...
| 05:11:01 PM | Info | ......COMMAND => Verifying that permissions are enabled for LEWISIbookG4
| 05:11:02 PM | Info | Permissions on '/Volumes/LEWISIbookG4' are enabled.
| 05:11:02 PM | Info | ......COMMAND => Verifying that LEWISIbookG4 ACL support matches Leopard
| 05:11:02 PM | Info | ...ACTION: Preserving Spotlight state on LEWISIbookG4
| 05:11:02 PM | Info | ......COMMAND => Disabling Spotlight search indexing on LEWISIbookG4
| 05:11:02 PM | Info | PHASE: 2. Copy Files
| 05:11:02 PM | Info | ...ACTION: Copying files from Leopard to LEWISIbookG4
| 05:11:02 PM | Info | ......COMMAND => Cloning Leopard to LEWISIbookG4
| 05:11:02 PM | Info | Copying copy files using script: /Users/lewiszhou/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 05:11:03 PM | Info | Loading 22 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system temporary files.dset
| 05:11:03 PM | Info | Loading 6 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system cache files.dset
| 05:11:03 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Norton FileSaver files.dset
| 05:11:03 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Google Desktop Index files.dset
| 05:11:03 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude iTunes Temporary files.dset
| 05:11:03 PM | Info | Loading 0 commands from copy script /Users/lewiszhou/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 05:11:03 PM | Info | /
| 05:11:07 PM | Info | /cores
| 05:11:07 PM | Info | /Network
| 05:11:07 PM | Info | /.vol
| 05:11:07 PM | Info | Ignoring /.vol
| 05:11:07 PM | Info | /.Trashes
| 05:11:07 PM | Info | /private
| 05:11:27 PM | Info | Ignoring /private/var/vm/swapfile0
| 05:11:59 PM | Info | Ignoring /private/var/db/BootCache.playlist
| 05:11:59 PM | Info | Ignoring /private/var/db/volinfo.database
| 05:11:59 PM | Info | Ignoring /private/var/run/syslog.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/diskarbitrationd.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/configd.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/DirectoryService.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/mds.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/appfwd.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/automount.initialized
| 05:11:59 PM | Info | Ignoring /private/var/run/utmpx
| 05:11:59 PM | Info | Ignoring /private/var/run/resolv.conf
| 05:11:59 PM | Info | Ignoring /private/var/run/mach.sym
| 05:11:59 PM | Info | Ignoring /private/var/run/ntpd.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/cron.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/com.sophos.sav.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/com.sophos.sav.ic.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/com.sophos.sau.pid
| 05:11:59 PM | Info | Ignoring /private/var/run/mds
| 05:11:59 PM | Info | Ignoring /private/var/run/hdiejectd.pid
| 05:11:59 PM | Info | Ignoring /private/var/tmp/com.apple.speech.synthesis.globals
| 05:11:59 PM | Info | Ignoring /private/var/tmp/launchd
| 05:11:59 PM | Info | Ignoring /private/var/tmp/mds
| 05:12:02 PM | Info | Ignoring /private/tmp/launchd-72.4hy7t2
| 05:12:02 PM | Info | Ignoring /private/tmp/launch-l3M7oF
| 05:12:02 PM | Info | Ignoring /private/tmp/launch-dKwwTT
| 05:12:02 PM | Info | Ignoring /private/tmp/launch-WD32du
| 05:12:02 PM | Info | Ignoring /private/tmp/SDTargetImageDevice
| 05:12:02 PM | Info | Ignoring /private/tmp/target.indexState
| 05:12:02 PM | Info | /.Spotlight-V100
| 05:12:02 PM | Info | Preserving /.Spotlight-V100
| 05:12:02 PM | Info | /Users
| 05:17:56 PM | Info | /Developer
| 06:08:16 PM | Info | Ignoring /Desktop DF
| 06:08:16 PM | Info | Ignoring /Desktop DB
| 06:08:16 PM | Info | Ignoring /.hotfiles.btree
| 06:08:21 PM | Info | /usr
| 06:24:44 PM | Info | /bin
| 06:24:44 PM | Info | /sbin
| 06:24:47 PM | Info | /System
| 07:53:24 PM | Info | /Library
| 09:11:28 PM | Info | /dev
| 09:11:28 PM | Info | /net
| 09:11:28 PM | Info | /home
| 09:11:28 PM | Info | /Applications
| 11:00:20 PM | Info | /.fseventsd
| 11:00:20 PM | Info | Preserving /.fseventsd
| 11:00:20 PM | Info | /Volumes
| 11:00:20 PM | Info | Ignoring /Volumes/Volume_1
| 11:00:20 PM | Info | Ignoring /Volumes/Data-Restore Disk
| 11:00:20 PM | Info | Ignoring /Volumes/.DS_Store
| 11:00:20 PM | Info | Ignoring /Volumes/Leopard
| 11:00:20 PM | Info | Ignoring /Volumes/LEWISIbookG4
| 11:00:20 PM | Info | Evaluated 810988 items occupying 19.63 GB (145371 directories, 642300 files, 23317 symlinks)
| 11:00:20 PM | Info | Copied 810476 items totaling 19.37 GB (145352 directories, 641808 files, 23316 symlinks)
| 11:00:20 PM | Info | Cloned 19.37 GB of data in 20957 seconds at an effective transfer rate of 0.95 MB/s
| 11:00:20 PM | Info | ......COMMAND => Resetting Custom Icon bit on LEWISIbookG4
| 11:00:20 PM | Info | PHASE: 3. After Successful Copy
| 11:00:20 PM | Info | ...ACTION: Making LEWISIbookG4 bootable
| 11:00:20 PM | Info | ......COMMAND => Blessing OS X System Folder
| 11:00:22 PM | Info | Successfully blessed Mac OS X folder on LEWISIbookG4
| 11:00:22 PM | Info | ......COMMAND => Blessing OS 9 System Folder
| 11:00:22 PM | Info | Did not bless Mac OS 9 System Folder on LEWISIbookG4 because it does not exist.
| 11:00:22 PM | Info | ...ACTION: Restoring Spotlight state on LEWISIbookG4
| 11:00:22 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on LEWISIbookG4
| 11:00:22 PM | Info | ...ACTION: Unmounting LEWISIbookG4
| 11:00:22 PM | Info | ......COMMAND => Unmounting '/Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage'
| 11:00:24 PM | Info | hdiutil: detach failed - No such file or directory
| 11:00:24 PM | Info | PHASE: 4. And Finally...
| 11:00:24 PM | Info | ...ACTION: Quitting SuperDuper!
| 11:00:24 PM | Info | ......COMMAND => Quitting SuperDuper!
| 11:00:24 PM | Info | Copy complete.

zickzhou 07-29-2009 02:07 PM

| 02:30:26 AM | Info | SuperDuper!, 2.5 (84), path: /Applications/SuperDuper!.app, Mac OS 10.5.7 build 9J61 (ppc)
| 02:30:26 AM | Info | Started on Wed, Jul 29, 2009 at 2:30 AM
| 02:30:26 AM | Info | Source Volume: Leopard, mount: /, device: /dev/disk0s5, media: TOSHIBA MK6025GAS TOSHIBA MK6025GAS, interconnect: Internal ATA, file system: "Journaled HFS+", OS: 10.5.7 (9J61), capacity: 39.82 GB, used: 20.60 GB, directories: 145371, files: 682182, ejectable: NO, ACLs: Enabled
| 02:30:26 AM | Info | Target Image: /Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage, name: LEWISIbookG4
| 02:30:26 AM | Info | Copy Mode : Copy Newer files
| 02:30:26 AM | Info | Copy Script : Backup - all files.dset
| 02:30:26 AM | Info | Transcript : BuildTranscript.plist
| 02:30:28 AM | Info | PHASE: 1. Prepare to Copy Files
| 02:30:28 AM | Info | ...ACTION: Preparing Leopard
| 02:30:28 AM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 02:30:33 AM | Info | volinfo.database OK
| 02:30:33 AM | Info | ......COMMAND => Enabling permissions on Leopard
| 02:30:33 AM | Info | Refreshing Disk Arbitration ...
| 02:30:33 AM | Info | ......COMMAND => Verifying that permissions are enabled for Leopard
| 02:30:33 AM | Info | Permissions on '/' are enabled.
| 02:30:33 AM | Info | ...ACTION: Mounting LEWISIbookG4
| 02:30:33 AM | Info | ......COMMAND => Preparing LEWISIbookG4
| 02:30:34 AM | Info | ......COMMAND => Setting ownership and access modes for '/Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage'
| 02:30:34 AM | Info | ......COMMAND => Mounting LEWISIbookG4
| 02:30:36 AM | Info | /dev/disk1 Apple_partition_scheme /dev/disk1s1 Apple_partition_map /dev/disk1s3 Apple_HFS /Volumes/LEWISIbookG4
| 02:30:36 AM | Info | ......COMMAND => Mounting LEWISIbookG4
| 02:30:36 AM | Info | Waiting for LEWISIbookG4 to mount.
| 02:30:38 AM | Info | Waiting for LEWISIbookG4 to mount.
| 02:30:40 AM | Info | Waiting for LEWISIbookG4 to mount.
| 02:30:42 AM | Info | Waiting for LEWISIbookG4 to mount.
| 02:30:44 AM | Error | Failed to mount 'LEWISIbookG4'

zickzhou 07-29-2009 02:09 PM

| 06:30:17 AM | Info | SuperDuper!, 2.5 (84), path: /Applications/SuperDuper!.app, Mac OS 10.5.7 build 9J61 (ppc)
| 06:30:17 AM | Info | Started on Wed, Jul 29, 2009 at 6:30 AM
| 06:30:17 AM | Info | Source Volume: Leopard, mount: /, device: /dev/disk0s5, media: TOSHIBA MK6025GAS TOSHIBA MK6025GAS, interconnect: Internal ATA, file system: "Journaled HFS+", OS: 10.5.7 (9J61), capacity: 39.82 GB, used: 20.61 GB, directories: 145371, files: 682186, ejectable: NO, ACLs: Enabled
| 06:30:17 AM | Info | Target Image: /Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage, name: LEWISIbookG4
| 06:30:17 AM | Info | Copy Mode : Copy Newer files
| 06:30:17 AM | Info | Copy Script : Backup - all files.dset
| 06:30:17 AM | Info | Transcript : BuildTranscript.plist
| 06:30:17 AM | Info | PHASE: 1. Prepare to Copy Files
| 06:30:17 AM | Info | ...ACTION: Preparing Leopard
| 06:30:17 AM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 06:30:18 AM | Info | volinfo.database OK
| 06:30:18 AM | Info | ......COMMAND => Enabling permissions on Leopard
| 06:30:18 AM | Info | Refreshing Disk Arbitration ...
| 06:30:18 AM | Info | ......COMMAND => Verifying that permissions are enabled for Leopard
| 06:30:18 AM | Info | Permissions on '/' are enabled.
| 06:30:18 AM | Info | ...ACTION: Mounting LEWISIbookG4
| 06:30:18 AM | Info | ......COMMAND => Preparing LEWISIbookG4
| 06:30:18 AM | Info | ......COMMAND => Setting ownership and access modes for '/Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage'
| 06:30:18 AM | Info | ......COMMAND => Mounting LEWISIbookG4
| 06:30:19 AM | Info | /dev/disk1 Apple_partition_scheme /dev/disk1s1 Apple_partition_map /dev/disk1s3 Apple_HFS /Volumes/LEWISIbookG4
| 06:30:19 AM | Info | ......COMMAND => Mounting LEWISIbookG4
| 06:30:19 AM | Info | Waiting for LEWISIbookG4 to mount.
| 06:30:21 AM | Info | Waiting for LEWISIbookG4 to mount.
| 06:30:23 AM | Info | Waiting for LEWISIbookG4 to mount.
| 06:30:25 AM | Info | Waiting for LEWISIbookG4 to mount.
| 06:30:27 AM | Info | Waiting for LEWISIbookG4 to mount.
| 06:30:27 AM | Error | Failed to mount 'LEWISIbookG4'

zickzhou 07-29-2009 02:09 PM

| 04:30:16 AM | Info | SuperDuper!, 2.5 (84), path: /Applications/SuperDuper!.app, Mac OS 10.5.7 build 9J61 (ppc)
| 04:30:16 AM | Info | Started on Wed, Jul 29, 2009 at 4:30 AM
| 04:30:16 AM | Info | Source Volume: Leopard, mount: /, device: /dev/disk0s5, media: TOSHIBA MK6025GAS TOSHIBA MK6025GAS, interconnect: Internal ATA, file system: "Journaled HFS+", OS: 10.5.7 (9J61), capacity: 39.82 GB, used: 20.61 GB, directories: 145371, files: 682184, ejectable: NO, ACLs: Enabled
| 04:30:16 AM | Info | Target Image: /Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage, name: LEWISIbookG4
| 04:30:16 AM | Info | Copy Mode : Copy Newer files
| 04:30:16 AM | Info | Copy Script : Backup - all files.dset
| 04:30:16 AM | Info | Transcript : BuildTranscript.plist
| 04:30:17 AM | Info | PHASE: 1. Prepare to Copy Files
| 04:30:17 AM | Info | ...ACTION: Preparing Leopard
| 04:30:17 AM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 04:30:18 AM | Info | volinfo.database OK
| 04:30:18 AM | Info | ......COMMAND => Enabling permissions on Leopard
| 04:30:18 AM | Info | Refreshing Disk Arbitration ...
| 04:30:24 AM | Info | ......COMMAND => Verifying that permissions are enabled for Leopard
| 04:30:24 AM | Info | Permissions on '/' are enabled.
| 04:30:24 AM | Info | ...ACTION: Mounting LEWISIbookG4
| 04:30:24 AM | Info | ......COMMAND => Preparing LEWISIbookG4
| 04:30:24 AM | Info | ......COMMAND => Setting ownership and access modes for '/Volumes/Volume_1/LewisIBOOKG4/LEWISIbookG4.sparseimage'
| 04:30:24 AM | Info | ......COMMAND => Mounting LEWISIbookG4
| 04:30:25 AM | Info | /dev/disk1 Apple_partition_scheme /dev/disk1s1 Apple_partition_map /dev/disk1s3 Apple_HFS /Volumes/LEWISIbookG4
| 04:30:25 AM | Info | ......COMMAND => Mounting LEWISIbookG4
| 04:30:25 AM | Info | Waiting for LEWISIbookG4 to mount.
| 04:30:27 AM | Info | Waiting for LEWISIbookG4 to mount.
| 04:30:29 AM | Info | Waiting for LEWISIbookG4 to mount.
| 04:30:31 AM | Info | Waiting for LEWISIbookG4 to mount.
| 04:30:33 AM | Error | Failed to mount 'LEWISIbookG4'

zickzhou 07-29-2009 02:14 PM

I checked my system-energy saving settings.
If the laptop is on AC, then it never sleep. the screen will turn off after 15 min. So i do not think it is a weekup issue.

And from the log, I can see it is determined to be a mounting issue. My question is, why this is happening? I used exactly the same mounting configuration as the full backup. And when I came back this morning, I actually noticed that the sparse image is mounted on my mac (very much like mounting a dmg file). So how can I actually configure the SD to acheive the back up scheme I proposed in my initial post?

dnanian 07-29-2009 02:41 PM

The problem in all of these backups is that the image is already mounted when the backup starts. If you eject the image, they should work fine.


All times are GMT -4. The time now is 05:39 PM.

Powered by vBulletin® Version 3.8.9
Copyright ©2000 - 2024, vBulletin Solutions, Inc.