[Nick]

(CONTINUED FROM PREVIOUS POST)

Besides the fact that it failed, the time indicated was clearly inconsistent with the time I actually initiated the backup: It says it started today (not yesterday) at 12:57 PM, when in fact I had initiated it yesterday afternoon. Stranger still, a short while later SD! began another backup—the “standard” backup (“Smart Update Nick’s HD Clone”), which it promptly completed:

--------------------------------
| 12:57:41 PM | Info | SuperDuper!, 2.6.2 (87), path: /Applications/SuperDuper!.app, Mac OS 10.5.8 build 9L31a (i386)
| 12:57:41 PM | Info | Started on Tue, Jan 19, 2010 at 12:57 PM
| 12:57:41 PM | Info | Source Volume: Nick's HD, mount: /, device: /dev/disk0s2, media: Hitachi HDP725032GLA380, interconnect: Internal SATA, file system: "Journaled HFS+", OS: 10.5.8 (9L31a), capacity: 297.77 GiB, used: 266.49 GiB, directories: 109756, files: 1291515, ejectable: NO, ACLs: Enabled
| 12:57:41 PM | Info | Target Volume: Nick's HD Clone, mount: /Volumes/Nick's HD Clone, device: /dev/disk4s5, media: LaCie d2 quadra, interconnect: External FireWire, file system: "Journaled HFS+", OS: 10.5.8 (9L31a), capacity: 348.30 GiB, used: 267.93 GiB, directories: 113005, files: 1316674, ejectable: YES, ACLs: Enabled
| 12:57:41 PM | Info | Copy Mode : Smart Update
| 12:57:41 PM | Info | Copy Script : Backup - all files.dset
| 12:57:41 PM | Info | Transcript : BuildTranscript.plist
| 12:57:42 PM | Info | PHASE: 1. Prepare to Copy Files
| 12:57:42 PM | Info | ...ACTION: Preparing Nick's HD
| 12:57:42 PM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 12:57:42 PM | Info | volinfo.database OK
| 12:57:42 PM | Info | ......COMMAND => Enabling permissions on Nick's HD
| 12:57:42 PM | Info | Refreshing Disk Arbitration ...
| 12:57:42 PM | Info | ......COMMAND => Verifying that permissions are enabled for Nick's HD
| 12:57:42 PM | Info | Permissions on '/' are enabled.
| 12:57:42 PM | Info | ...ACTION: Preparing Nick's HD Clone
| 12:57:42 PM | Info | ......COMMAND => Enabling permissions on Nick's HD Clone
| 12:57:42 PM | Info | Refreshing Disk Arbitration ...
| 12:57:43 PM | Info | ......COMMAND => Verifying that permissions are enabled for Nick's HD Clone
| 12:57:43 PM | Info | Permissions on '/Volumes/Nick's HD Clone' are enabled.
| 12:57:43 PM | Info | ......COMMAND => Verifying that Nick's HD Clone ACL support matches Nick's HD
| 12:57:43 PM | Info | ...ACTION: Preserving Spotlight state on Nick's HD Clone
| 12:57:43 PM | Info | ......COMMAND => Disabling Spotlight search indexing on Nick's HD Clone
| 12:57:43 PM | Info | PHASE: 2. Copy Files
| 12:57:43 PM | Info | ...ACTION: Copying files from Nick's HD to Nick's HD Clone using Smart Update
| 12:57:43 PM | Info | ......COMMAND => Cloning Nick's HD to Nick's HD Clone
| 12:57:43 PM | Info | Copying copy files with delete using script: /Users/Nick/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 12:57:44 PM | Info | Loading 27 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system temporary files.dset
| 12:57:44 PM | Info | Loading 6 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system cache files.dset
| 12:57:44 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Norton FileSaver files.dset
| 12:57:44 PM | Info | Loading 2 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Google Desktop Index files.dset
| 12:57:44 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude iTunes Temporary files.dset
| 12:57:44 PM | Info | Loading 0 commands from copy script /Users/Nick/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 12:57:47 PM | Info | /
| 12:57:47 PM | Info | /.vol
| 12:57:47 PM | Info | Ignoring /.vol
| 12:57:47 PM | Info | /cores
| 12:57:47 PM | Info | /Network
| 12:57:47 PM | Info | /bin
| 12:57:47 PM | Info | /System
| 12:59:26 PM | Info | /private
| 12:59:29 PM | Info | Ignoring /private/var/folders/-H
| 12:59:29 PM | Info | Ignoring /private/var/folders/Pi
| 12:59:29 PM | Info | Ignoring /private/var/folders/zz
| 12:59:29 PM | Info | Ignoring /private/var/vm/swapfile0
| 12:59:29 PM | Info | Ignoring /private/var/vm/swapfile1
| 12:59:29 PM | Info | Ignoring /private/var/vm/swapfile2
| 12:59:29 PM | Info | Ignoring /private/var/vm/swapfile3
| 12:59:29 PM | Info | Ignoring /private/var/vm/swapfile4
| 12:59:29 PM | Info | Ignoring /private/var/vm/swapfile5
| 12:59:29 PM | Info | Ignoring /private/var/run/usbmuxd
| 12:59:29 PM | Info | Ignoring /private/var/run/syslog
| 12:59:29 PM | Info | Ignoring /private/var/run/mDNSResponder
| 12:59:29 PM | Info | Ignoring /private/var/run/cupsd
| 12:59:29 PM | Info | Ignoring /private/var/run/asl_input
| 12:59:29 PM | Info | Ignoring /private/var/run/syslog.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/configd.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/diskarbitrationd.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/DirectoryService.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/com.apple.blued.launchd
| 12:59:29 PM | Info | Ignoring /private/var/run/automount.initialized
| 12:59:29 PM | Info | Ignoring /private/var/run/pcscd.pub
| 12:59:29 PM | Info | Ignoring /private/var/run/appfwd.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/mach.sym
| 12:59:29 PM | Info | Ignoring /private/var/run/mds
| 12:59:29 PM | Info | Ignoring /private/var/run/macaronid.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/ntpd.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/utmpx
| 12:59:29 PM | Info | Ignoring /private/var/run/pppconfd
| 12:59:29 PM | Info | Ignoring /private/var/run/portmap.socket
| 12:59:29 PM | Info | Ignoring /private/var/run/cron.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/cups
| 12:59:29 PM | Info | Ignoring /private/var/run/mds.pid
| 12:59:29 PM | Info | Ignoring /private/var/run/.DSRunningSP1
| 12:59:29 PM | Info | Ignoring /private/var/run/.autoBackup
| 12:59:50 PM | Info | Ignoring /private/var/db/volinfo.database
| 12:59:50 PM | Info | Ignoring /private/var/tmp/.BlankFile
| 12:59:50 PM | Info | Ignoring /private/var/tmp/tmp.0.zqWEg8
| 12:59:50 PM | Info | Ignoring /private/var/tmp/tmp.1.1PW0iI
| 12:59:50 PM | Info | Ignoring /private/var/tmp/tmp.2.wfck3Q
| 12:59:50 PM | Info | Ignoring /private/var/tmp/com.apple.speech.synthesis.globals

(CONTINUED IN NEXT POST)