Clone of Bootcamp partition taking 15hrs+ with Winclone 8.2

I am still stuck at a point where I can’t do a backup with v8.2 in anything less than 20+ hours for a measly 100GB Bootcamp partition that has about 40GB of data on it.

I started another attempt at 2:56pm today, and it is now 4:37pm…It shows 11% progress (as per the log entries), so make that about 15hrs until completion…that can’t…be…right. :-/

Also, what I see happening in the log file makes no sense to me…it shows that it is at 479GB of 759GB, which just don’t exist on that partition…when it first scanned the backup job, it saw 848GB, and has slowly been counting down to around 600GB and then back up to 756GB now…what is it seeing and backing up?

Here are some relevant parts of my log up to about 15 minutes ago:

2020-07-16T14:56:36+02:00:Winclone 8.2 (48121)
2020-07-16T14:56:36+02:00:Product ID:Winclone Standard
2020-07-16T14:56:36+02:00:Licensed to t***@.com
2020-07-16T14:56:36+02:00:License Key A6D-
2020-07-16T14:56:36+02:00:Model Identifier: MacBookPro15,3
2020-07-16T14:56:36+02:00:=================diskutil list=================
2020-07-16T14:56:37+02:00:/dev/disk0 (internal, physical):
#: TYPE NAME SIZE IDENTIFIER
0: GUID_partition_scheme *1.0 TB disk0
1: EFI EFI 314.6 MB disk0s1
2: Apple_APFS Container disk1 899.0 GB disk0s2
3: Microsoft Basic Data Win10 101.2 GB disk0s3

/dev/disk1 (synthesized):
…
…
…
2020-07-16T14:56:37+02:00:===============================================
2020-07-16T14:57:27+02:00:We have Windows, but no BOOT folder, so checking to see if there is another partition on the same drive that has the folder. If so, we have a split boot config, and will grab the boot files
2020-07-16T14:57:46+02:00:Setting to not sleep…
2020-07-16T14:57:46+02:00:Writing Version of Windows to Image
2020-07-16T14:57:47+02:00:Starting Helper Tool
2020-07-16T14:57:47+02:00:setting up listener for mach service com.twocanoes.WincloneHelper
2020-07-16T14:57:47+02:00:Getting new connection request
2020-07-16T14:57:49+02:00:Saving Partition Type, 2.000000% complete
2020-07-16T14:57:49+02:00:Could not read /dev/disk0. Probably due to SIP. Ignoring and returning 0x07
2020-07-16T14:57:49+02:00:Saving Filesize, 3.000000% complete
2020-07-16T14:57:51+02:00:Preparing to Save Image, 5.000000% complete
2020-07-16T14:57:51+02:00:Executing “ntfslabel -f -f /dev/disk0s3”
2020-07-16T14:57:52+02:00:Executing “wimcapture /dev/disk0s3 /Volumes/4TB-USB3.2/_BAK/Computers/Bootcamp/rMBP-2018/rMBP2018_Win10-Bootcamp.winclone/Windows.wim --strict-acls --check”
2020-07-16T14:57:52+02:00:Capturing WIM image from NTFS filesystem on “/dev/disk0s3”
Scanning “/dev/disk0s3”
2020-07-16T14:57:52+02:00:Starting File Clone, 5.000000% complete
…
2020-07-16T15:54:47+02:00:Archiving file data: 271 GiB of 805 GiB (33%) done
2020-07-16T15:54:48+02:00:Last message repeated 38 times
2020-07-16T15:54:48+02:00:Archiving file data, 8.300000% complete
2020-07-16T15:54:50+02:00:Last message repeated 37 times
2020-07-16T15:54:50+02:00:Archiving file data: 271 GiB of 805 GiB (33%) done
2020-07-16T15:54:50+02:00:Last message repeated 36 times
2020-07-16T15:54:50+02:00:Archiving file data, 8.300000% complete
…
2020-07-16T16:57:43+02:00:Last message repeated 30 times
2020-07-16T16:57:43+02:00:Archiving file data, 12.600000% complete
2020-07-16T16:57:43+02:00:Last message repeated 30 times
2020-07-16T16:57:43+02:00:Archiving file data: 560 GiB of 731 GiB (76%) done
2020-07-16T16:57:45+02:00:Last message repeated 31 times
2020-07-16T16:57:45+02:00:Archiving file data, 12.600000% complete
2020-07-16T16:57:45+02:00:Last message repeated 31 times
2020-07-16T16:57:45+02:00:Archiving file data: 560 GiB of 731 GiB (76%) done
2020-07-16T16:57:47+02:00:Last message repeated 31 times
2020-07-16T16:57:47+02:00:Archiving file data, 12.600000% complete
2020-07-16T16:57:47+02:00:Last message repeated 31 times
2020-07-16T16:57:47+02:00:Archiving file data: 560 GiB of 731 GiB (76%) done
2020-07-16T16:57:49+02:00:Last message repeated 32 times
2020-07-16T16:57:49+02:00:Archiving file data, 12.600000% complete
2020-07-16T16:57:49+02:00:Last message repeated 32 times
2020-07-16T16:57:49+02:00:Archiving file data: 560 GiB of 731 GiB (76%) done
2020-07-16T16:57:50+02:00:Last message repeated 19 times
2020-07-16T16:57:50+02:00:Archiving file data: 561 GiB of 731 GiB (76%) done

What’s going on, and how can it be fixed?

btw, I saw this line:

2020-07-16T14:57:49+02:00:Could not read /dev/disk0. Probably due to SIP. Ignoring and returning 0x07

so I should mention that SIP happens to be disabled on my MBP right now…had to do that in order to get a macOS Big Sur Beta to install to and boot from an external SSD. But the behavior I described above also happened in exactly the same way before I disabled SIP.

huh, now it’s at 90%…I mean, it’s been 3hrs, and not 15hrs+, but still, with only 40GB of data on that partition, it shouldn’t take more than half an hour, so…

here is where it’s at:

2020-07-16T18:02:40+02:00:Last message repeated 203 times
2020-07-16T18:02:40+02:00:Verifying file data, 90.099998% complete
2020-07-16T18:02:42+02:00:Last message repeated 213 times
2020-07-16T18:02:42+02:00:Verifying file data: 623 GiB of 694 GiB (89%) done
2020-07-16T18:02:42+02:00:Last message repeated 221 times
2020-07-16T18:02:42+02:00:Verifying file data, 90.099998% complete
2020-07-16T18:02:44+02:00:Last message repeated 213 times
2020-07-16T18:02:44+02:00:Verifying file data: 624 GiB of 694 GiB (89%) done
2020-07-16T18:02:44+02:00:Last message repeated 217 times
2020-07-16T18:02:44+02:00:Verifying file data, 90.099998% complete
2020-07-16T18:02:46+02:00:Last message repeated 193 times
2020-07-16T18:02:46+02:00:Verifying file data: 624 GiB of 694 GiB (90%) done
2020-07-16T18:02:46+02:00:Last message repeated 175 times
2020-07-16T18:02:46+02:00:Verifying file data, 91.000000% complete
2020-07-16T18:02:46+02:00:Last message repeated 19 times
2020-07-16T18:02:46+02:00:Verifying file data: 625 GiB of 694 GiB (90%) done
…
2020-07-16T18:07:24+02:00:Verifying file data: 694 GiB of 694 GiB (100%) done
2020-07-16T18:07:24+02:00:Last message repeated 67 times
2020-07-16T18:07:24+02:00:Verifying file data, 100.000000% complete
2020-07-16T18:07:25+02:00:"/Volumes/4TB-USB3.2/_BAK/Computers/Bootcamp/rMBP-2018/rMBP2018_Win10-Bootcamp.winclone/Windows.wim" was successfully verified.
2020-07-16T18:07:27+02:00:Last message repeated 1 times
2020-07-16T18:07:27+02:00:(null)
2020-07-16T18:07:27+02:00:Setting the system to allow sleep…

It looks like it completed. Is it still showing that it is in progress?

tim

No, it completed, but that wasn’t my concern anymore. My concern is why it took 3 hrs for 36GB on an otherwise empty 100GB partition? At one hour per 10GB, would I have to wait 30hrs to back up my usual fully configured system of 300GB? I know incremental will be quicker, but I don’t understand why it’s backing up so dreadfully slow. CCC burns through a 300GB backup in an hour, hour and a half.