"Failed to copy files from Macintosh HD..."

[MilMascaras]

Hello Folks:
Consider myself expert level user of SD, using it for years.

but I am running into a consistent error recently:
I am making a master image of a new Mac (for restoration/testing purposes), and I am now newly getting the error message:
"Failed to copy files from Macintosh HD to ..."

I am making a new sparseimage from a Leopard 10.5.5 Image (that has been tested, Onyx maintenance run on it to confirm, etc), and have run into this error starting a couple months ago (my workaround was to use CCC).

But I always preferred SD for sparseimage creation and updating.
According to the log, SD choked due to:
"| Error | SD Copy: Error "Operation not permitted" encountered while setting HFS meta data for /Volumes/Leopard 10.5.5..."
(ps: this is the name the backup volume image/sparseimage I am trying to create)

So it looks like a meta data error that SD cannot copy?
Never seen this before with any backup program.
Can anybody enlighten me?
Thanks

P.S: Already researched the Users' Guide "Troubleshooting" section with no relief for this particular problem.

[dnanian]

I'd need to see the full log; if you could send it to support with the "Send to shirt pocket" button, I'll take a look. Note that this almost always means a damaged set of OS files in Leopard...

[MilMascaras]

WOW, Thanks for the quick reply:
At this time, my test Mac does not have exchange setup (use webbased email only), so the "Send To Shirt Pocket... command never works. so if you'll indulge me, I included "meaty part" of the log.

I am trying to create a new image from a properly Target mode mounted volume, that I want to back up to a new image called: "Leopard 10.5.5 Universal Image" Here is the main part of the log:
================================
| 12:50:50 PM | Info | ......COMMAND => Cloning Macintosh HD to Leopard 10.5.5 Universal Image
| 12:50:50 PM | Info | Copying skip files using script: /Users/joeadmin/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 12:50:50 PM | Info | ACLs from Macintosh HD will not be copied to Leopard 10.5.5 Universal Image.
| 12:50:50 PM | Info | Loading 22 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system temporary files.dset
| 12:50:50 PM | Info | Loading 6 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system cache files.dset
| 12:50:50 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Norton FileSaver files.dset
| 12:50:50 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Google Desktop Index files.dset
| 12:50:50 PM | Info | Loading 1 commands from copy script /Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude iTunes Temporary files.dset
| 12:50:50 PM | Info | Loading 0 commands from copy script /Users/joeadmin/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 12:50:50 PM | Info | /Volumes/Macintosh HD 1
| 12:50:53 PM | Info | /Volumes/Macintosh HD 1/dev
| 12:50:53 PM | Info | /Volumes/Macintosh HD 1/cores
| 12:50:53 PM | Info | /Volumes/Macintosh HD 1/Network
| 12:50:53 PM | Info | /Volumes/Macintosh HD 1/.TemporaryItems
| 12:50:53 PM | Info | /Volumes/Macintosh HD 1/private
| 12:50:54 PM | Info | -rw-r--r-- 1 0 99 - 0 Sep 16 12:50 /Volumes/Leopard 10.5.5 Universal Image/private/var/root/Library/Application Support/SyncServices/Local/DataReferences/349/5FC5FB96-3BC7-41F0-B926-47DC58B1CF1E.truth.data
| 12:50:54 PM | Error | SDCopy: Error "Operation not permitted" encountered while setting HFS meta data for /Volumes/Leopard 10.5.5 Universal Image/private/var/root/Library/Application Support/SyncServices/Local/DataReferences/349/5FC5FB96-3BC7-41F0-B926-47DC58B1CF1E.truth.data of type: 8\n: Operation not permitted


P.S: I noticed it was choking on a file owned by Root in syncservices. So, on subsequent attempts, I enabled Root, logged in as root, and ran SD from my Root login, yet still got identical error.

[dnanian]

SuperDuper!'s copy engine runs as root, so that won't make a difference.

Anyway -- this is what I thought it was (although it's in your sync data). Use iSync's preferences to reset your sync data and then give it another try.

[KevinBBG]

Originally Posted by dnanian

SuperDuper!'s copy engine runs as root, so that won't make a difference.

Anyway -- this is what I thought it was (although it's in your sync data). Use iSync's preferences to reset your sync data and then give it another try.

I'm having the exact same error message, only it happened in the middle of restoring from my clone to my main drive, so my internal HD is now erased.

I opened up iSync and the only reset was for sync history, but I've never used iSync on this computer before. All syncing I've done has been through .Mac (now MobileMe). But I've reset the history and trying again.

Kevin

[dnanian]

Right: I just sent a response to your support request suggesting exactly that. iSync's reset should also reset Mobile Me (it's confusing, I know).

[carillonator]

I had the same problem, and am glad I found this post. Resetting the iSync history seems to have solved it. Disk Utility also failed in restoring my internal HD because of this (with no explanation, of course), so I can't imagine how many people have gotten stuck in this situation using either SD or DU. What a mess. And I've never even used iSync.

[dnanian]

That's why we're here for support, of course!

[mad101dan]

I am having the same issue.

Am i right in thinking I have to log into the backed up version and reset isync from there ?

That is what i tried and I am still getting the following error message.

| 01:06:06 PM | Info | Copy Mode : Erase, then copy files
| 01:06:06 PM | Info | Copy Script : Backup - all files.dset
| 01:06:06 PM | Info | Transcript : BuildTranscript.plist
| 01:06:06 PM | Info | PHASE: 1. Prepare to Copy Files
| 01:06:06 PM | Info | ...ACTION: Preparing NBH Imac
| 01:06:06 PM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 01:06:06 PM | Info | /var/db/volinfo.database does not exist.
| 01:06:06 PM | Info | ......COMMAND => Enabling permissions on NBH Imac
| 01:06:07 PM | Info | Refreshing Disk Arbitration ...
| 01:06:07 PM | Info | ......COMMAND => Verifying that permissions are enabled for NBH Imac
| 01:06:07 PM | Info | Permissions on '/Volumes/NBH Imac' are enabled.
| 01:06:07 PM | Info | ...ACTION: Erasing Macintosh HD
| 01:06:07 PM | Info | ......COMMAND => Preserving Macintosh HD UUID
| 01:06:07 PM | Info | A55F46DE8455BEEA
| 01:06:07 PM | Info | ......COMMAND => Preserving spotlight indexing state
| 01:06:07 PM | Info | ......COMMAND => Erasing Macintosh HD
| 01:06:32 PM | Info | ......COMMAND => Restoring Macintosh HD UUID (A55F46DE8455BEEA)
| 01:06:32 PM | Info | A55F46DE8455BEEA
| 01:06:32 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on Macintosh HD
| 01:06:32 PM | Info | ...ACTION: Preparing Macintosh HD
| 01:06:32 PM | Info | ......COMMAND => Enabling permissions on Macintosh HD
| 01:06:32 PM | Info | Refreshing Disk Arbitration ...
| 01:06:32 PM | Info | ......COMMAND => Verifying that permissions are enabled for Macintosh HD
| 01:06:32 PM | Info | Permissions on '/Volumes/Macintosh HD' are enabled.
| 01:06:32 PM | Info | ......COMMAND => Verifying that Macintosh HD ACL support matches NBH Imac
| 01:06:32 PM | Info | ...ACTION: Preserving Spotlight state on Macintosh HD
| 01:06:32 PM | Info | ......COMMAND => Disabling Spotlight search indexing on Macintosh HD
| 01:06:32 PM | Info | PHASE: 2. Copy Files
| 01:06:32 PM | Info | ...ACTION: Copying files from NBH Imac to Macintosh HD
| 01:06:32 PM | Info | ......COMMAND => Cloning NBH Imac to Macintosh HD
| 01:06:33 PM | Info | Copying copy files using script: /Users/admin/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 01:06:33 PM | Info | Loading 22 commands from copy script /Volumes/NBH Imac/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system temporary files.dset
| 01:06:33 PM | Info | Loading 6 commands from copy script /Volumes/NBH Imac/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system cache files.dset
| 01:06:33 PM | Info | Loading 1 commands from copy script /Volumes/NBH Imac/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Norton FileSaver files.dset
| 01:06:33 PM | Info | Loading 1 commands from copy script /Volumes/NBH Imac/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Google Desktop Index files.dset
| 01:06:33 PM | Info | Loading 1 commands from copy script /Volumes/NBH Imac/Applications/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude iTunes Temporary files.dset
| 01:06:33 PM | Info | Loading 0 commands from copy script /Users/admin/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 01:06:33 PM | Info | /Volumes/NBH Imac
| 01:06:34 PM | Info | -rw-r--r-- 1 0 20 - 0 Mar 16 13:06 /Volumes/Macintosh HD/private/var/root/Library/Application Support/SyncServices/Local/DataReferences/349/4F5EB7D0-DD3E-4650-B056-7AC58F50C913.truth.data
| 01:06:34 PM | Info | /Volumes/NBH Imac/cores
| 01:06:34 PM | Info | /Volumes/NBH Imac/Network
| 01:06:34 PM | Info | /Volumes/NBH Imac/Teachers Pack
| 01:06:34 PM | Info | /Volumes/NBH Imac/private
| 01:06:34 PM | Error | SDCopy: Error "Operation not permitted" encountered while setting HFS meta data for /Volumes/Macintosh HD/private/var/root/Library/Application Support/SyncServices/Local/DataReferences/349/4F5EB7D0-DD3E-4650-B056-7AC58F50C913.truth.data of type: 8\n: Operation not permitted

[dnanian]

No, actually -- in this case -- reset your sync history on the source drive using iSync's prefs.

[mad101dan]

Sorry for being thick

When you say source drive, is that not the backed up version I have.

Just to make it simpe, I have a backup I took which is not sitting on my external HD and is called NBH Imac.

I am trying to restore it to the imac internal HD, which is now blank.

So the only place I can see to reset the isync is on my external backup.

I have tried this and am stilling getting the error above.

Thx for your help.

[dnanian]

No, I mean the source drive, whatever you're copying from right now. I can't tell what they are in the small log snippet you sent.

[mad101dan]

Here is the full log.

i have reset isync on the backup and on the actual live OS I am using now. I am still getting this error.

| 04:06:01 PM | Info | SuperDuper!, 2.5 (84), path: /Users/admin/Desktop/SuperDuper!.app, Mac OS 10.5.6 build 9G55 (i386)
| 04:06:01 PM | Info | Started on Mon, Mar 16, 2009 at 4:06 PM
| 04:06:01 PM | Info | Source Volume: NBH Imac, mount: /Volumes/NBH Imac, device: /dev/disk2s11, media: WD 5000AAJS Externa, interconnect: External FireWire, file system: "Journaled HFS+", OS: 10.5.6 (9G55), capacity: 212.81 GB, used: 31.12 GB, directories: 186037, files: 745876, ejectable: NO, ACLs: Enabled
| 04:06:01 PM | Info | Target Volume: Macintosh HD, mount: /Volumes/Macintosh HD, device: /dev/disk0s2, media: ST3250824AS Q, interconnect: Internal SATA, file system: "Journaled HFS+", OS: N/A, capacity: 232.57 GB, used: 0.13 GB, directories: 62, files: 82, ejectable: NO, ACLs: Enabled
| 04:06:01 PM | Info | Copy Mode : Erase, then copy files
| 04:06:01 PM | Info | Copy Script : Backup - all files.dset
| 04:06:01 PM | Info | Transcript : BuildTranscript.plist
| 04:06:01 PM | Info | PHASE: 1. Prepare to Copy Files
| 04:06:01 PM | Info | ...ACTION: Preparing NBH Imac
| 04:06:01 PM | Info | ......COMMAND => Verifying the integrity of volinfo.database
| 04:06:01 PM | Info | volinfo.database OK
| 04:06:01 PM | Info | ......COMMAND => Enabling permissions on NBH Imac
| 04:06:01 PM | Info | Refreshing Disk Arbitration ...
| 04:06:01 PM | Info | ......COMMAND => Verifying that permissions are enabled for NBH Imac
| 04:06:01 PM | Info | Permissions on '/Volumes/NBH Imac' are enabled.
| 04:06:01 PM | Info | ...ACTION: Erasing Macintosh HD
| 04:06:01 PM | Info | ......COMMAND => Preserving Macintosh HD UUID
| 04:06:01 PM | Info | A55F46DE8455BEEA
| 04:06:01 PM | Info | ......COMMAND => Preserving spotlight indexing state
| 04:06:02 PM | Info | ......COMMAND => Erasing Macintosh HD
| 04:06:09 PM | Info | ......COMMAND => Restoring Macintosh HD UUID (A55F46DE8455BEEA)
| 04:06:09 PM | Info | A55F46DE8455BEEA
| 04:06:09 PM | Info | ......COMMAND => Restoring Spotlight search indexing state on Macintosh HD
| 04:06:10 PM | Info | ...ACTION: Preparing Macintosh HD
| 04:06:10 PM | Info | ......COMMAND => Enabling permissions on Macintosh HD
| 04:06:10 PM | Info | Refreshing Disk Arbitration ...
| 04:06:10 PM | Info | ......COMMAND => Verifying that permissions are enabled for Macintosh HD
| 04:06:10 PM | Info | Permissions on '/Volumes/Macintosh HD' are enabled.
| 04:06:10 PM | Info | ......COMMAND => Verifying that Macintosh HD ACL support matches NBH Imac
| 04:06:10 PM | Info | ...ACTION: Preserving Spotlight state on Macintosh HD
| 04:06:10 PM | Info | ......COMMAND => Disabling Spotlight search indexing on Macintosh HD
| 04:06:10 PM | Info | PHASE: 2. Copy Files
| 04:06:10 PM | Info | ...ACTION: Copying files from NBH Imac to Macintosh HD
| 04:06:10 PM | Info | ......COMMAND => Cloning NBH Imac to Macintosh HD
| 04:06:10 PM | Info | Copying copy files using script: /Users/admin/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 04:06:10 PM | Info | Loading 22 commands from copy script /Users/admin/Desktop/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system temporary files.dset
| 04:06:10 PM | Info | Loading 6 commands from copy script /Users/admin/Desktop/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude system cache files.dset
| 04:06:10 PM | Info | Loading 1 commands from copy script /Users/admin/Desktop/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Norton FileSaver files.dset
| 04:06:10 PM | Info | Loading 1 commands from copy script /Users/admin/Desktop/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude Google Desktop Index files.dset
| 04:06:10 PM | Info | Loading 1 commands from copy script /Users/admin/Desktop/SuperDuper!.app/Contents/Resources/Copy Scripts/Exclude iTunes Temporary files.dset
| 04:06:10 PM | Info | Loading 0 commands from copy script /Users/admin/Library/Application Support/SuperDuper!/Copy Scripts/Standard Scripts/Backup - all files.dset
| 04:06:10 PM | Info | /Volumes/NBH Imac
| 04:06:11 PM | Info | -rw-r--r-- 1 0 20 - 0 Mar 16 16:06 /Volumes/Macintosh HD/private/var/root/Library/Application Support/SyncServices/Local/DataReferences/349/4F5EB7D0-DD3E-4650-B056-7AC58F50C913.truth.data
| 04:06:11 PM | Info | /Volumes/NBH Imac/cores
| 04:06:11 PM | Info | /Volumes/NBH Imac/Network
| 04:06:11 PM | Info | /Volumes/NBH Imac/Teachers Pack
| 04:06:11 PM | Info | /Volumes/NBH Imac/private
| 04:06:11 PM | Error | SDCopy: Error "Operation not permitted" encountered while setting HFS meta data for /Volumes/Macintosh HD/private/var/root/Library/Application Support/SyncServices/Local/DataReferences/349/4F5EB7D0-DD3E-4650-B056-7AC58F50C913.truth.data of type: 8\n: Operation not permitted

[dnanian]

OK. So, you'll want to start up from your NBH Imac volume and reset the sync history.

Alternatively, I believe Disk Warrior can fix this kind of file system damage. Do you have that?

[mad101dan]

Thx, using Disk Warrior seems to have solved the issue. I am still in the process of copy bacl to my imac but it seems to have gotten alot further than before.

Thx for the support, very quick and helpful. Really high quality.