[Can not read data.]

[ndumoulin]

Hi there,
We have a recurring issue with vvengine 1.1 and vice versa Pro 2 , some files are not copied to the destination. The error is : [Can not read data.] [ERROR].
The data being copied is local and it is being backup to a NAS. There does not seem to be any network issues because we have consistent ping to the NAS(no timeout, max is 15ms) , but I may be wrong.


When we run it in vice versa manually it works all the time but it’s not the case if used with vvengine and the scheduler.

Here's a copy of the log file:
C:\Documents and Settings\All Users\Application Data\ViceVersa PRO 2\log1.log
Extract of File: C:\Documents and Settings\All Users\Application Data\ViceVersa PRO 2\log1.log
2011-09-29 08:10:03 : START ID: 201192912100-3480441-4156
2011-09-29 08:10:03 : ************************************************************
2011-09-29 08:10:03 : Profile Started.
2011-09-29 08:10:03 : ************************************************************
2011-09-29 08:10:03 : Version: ViceVersa PRO 2 Build 2014 (SN80)
2011-09-29 08:10:03 : Command Line: "C:\Program Files\ViceVersa Pro 2\VICEVERSA.EXE" "C:\MsProtectData\Profile\MsProtectData_SQL_Servus.fsf" /hiddenautosync /vveng
2011-09-29 08:10:03 : System: , (Terminal Services), (Terminal Services in Remote Admin Mode), (Multiprocessor Free), (x86-32 Processor) v5.2 Build:3790 Service Pack:2
2011-09-29 08:10:03 : User: Domain\user
2011-09-29 08:10:03 : Computer: BACKUP
2011-09-29 08:10:03 : **** Profile: C:\MsProtectData\Profile\MsProtectData_SQL_Servus.fsf
2011-09-29 08:10:03 : **** - Folders -
2011-09-29 08:10:03 : **** Source: "\\?\f:\backup\SQL\SERVUS\"
2011-09-29 08:10:03 : **** Target: "\\?\unc\nas01\bck$\backup\SQL\SERVUS\" (Encrypted)
2011-09-29 08:10:03 : **** Include Subfolders: Yes
2011-09-29 08:10:03 : **** Create sources/targets that do not exist
2011-09-29 08:10:03 : **** Network: connect to "\\nas01\bck$\" with user "user" and disconnect when done
2011-09-29 08:10:03 : **** Exclude system files
2011-09-29 08:10:03 : **** - Comparison Settings -
2011-09-29 08:10:03 : **** Comparison Type: Size and Timestamp
2011-09-29 08:10:03 : **** Ignore 2 seconds difference
2011-09-29 08:10:03 : **** - Execution Settings -
2011-09-29 08:10:03 : **** Method: Backup (Mirror Source to Target)
2011-09-29 08:10:03 : **** No overwrite / read-only / error confirmations
2011-09-29 08:10:03 : **** Log File: "C:\Documents and Settings\All Users\Application Data\ViceVersa PRO 2\log1.log" (max 5000 KB)
2011-09-29 08:10:03 : **** Log only summary and errors
2011-09-29 08:10:03 : **** No archive for deleted/replaced source files
2011-09-29 08:10:03 : **** No archive for deleted/replaced target files
2011-09-29 08:10:03 : **** Speed: 69 Buffer Size: 32768 (flush the buffer every write)
2011-09-29 08:10:03 : **** Copy files even if timestamp changes after initial comparison
2011-09-29 08:10:03 : **** Try to copy files that are in use by other applications
2011-09-29 08:10:03 : **** Copy file/folder permissions
2011-09-29 08:10:03 : **** Do not copy file/folder data streams
2011-09-29 08:10:03 : **** No empty source/target check
2011-09-29 08:10:03 : **** Replace newer target files with older source files (backup only)
2011-09-29 08:10:03 : **** Run custom scripts after execution
2011-09-29 08:10:03 : Connecting to "\\nas01\bck$" with user "user" ... Connected.
2011-09-29 08:10:03 : Checking source \\?\f:\backup\SQL\SERVUS\ ...
2011-09-29 08:10:03 : Checking target \\?\unc\nas01\bck$\backup\SQL\SERVUS\ ...
2011-09-29 08:10:04 : Comparing ...
2011-09-29 08:10:04 : Comparing done.
2011-09-29 08:10:04 : - Status Summary -
2011-09-29 08:10:04 : - Total Files - Source: 9 (13,59GB) - Target: 9 (13,56GB)
2011-09-29 08:10:04 : - Excluded Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:10:04 : - Matched Files - Source: 8 (12,07GB) - Target: 8 (12,07GB)
2011-09-29 08:10:04 : - Single Files - Source: 1 (1,52GB) - Target: 1 (1,50GB)
2011-09-29 08:10:04 : - Newer Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:10:04 : - Older Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:10:04 : - Total Subfolders - Source: 0 - Target: 0
2011-09-29 08:10:04 : - Excluded Subfolders - Source: 0 - Target: 0
2011-09-29 08:10:04 : - Matched Subfolders - Source: 0 - Target: 0
2011-09-29 08:10:04 : - Single Subfolders - Source: 0 - Target: 0
2011-09-29 08:10:04 : - To Do - Backup (Mirror Source to Target)
2011-09-29 08:10:04 : - Files to Add - Source: 0 (0) - Target: 1 (1,52GB)
2011-09-29 08:10:04 : - Files to Update - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:10:04 : - Files to Delete - Source: 0 (0) - Target: 1 (1,50GB)
2011-09-29 08:10:04 : - Subfolders to Add - Source: 0 - Target: 0
2011-09-29 08:10:04 : - Subfolders to Delete - Source: 0 - Target: 0
2011-09-29 08:10:04 :
2011-09-29 08:10:04 : ---- Start Execution ----
2011-09-29 08:10:04 : ---- Backup (Mirror Source to Target) (Source: \\?\f:\backup\SQL\SERVUS\ Target: \\?\unc\nas01\bck$\backup\SQL\SERVUS\) ----
2011-09-29 08:10:04 : ---- Start deleting ----
2011-09-29 08:10:04 : -- Deleting from target ...
2011-09-29 08:10:04 : -- Done: 1 (1,50GB) Err: 0 (0) Skipped: 0 (0) Tot: 1 (1,50GB) --
2011-09-29 08:10:04 : -- Objects Deleted per Second: 1.00 -- Elapsed Time: 0 sec
2011-09-29 08:10:04 : Re-comparing ...
2011-09-29 08:10:04 : ---- Deleting finished ----
2011-09-29 08:10:04 : ---- Start copying ----
2011-09-29 08:10:04 : -- Copying to target...
2011-09-29 08:17:45 : Copying file \\?\f:\backup\SQL\SERVUS\SERVUS_backup_201109281900.bak <to> \\?\unc\nas01\bck$\backup\SQL\SERVUS\SERVUS_backup_201109281900.bak.enc (1,52GB) [Can not read data.] [ERROR].
2011-09-29 08:17:45 : -- Done: 0 (0) Err: 1 (1,52GB) Skipped: 0 (0) Tot: 1 (1,52GB) --
2011-09-29 08:17:45 : -- Average Transfer Rate: 0/Sec -- Elapsed Time: 7 min 40 sec
2011-09-29 08:17:45 : Re-comparing ...
2011-09-29 08:17:45 : ---- Copying finished ----
2011-09-29 08:17:45 : ---- End ----
2011-09-29 08:17:45 : - Execution Summary -
2011-09-29 08:17:45 : - Added Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:17:45 : - Updated Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:17:45 : - Deleted Files - Source: 0 (0) - Target: 1 (1,50GB)
2011-09-29 08:17:45 : -- Errors (Adding) - Source: 0 (0) - Target: 1 (1,52GB) [ERROR]
2011-09-29 08:17:45 : - Added Subfolders - Source: 0 - Target: 0
2011-09-29 08:17:45 : - Deleted Subfolders - Source: 0 - Target: 0
2011-09-29 08:17:45 : - Status Summary -
2011-09-29 08:17:45 : - Total Files - Source: 9 (13,59GB) - Target: 8 (12,07GB)
2011-09-29 08:17:45 : - Excluded Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:17:45 : - Matched Files - Source: 8 (12,07GB) - Target: 8 (12,07GB)
2011-09-29 08:17:45 : - Single Files - Source: 1 (1,52GB) - Target: 0 (0)
2011-09-29 08:17:45 : - Newer Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:17:45 : - Older Files - Source: 0 (0) - Target: 0 (0)
2011-09-29 08:17:45 : - Total Subfolders - Source: 0 - Target: 0
2011-09-29 08:17:45 : - Excluded Subfolders - Source: 0 - Target: 0
2011-09-29 08:17:45 : - Matched Subfolders - Source: 0 - Target: 0
2011-09-29 08:17:45 : - Single Subfolders - Source: 0 - Target: 0
2011-09-29 08:17:45 : Disconnected from \\nas01\bck$
2011-09-29 08:17:45 : Exit Code: 3. Execution completed with file copy/delete errors. [ERROR]
2011-09-29 08:17:45 : Running script C:\Program Files\ViceVersa Pro 2\GlobalScripts\Global_end.vbs
2011-09-29 08:17:47 : Script Output:
2011-09-29 08:17:47 : Microsoft (R) Windows Script Host Version 5.6
2011-09-29 08:17:47 : Copyright (C) Microsoft Corporation 1996-2001. Tous droits r‚serv‚s.


Can you help me solve this issue?

Thanks

[TGRMN Software]

That's strange: the error is generated because of trouble reading the source file. Is the disk OK? thanks
_________________
--
TGRMN Software Support
http://www.tgrmn.com
http://www.compareandmerge.com

[Guest]

If we had problems with the local disks we would have the same problem running the profile manually which is not the case.

We seem to have this problem only with big files over 1Gig.

The host for the vvengine service is a windows 2003 server and the nas is a windows XP Pro.

[ndumoulin]

Also if you watch closely, it took 7 minutes to run before reporting the error. This means that the file was in the process of being copied to the destination.

And for a file that big it takes 8 minutes on average so it was almost done when the error occured.