View Single Post
  #1  
Old 06-06-2006, 06:06 PM
BackerUpper BackerUpper is offline
Registered User
 
Join Date: Jun 2006
Posts: 1
Question Long Hang While Copying

When attempting to copy an external drive to a disk image (parse or read only) it seems SD hangs right away when it starts copying (info about how much has been copied stops increasing but elapsed time continues to go) and then continues once it gets to about 4GB or so. What causes this to hang? I have tried it on several systems and tried a couple external drives. Below is the log file from one operation. You can see where it jumps from 03:16:14 PM to 03:35:13 PM after copying Chrismas Hits 60 CD2. Chrismas Hits 60 CD2 is only about 100MB but DV File is 4GB or so.

| 03:15:42 PM | Info | SuperDuper!, 2.1.1 (78), path: /Users/TestMachine/Applications/SuperDuper!.app, Mac OS 10.4.6 build 8I127 (ppc)
| 03:15:42 PM | Info | Started on Tue, Jun 6, 2006 at 3:15 PM
| 03:15:42 PM | Info | Source Drive: Travel Drive 9GB, mount: /Volumes/Travel Drive 9GB, device: ST310211 A, interconnect: External FireWire, file system: "Journaled HFS+", OS: N/A, capacity: 9.19 GB, used: 4.82 GB, directories: 20, files: 156, ejectable: NO, ACLs: Disabled
| 03:15:42 PM | Info | Target Image: /Users/TestMachine/Documents/Test Test.sparseimage, name: Test Test
| 03:15:42 PM | Info | Copy Mode : Erase, then copy files
| 03:15:42 PM | Info | Copy Script : Backup - all files.dset
| 03:15:42 PM | Info | Transcript : BuildTranscript.plist
| 03:15:42 PM | Info | PHASE: 1. Prepare to Copy Files
| 03:15:42 PM | Info | ...ACTION: Preparing Travel Drive 9GB
| 03:15:42 PM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 03:15:43 PM | Info | volinfo.database OK
| 03:15:43 PM | Info | ......COMMAND => Enabling permissions on Travel Drive 9GB
| 03:15:43 PM | Info | Refreshing Disk Arbitration ...
| 03:15:43 PM | Info | ......COMMAND => Verifying that permissions are enabled for Travel Drive 9GB
| 03:15:43 PM | Info | Permissions on '/Volumes/Travel Drive 9GB' are enabled.
| 03:15:43 PM | Info | ...ACTION: Mounting Test Test
| 03:15:43 PM | Info | ......COMMAND => Preparing Test Test
| 03:15:51 PM | Info | created: /Users/TestMachine/Documents/Test Test.sparseimage
| 03:15:51 PM | Info | ......COMMAND => Setting ownership and access modes for '/Users/TestMachine/Documents/Test Test.sparseimage'
| 03:15:51 PM | Info | ......COMMAND => Mounting Test Test
| 03:15:56 PM | Info | ...ACTION: Erasing Test Test
| 03:15:56 PM | Info | ......COMMAND => Preserving Test Test UUID
| 03:15:57 PM | Info | 29F447529C2CA241
| 03:15:57 PM | Info | ......COMMAND => Preserving spotlight indexing state
| 03:15:57 PM | Info | ......COMMAND => Erasing Test Test
| 03:16:09 PM | Info | ......COMMAND => Restoring Test Test UUID (SDUUID.hexString)
| 03:16:10 PM | Info | 29F447529C2CA241
| 03:16:10 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on Test Test
| 03:16:10 PM | Info | ...ACTION: Preparing Test Test
| 03:16:10 PM | Info | ......COMMAND => Enabling permissions on Test Test
| 03:16:10 PM | Info | Refreshing Disk Arbitration ...
| 03:16:10 PM | Info | ......COMMAND => Verifying that permissions are enabled for Test Test
| 03:16:10 PM | Info | Permissions on '/Volumes/Test Test' are enabled.
| 03:16:10 PM | Info | ......COMMAND => Verifying that Test Test ACL support matches Travel Drive 9GB
| 03:16:10 PM | Info | ......COMMAND => Disabling Spotlight search indexing on Test Test
| 03:16:10 PM | Info | PHASE: 2. Copy Files
| 03:16:10 PM | Info | ...ACTION: Copying files from Travel Drive 9GB to Test Test
| 03:16:10 PM | Info | ......COMMAND => Cloning Travel Drive 9GB to Test Test
| 03:16:11 PM | Info | Copying all files using script: /Users/TestMachine/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 03:16:11 PM | Info | Loading 19 commands from copy script /Users/TestMachine/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system temporary files.dset
| 03:16:11 PM | Info | Loading 6 commands from copy script /Users/TestMachine/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system cache files.dset
| 03:16:11 PM | Info | Loading 1 commands from copy script /Users/TestMachine/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Norton FileSaver files.dset
| 03:16:11 PM | Info | Loading 2 commands from copy script /Users/TestMachine/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Spotlight search index.dset
| 03:16:11 PM | Info | Loading 0 commands from copy script /Users/TestMachine/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 03:16:11 PM | Info | /Volumes/Travel Drive 9GB
| 03:16:14 PM | Info | /Volumes/Travel Drive 9GB/Chrismas Hits 60 CD2
| 03:35:13 PM | Info | /Volumes/Travel Drive 9GB/Recycled
| 03:35:13 PM | Info | /Volumes/Travel Drive 9GB/DV File
| 03:35:16 PM | Info | /Volumes/Travel Drive 9GB/TheVolumeSettingsFolder
| 03:35:16 PM | Info | /Volumes/Travel Drive 9GB/Trash
| 03:35:16 PM | Info | /Volumes/Travel Drive 9GB/Barry Manilow - A Christmas Gift Of Love
| 03:35:26 PM | Info | /Volumes/Travel Drive 9GB/Chrismas Hits 60 CD1
| 03:35:48 PM | Info | /Volumes/Travel Drive 9GB/A Christmas Together
| 03:36:08 PM | Info | /Volumes/Travel Drive 9GB/Chrismas Hits 60 CD3
| 03:36:26 PM | Info | /Volumes/Travel Drive 9GB/Denis Leary - Merry F#%$in Christmas
| 03:36:34 PM | Info | /Volumes/Travel Drive 9GB/.Spotlight-V100
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/_rules.plist
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/ContentIndex.db
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/master-change-id
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/master-change-list-00000001
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/.journalHistoryLog
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/store.db
| 03:36:34 PM | Info | Ignoring /Volumes/Travel Drive 9GB/.Spotlight-V100/.store.db
| 03:36:34 PM | Info | /Volumes/Travel Drive 9GB/.TemporaryItems
| 03:36:34 PM | Info | /Volumes/Travel Drive 9GB/Euro Trip - Original Soundtrack
| 03:36:53 PM | Info | /Volumes/Travel Drive 9GB/.Trashes
| 03:36:53 PM | Info | Ignoring /Volumes/Travel Drive 9GB/Desktop DB
| 03:36:53 PM | Info | Ignoring /Volumes/Travel Drive 9GB/Desktop DF
| 03:36:54 PM | Info | Evaluated 174 items occupying 4.80 GB (20 directories, 154 files, 0 symlinks)
| 03:36:54 PM | Info | Copied 180 items totaling 4.80 GB (18 directories, 144 files, 18 symlinks)
| 03:36:54 PM | Info | Cloned 4.80 GB of data in 1243 seconds at an effective transfer rate of 3.95 MB/s
| 03:36:54 PM | Info | PHASE: 3. After Successful Copy
| 03:36:54 PM | Info | ...ACTION: Making Test Test bootable
| 03:36:54 PM | Info | ......COMMAND => Blessing OS X System Folder
| 03:36:55 PM | Info | Did not bless Mac OS X System Folder on Test Test because it does not exist.
| 03:36:55 PM | Info | ......COMMAND => Blessing OS 9 System Folder
| 03:36:55 PM | Info | Did not bless Mac OS 9 System Folder on Test Test because it does not exist.
| 03:36:55 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on Test Test
| 03:36:56 PM | Info | ...ACTION: Unmounting Test Test
| 03:36:56 PM | Info | ......COMMAND => Unmounting '/Users/TestMachineTestMachine/Documents/Test Test.sparseimage'
| 03:36:57 PM | Info | "disk3" unmounted.
| 03:36:58 PM | Info | "disk3" ejected.
| 03:36:58 PM | Info | Copy complete.
Reply With Quote