Backups fail after upgrade

I recently upgraded from 1.3.2 to 1.4.10

Many backups now fail.

The server side auto upgraded all the windows clients to 1.4.9.

The file backups were failing repeatedly. I have tried to uninstall the urbackup client and re-install it and it seems to behave the same way.

I have compared the settings.cfg to another box that is still working, and they are identical except for the computername.

Ive included the settings.cfg, client debug log, server debug log, and some status.

Im not sure where I can look next to correct this behavior. I was thinking about digging in to some of these .db files, they are probably sqlite?

Client settings.cfg:

allow_config_paths_def=true
allow_log_view_def=true
allow_overwrite_def=true
allow_pause_def=true
allow_starting_full_file_backups_def=true
allow_starting_full_image_backups_def=true
allow_starting_incr_file_backups_def=true
allow_starting_incr_image_backups_def=true
allow_tray_exit_def=true
background_backups_def=true
backup_window=1-7/19-24,0-2
backup_window_full_file_def=1-7/19-24,0-2
backup_window_full_image_def=1-7/19-24,0-2
backup_window_incr_file_def=1-7/19-24,0-2
backup_window_incr_image_def=1-7/19-24,0-2
client_quota_def=100%
computername=SQLC04S1
default_dirs_def=C
end_to_end_file_backup_verification_def=false
exclude_files=pagefile.sys,*/backup_exclude/*
file_hash_collect_amount_def=1000
file_hash_collect_cachesize_def=40960
file_hash_collect_timeout_def=10000
follow_symlinks_def=true
image_file_format_def=vhdz
image_letters=C
include_files=B:\*
internet_authkey=
internet_calculate_filehashes_on_client_def=false
internet_compress=false
internet_connect_always_def=false
internet_encrypt=false
internet_full_file_backups=false
internet_full_file_transfer_mode_def=hashed
internet_image_backups=false
internet_image_transfer_mode_def=hashed
internet_incr_file_transfer_mode_def=blockhash
internet_mode_enabled=false
internet_readd_file_entries_def=true
internet_server=
internet_server_port=55415
internet_speed=-1
local_full_file_transfer_mode_def=hashed
local_image_transfer_mode_def=hashed
local_incr_file_transfer_mode_def=hashed
local_speed=-1
max_file_full=10
max_file_incr=100
max_image_full=5
max_image_incr=30
min_file_full=2
min_file_incr=40
min_image_full=2
min_image_incr=4
silent_update_def=true
startup_backup_delay=0
update_freq_full=2592000
update_freq_image_full=5184000
update_freq_image_full_orig=5184000
update_freq_image_incr=604800
update_freq_incr=43200
verify_using_client_hashes_def=false
client_set_settings=true
client_set_settings_time=1447952038

Server debug log:

2015-11-19 10:54:31: msg=START BACKUP FULL
2015-11-19 10:54:31: Starting full file backup...
2015-11-19 10:54:31: SQLC04S1: Connecting for filelist...
2015-11-19 10:54:31: SQLC04S1: Waiting for filelist
2015-11-19 10:54:31: Created new database connection for urbackup/backup_server.db
2015-11-19 10:54:50: WARNING: Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
2015-11-19 10:54:50: WARNING: Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
2015-11-19 10:54:50: WARNING: Writer is in error state during snapshot creation. Writer data may not be consistent. This means the files open by this application (e.g. databases) will be backed up in a crash consistent state instead of a properly shutdown state. Properly written applications can recover from system crashes or power failures.
2015-11-19 10:54:50: Indexing of "C" done. 1 filesystem lookups 0 db lookups and 0 db updates
2015-11-19 10:54:50: SQLC04S1: Doing backup with hashed transfer...
2015-11-19 10:54:50: SQLC04S1: Loading file list...
2015-11-19 10:54:50: SQLC04S1: Started loading files...
2015-11-19 10:54:50: Created new database connection for urbackup/backup_server.db
2015-11-19 10:54:50: Starting shadowcopy "C".
2015-11-19 10:55:00: Stoping shadowcopy "C".
2015-11-19 10:55:00: Waiting for file transfers...
2015-11-19 10:55:03: Writing new file list...
2015-11-19 10:55:03: Waiting for file hashing and copying threads...
2015-11-19 10:55:03: Setting cachesize to 40960
2015-11-19 10:55:04: Transferred 92 bytes - Average speed: 48 Bit/s
2015-11-19 10:55:04: Script does not exist urbackup/post_full_filebackup
2015-11-19 10:55:04: Setting cachesize to 40960
2015-11-19 10:55:04: server_prepare_hash Thread finished (exit)
2015-11-19 10:55:04: server_hash Thread finished - normal
2015-11-19 10:55:04: Time taken for backing up client SQLC04S1: 33s
2015-11-19 10:55:04: Backup succeeded
2015-11-19 10:55:04: Updating statistics...
2015-11-19 10:55:04: Done updating statistics.

Client debug log:

2015-11-19 10:54:30: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:30: rc=0 hasError=true state=0
2015-11-19 10:54:30: ClientService cmd: START BACKUP FULL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:30: rc=0 hasError=true state=0
2015-11-19 10:54:30: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#PING RUNNING --#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:54:30: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#3START FULL BACKUP#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:54:30: rc=0 hasError=true state=0
2015-11-19 10:54:30: Removing VSS log data...
2015-11-19 10:54:30: Final path: C:\
2015-11-19 10:54:31: Deleting files... doing full index...
2015-11-19 10:54:31: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:31: rc=0 hasError=true state=0
2015-11-19 10:54:31: ClientService cmd: STATUS#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:31: rc=0 hasError=true state=0
2015-11-19 10:54:31: ClientService cmd: GET INCRINTERVALL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:31: rc=0 hasError=true state=0
2015-11-19 10:54:32: Final path: C:\
2015-11-19 10:54:32: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:32: rc=0 hasError=true state=0
2015-11-19 10:54:33: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:33: rc=0 hasError=true state=0
2015-11-19 10:54:34: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:34: rc=0 hasError=true state=0
2015-11-19 10:54:35: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:35: rc=0 hasError=true state=0
2015-11-19 10:54:36: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:36: rc=0 hasError=true state=0
2015-11-19 10:54:37: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:37: rc=0 hasError=true state=0
2015-11-19 10:54:38: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:38: rc=0 hasError=true state=0
2015-11-19 10:54:39: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:39: rc=0 hasError=true state=0
2015-11-19 10:54:40: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:40: rc=0 hasError=true state=0
2015-11-19 10:54:40: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#PING RUNNING --#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:54:40: rc=0 hasError=true state=0
2015-11-19 10:54:41: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:41: rc=0 hasError=true state=0
2015-11-19 10:54:42: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:42: rc=0 hasError=true state=0
2015-11-19 10:54:42: Creating shadowcopy of "C" in indexDirs()
2015-11-19 10:54:43: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:43: rc=0 hasError=true state=0
2015-11-19 10:54:44: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:44: rc=0 hasError=true state=0
2015-11-19 10:54:44: Number of Writers: 12
2015-11-19 10:54:44: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer SqlServerWriter has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: WARNING: Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
2015-11-19 10:54:44: Writer ASR Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer Shadow Copy Optimization Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:44: Writer Cluster Database has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Number of Writers: 12
2015-11-19 10:54:45: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer SqlServerWriter has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer ASR Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer Shadow Copy Optimization Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: Writer Cluster Database has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:45: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:45: rc=0 hasError=true state=0
2015-11-19 10:54:46: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:46: rc=0 hasError=true state=0
2015-11-19 10:54:46: Number of Writers: 12
2015-11-19 10:54:46: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:46: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:46: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:54:46: Writer SqlServerWriter has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: Writer System Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: WARNING: Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
2015-11-19 10:54:46: Writer ASR Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: Writer Shadow Copy Optimization Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: Writer Registry Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: Writer WMI Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: Writer COM+ REGDB Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: Writer Cluster Database has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2015-11-19 10:54:46: WARNING: Writer is in error state during snapshot creation. Writer data may not be consistent. This means the files open by this application (e.g. databases) will be backed up in a crash consistent state instead of a properly shutdown state. Properly written applications can recover from system crashes or power failures.
2015-11-19 10:54:47: Shadowcopy path: \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy16
2015-11-19 10:54:47: done.
2015-11-19 10:54:47: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:47: rc=0 hasError=true state=0
2015-11-19 10:54:48: Scanning for changed hard links in "C"...
2015-11-19 10:54:48: Changed dir: c:\opt\consul\data\serf\
...
2015-11-19 10:54:48: Changed dir: c:\windows\winsxs\amd64_microsoft-windows-nfs-server-clusterv2_31bf3856ad364e35_6.2.9200.16384_none_5d99a73045afd485\
2015-11-19 10:54:48: Indexing "C"...
2015-11-19 10:54:48: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:48: Indexing of "C" done. 1 filesystem lookups 0 db lookups and 0 db updates
2015-11-19 10:54:48: rc=0 hasError=true state=0
2015-11-19 10:54:48: Deleting backup of changed dirs...
2015-11-19 10:54:49: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:49: rc=0 hasError=true state=0
2015-11-19 10:54:50: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#GET VSSLOG
2015-11-19 10:54:50: VSS logdata - 827 bytes
2015-11-19 10:54:50: rc=0 hasError=true state=0
2015-11-19 10:54:50: rc=0 hasError=true state=0
2015-11-19 10:54:50: FileSrv: Info: Window size=524288
2015-11-19 10:54:50: FileSrv: Received data...
2015-11-19 10:54:50: FileSrv: Received a Packet.
2015-11-19 10:54:50: FileSrv: Sending file (normal) urbackup/filelist.ub
2015-11-19 10:54:50: FileSrv: Mapped name: C:\Program Files\UrBackup\urbackup\data\filelist.ub
2015-11-19 10:54:50: FileSrv: Reading last file part
2015-11-19 10:54:50: FileSrv: Info: File End
2015-11-19 10:54:50: FileSrv: Closed file.
2015-11-19 10:54:50: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#START SC "C"#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:54:50: orig_target=C:\ volpath=\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy16
2015-11-19 10:54:50: Shadowcopy already present.
2015-11-19 10:54:50: rc=0 hasError=true state=0
2015-11-19 10:54:50: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:50: rc=0 hasError=true state=0
2015-11-19 10:54:50: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#PING RUNNING -100-#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:54:50: rc=0 hasError=true state=0
2015-11-19 10:54:51: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:51: rc=0 hasError=true state=0
2015-11-19 10:54:52: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:52: rc=0 hasError=true state=0
2015-11-19 10:54:53: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:53: rc=0 hasError=true state=0
2015-11-19 10:54:54: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:54: rc=0 hasError=true state=0
2015-11-19 10:54:55: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:55: rc=0 hasError=true state=0
2015-11-19 10:54:56: ClientService cmd: PONG
2015-11-19 10:54:56: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:56: rc=0 hasError=true state=0
2015-11-19 10:54:57: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:57: rc=0 hasError=true state=0
2015-11-19 10:54:58: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:58: rc=0 hasError=true state=0
2015-11-19 10:54:59: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:54:59: rc=0 hasError=true state=0
2015-11-19 10:55:00: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#STOP SC "C"#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:55:00: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:55:00: rc=0 hasError=true state=0
2015-11-19 10:55:00: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#2PING RUNNING pc_done=100&eta_ms=61000#token=CmSe19N5uy3B80ql6pN8
2015-11-19 10:55:00: rc=0 hasError=true state=0
2015-11-19 10:55:01: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:55:01: rc=0 hasError=true state=0
2015-11-19 10:55:02: Number of Writers: 12
2015-11-19 10:55:02: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer SqlServerWriter has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: WARNING: Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
2015-11-19 10:55:02: Writer ASR Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer Shadow Copy Optimization Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer Cluster Database has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2015-11-19 10:55:02: Deleting shadowcopy for path "\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy16\" -2
2015-11-19 10:55:02: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:55:02: rc=0 hasError=true state=0
2015-11-19 10:55:02: Deleting Shadowcopy for dir "C:\"
2015-11-19 10:55:02: rc=0 hasError=true state=0
2015-11-19 10:55:02: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#DID BACKUP
2015-11-19 10:55:02: rc=0 hasError=true state=0
2015-11-19 10:55:03: ClientService cmd: STATUS DETAIL#pw=o57isenTMNVFS0gr5gjKtyKMG4kIR1
2015-11-19 10:55:03: rc=0 hasError=true state=0
2015-11-19 10:55:03: FileSrv: Recv Error in RecvMessage
2015-11-19 10:55:03: FileSrv: Deleting Memory...
2015-11-19 10:55:03: FileSrv: done.
2015-11-19 10:55:03: ClientService cmd: #I6EwFX2eDJp4RG5ySD7AL#2LOGDATA 1447952104 0-1447952071-Starting full file backup...
1-1447952090-Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
1-1447952090-Writer Cluster Shared Volume VSS Writer has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_TIMEOUT. UrBackup will continue with the backup but the associated data may not be consistent.
1-1447952090-Writer is in error state during snapshot creation. Writer data may not be consistent. This means the files open by this application (e.g. databases) will be backed up in a crash consistent state instead of a properly shutdown state. Properly written applications can recover from system crashes or power failures.
0-1447952090-Indexing of "C" done. 1 filesystem lookups 0 db lookups and 0 db updates
0-1447952090-SQLC04S1: Loading file list...
0-1447952090-SQLC04S1: Started loading files...
0-1447952100-Waiting for file transfers...
0-1447952103-Writing new file list...
0-1447952103-Waiting for file hashing and copying threads...
0-1447952104-Transferred 92 bytes - Average speed: 48 Bit/s
0-1447952104-Time taken for backing up client SQLC04S1: 33s
0-1447952104-Backup succeeded

The backups are of C: instead of B: but they are empty.
B: is where all files needing backup are.

Clients > SQLC04S1
	Backup time	Incremental	Size	Archived?
 	2015-11-19 10:54	No	-1 bytes	☐
 	2015-11-19 10:40	No	-1 bytes	☐
 	2015-11-19 10:02	No	0 bytes	☐
 	2015-11-19 10:00	No	0 bytes	☐
 	2015-11-19 09:58	No	0 bytes	☐
 	2015-11-19 09:55	No	0 bytes	☐
 	2015-11-19 09:52	No	0 bytes	☐
 	2015-11-19 09:50	No	0 bytes	☐
 	2015-11-19 09:47	No	0 bytes	☐
 	2015-11-19 09:39	No	0 bytes	☐
 	2015-11-19 09:36	No	0 bytes	☐
 	2015-11-19 09:35	Yes	0 bytes	☐
 	2015-11-19 09:32	No	0 bytes	☐
 	2015-11-19 09:26	No	0 bytes	☐
 	2015-11-19 09:22	No	0 bytes	☐
 	2015-11-19 09:19	No	0 bytes	☐
 	2015-11-10 19:04	Yes	0 bytes	☐
 	2015-11-08 00:24	Yes	80.26 GB	☐
 	2015-11-06 23:13	Yes	83.1 GB	☐
 	2015-11-05 23:09	Yes	88.55 GB	☐
 	2015-11-04 23:05	Yes	90.05 GB	☐
 	2015-11-03 23:05	Yes	83.1 GB	☐
 	2015-11-02 22:20	Yes	83.12 GB	☐
 	2015-11-01 22:18	Yes	89.41 GB	☐
 	2015-10-31 22:01	Yes	84.66 GB	☐
 	2015-10-30 21:53	Yes	86.77 GB	☐
 	2015-10-29 21:52	Yes	1.73 GB	☐
 	2015-10-28 21:46	No	0 bytes	☐
 	2015-10-27 19:01	Yes	0 bytes	☐
 	2015-10-26 01:02	Yes	92.22 GB	☐
 	2015-10-25 00:59	Yes	89.18 GB	☐
 	2015-10-24 00:55	Yes	89.41 GB	☐

Strangely the image backup does appear to be working from the same box.

Computer name	Action	Progress	Files in queue	 
SQLC04S1	Full image backup	
20%	0

You set it to backup files which are both on C:\ and on B:\ – there are no such files.

default_dirs_def=
include_files=B:*

With that in the settings.cfg and restarting the windows service the result is the same. It only tries to backup C: and cant do that either.

Also there is no configuration for “default_dirs_def” in the gui. I think it set it that way as the default. The boxes that are working also have “default_dirs_def=C”.

2015-11-19 14:37:28: Indexing of “C” done. 1 filesystem lookups 0 db lookups and 0 db updates
2015-11-19 14:37:28: SQLC04S1: Doing backup with hashed transfer…
2015-11-19 14:37:28: SQLC04S1: Loading file list…
2015-11-19 14:37:28: SQLC04S1: Started loading files…
2015-11-19 14:37:28: Starting shadowcopy “C”.