Backup Failure

[Nick]

(CONTINUED FROM PREVIOUS POST)

| 12:59:50 PM | Info | Ignoring /private/var/tmp/BonjourPrinters.plist
| 12:59:50 PM | Info | Ignoring /private/var/tmp/Nick
| 12:59:50 PM | Info | Ignoring /private/var/tmp/etilqs_s7yB2paaelStBPa
| 12:59:50 PM | Info | Ignoring /private/var/tmp/com.econtechnologies.chronoagent.local
| 12:59:50 PM | Info | Ignoring /private/var/tmp/launchd
| 12:59:50 PM | Info | Ignoring /private/var/tmp/mds
| 12:59:53 PM | Info | Ignoring /private/tmp/MobileDevice.log
| 12:59:53 PM | Info | Ignoring /private/tmp/launchd-120.Eh2ds8
| 12:59:53 PM | Info | Ignoring /private/tmp/launch-hldZKa
| 12:59:53 PM | Info | Ignoring /private/tmp/launch-YOz29H
| 12:59:53 PM | Info | Ignoring /private/tmp/launch-WfznBc
| 12:59:53 PM | Info | Ignoring /private/tmp/icssuis501
| 12:59:53 PM | Info | Ignoring /private/tmp/ics165
| 12:59:53 PM | Info | Ignoring /private/tmp/target221.indexState
| 12:59:53 PM | Info | Ignoring /private/tmp/target19804.indexState
| 12:59:53 PM | Info | Ignoring /Desktop DF
| 12:59:53 PM | Info | Ignoring /Desktop DB
| 12:59:53 PM | Info | /Users
| 02:33:21 PM | Info | /usr
| 02:34:06 PM | Info | /.Spotlight-V100
| 02:34:06 PM | Info | Preserving /.Spotlight-V100
| 02:34:06 PM | Info | /sbin
| 02:34:06 PM | Info | Ignoring /.hotfiles.btree
| 02:34:06 PM | Info | /Developer
| 02:35:54 PM | Info | /Library
| 02:37:12 PM | Info | /.Trashes
| 02:37:12 PM | Info | /Copies of Backups
| 02:50:03 PM | Info | /Applications
| 02:52:39 PM | Info | /dev
| 02:52:39 PM | Info | /net
| 02:52:39 PM | Info | /home
| 02:52:39 PM | Info | /Volumes
| 02:52:39 PM | Info | Ignoring /Volumes/TechTool Pro 4 DVD
| 02:52:39 PM | Info | Ignoring /Volumes/Mac OS X Install Disc 2
| 02:52:39 PM | Info | Ignoring /Volumes/Mac OS X Install Disc 1
| 02:52:39 PM | Info | Ignoring /Volumes/.vbt5
| 02:52:39 PM | Info | Ignoring /Volumes/LaCie d2 Quadra
| 02:52:39 PM | Info | Ignoring /Volumes/CompUSA Western Digital
| 02:52:39 PM | Info | Ignoring /Volumes/.DS_Store
| 02:52:39 PM | Info | Ignoring /Volumes/Seagate Barracuda
| 02:52:39 PM | Info | Ignoring /Volumes/DiskWarriorCD
| 02:52:39 PM | Info | Ignoring /Volumes/Nick's HD Clone
| 02:52:39 PM | Info | Ignoring /Volumes/LaCie
| 02:52:39 PM | Info | Ignoring /Volumes/Nick's HD
| 02:52:39 PM | Info | /.fseventsd
| 02:52:39 PM | Info | Preserving /.fseventsd
| 02:52:39 PM | Info | Evaluated 1399966 items occupying 265.56 GiB (109755 directories, 1276516 files, 13695 symlinks)
| 02:52:39 PM | Info | Copied 285509 items totaling 21.58 GiB (2515 directories, 282822 files, 172 symlinks)
| 02:52:39 PM | Info | Cloned 263.09 GiB of data in 6895 seconds at an effective transfer rate of 39.07 MiB/s
| 02:52:39 PM | Info | ......COMMAND => Resetting Custom Icon bit on Nick's HD Clone
| 02:52:39 PM | Info | PHASE: 3. After Successful Copy
| 02:52:39 PM | Info | ...ACTION: Making Nick's HD Clone bootable
| 02:52:39 PM | Info | ......COMMAND => Blessing OS X System Folder
| 02:52:40 PM | Info | Successfully blessed Mac OS X folder on Nick's HD Clone
| 02:52:40 PM | Info | ......COMMAND => Blessing OS 9 System Folder
| 02:52:40 PM | Info | Did not bless Mac OS 9 System Folder on Nick's HD Clone because it does not exist.
| 02:52:40 PM | Info | ...ACTION: Updating prebinding on Nick's HD Clone
| 02:52:40 PM | Info | ......COMMAND => Updating boot cache on '/Volumes/Nick'\''s HD Clone'
| 02:52:46 PM | Info | update_dyld_shared_cache[21363] current cache invalid because /System/Library/Frameworks/PubSub.framework/Versions/A/PubSub has changed
| 02:52:56 PM | Info | update_dyld_shared_cache[21363] current cache invalid because /System/Library/Frameworks/OpenGL.framework/Versions/A/Libraries/libGL.dylib has changed
| 02:53:06 PM | Info | update_dyld_shared_cache[21363] current cache invalid because /usr/lib/libcrypto.0.9.7.dylib has changed
| 02:53:13 PM | Info | Successfully updated boot cache on Nick's HD Clone
| 02:53:13 PM | Info | ...ACTION: Restoring Spotlight state on Nick's HD Clone
| 02:53:13 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on Nick's HD Clone
| 02:53:14 PM | Info | /Volumes/Nick's HD Clone:
| 02:53:14 PM | Info | Indexing and searching disabled.
| 02:53:14 PM | Info | Indexing enabled on Nick's HD Clone
| 02:53:14 PM | Info | Copy complete.
--------------------------------

What strikes me as odd here is the main SD! window that shows the progress and remains open after the backup has been completed: While it correctly shows that it was backing up to my clone drive (“Nick's HD Clone”), the “to” volume in the toolbar area says “LaCie,” and the “using” script in the toolbar says “Backup – all files, except Copies of Backups folder,” which suggests that SD! was backing up not to “Nick's HD Clone,” but to “LaCie.”

I then compared the contents of the LaCie to the contents of my internal drive. After accounting for the 47.67 GB “Copies of Backups folder,” it certainly appears that—despite the reported failure of SD! to perform the backup due to its inability to find the “Copies of Backups folder”—the LaCie contained “all files, except Copies of Backups folder,” to within about 340 MB.

Comments? Suggestions?