New server backup image failing. Creating shadow copy failed

Digitalmatter · May 30, 2019, 3:52pm

Server 2016 Std fresh deployment.
Installed URBackup to get the initial full image backup done.
I see SYSVOL goes through and as soon as it goes to backup the drives, the backups fail immediately and the task closes. Below error message shows in the log.

VSS is running.

|Warnings| 05/30/19 11:49 Error retrieving last image backup. Doing full image backup instead.

|Errors| 05/30/19 11:49 Request of image backup failed. Reason: Creating shadow copy failed. See client log file for details.

|Errors| 05/30/19 11:49 Backup failed

The below is pulled from the client debugging log

2019-05-30 11:17:51: ERROR: CoInitializeEx(NULL, COINIT_APARTMENTTHREADED) failed. VSS error code UNDEF(-2147024888)
2019-05-30 11:17:51: ERROR: CoInitializeSecurity(NULL, -1, NULL, NULL, RPC_C_AUTHN_LEVEL_PKT_PRIVACY, RPC_C_IMP_LEVEL_IDENTIFY, NULL, EOAC_NONE, NULL) failed. VSS error code UNDEF(-2147221008)
2019-05-30 11:21:09: ERROR: Ident reset (1)
2019-05-30 11:21:52: ERROR: backupcom->InitializeForBackup() failed. VSS error code VSS_E_UNEXPECTED
2019-05-30 11:21:52: ERROR: Creating shadowcopy of “D:” failed.
2019-05-30 11:21:52: ERROR: Creating shadow copy failed. See client log file for details.
2019-05-30 11:21:54: ERROR: backupcom->InitializeForBackup() failed. VSS error code VSS_E_UNEXPECTED
2019-05-30 11:21:54: ERROR: Creating shadowcopy of “E:” failed.
2019-05-30 11:21:54: ERROR: Creating shadow copy failed. See client log file for details.
2019-05-30 11:23:41: ERROR: Not found
2019-05-30 11:23:41: ERROR: backupcom->InitializeForBackup() failed. VSS error code VSS_E_UNEXPECTED
2019-05-30 11:23:41: ERROR: Creating shadowcopy of “C:” failed.
2019-05-30 11:23:41: ERROR: Creating shadow copy failed. See client log file for details.
2019-05-30 11:27:08: Loaded -fileserv- plugin
2019-05-30 11:27:08: Loaded -fsimageplugin- plugin
2019-05-30 11:27:08: Loaded -cryptoplugin- plugin
2019-05-30 11:27:08: SQLite: recovered 43 frames from WAL file C:\Program Files\UrBackup\urbackup\backup_client.db-wal code: 283
2019-05-30 11:27:08: urbackupserver: Server started up successfully!
2019-05-30 11:27:08: FileSrv: Backup privileges set successfully
2019-05-30 11:27:08: FileSrv: Backup privileges set successfully (SE_SECURITY_NAME)
2019-05-30 11:27:08: FileSrv: Backup privileges set successfully (SE_RESTORE_NAME)
2019-05-30 11:27:08: FileSrv: Binding UDP socket at port 35622…
2019-05-30 11:27:08: FileSrv: done.
2019-05-30 11:27:08: FileSrv: Disabling new behavior…
2019-05-30 11:27:08: FileSrv: Servername: -APA-APAsrv01-
2019-05-30 11:27:08: FileSrv: Server started up successfully
2019-05-30 11:27:08: Started UrBackupClient Backend…
2019-05-30 11:27:08: FileSrv: UDP Thread startet
2019-05-30 11:27:08: Filesystem. Vol="\?\Volume{121ffacf-0000-0000-0000-100000000000}" Name=“system reserved” Type=“ntfs” VPaths=0 Size=524283904
2019-05-30 11:27:08: Bootable flag set for volume
2019-05-30 11:27:08: Found potential candidate: \?\Volume{121ffacf-0000-0000-0000-100000000000}\ Score: 103
2019-05-30 11:27:08: Filesystem. Vol="\?\Volume{9b9c4455-da35-43a6-9bc3-7033b397fe01}" Name=“db” Type=“ntfs” VPaths=1 Size=107237863424
2019-05-30 11:27:08: GPT formated hard disk encountered. No bootable flag. Attributes = 0
2019-05-30 11:27:08: Bootable flag not set for volume
2019-05-30 11:27:08: Filesystem. Vol="\?\Volume{c7346426-2f5c-46af-85ec-7051cc3bdb4d}" Name=“data” Type=“ntfs” VPaths=1 Size=966231322624
2019-05-30 11:27:08: GPT formated hard disk encountered. No bootable flag. Attributes = 0
2019-05-30 11:27:08: Bootable flag not set for volume
2019-05-30 11:27:08: Filesystem. Vol="\?\Volume{121ffacf-0000-0000-0000-501f00000000}" Name="" Type=“ntfs” VPaths=1 Size=106847793152
2019-05-30 11:27:08: Filesystem is System partition. Skipping…
2019-05-30 11:27:08: Filesystem. Vol="\?\Volume{c254b59d-1a4c-11e8-965c-806e6f6e6963}" Name=“sss_x64fre_en-us_dv9” Type=“udf” VPaths=1 Size=5883301888
2019-05-30 11:27:08: Bootable flag not set for volume
2019-05-30 11:27:08: Selected volume \?\Volume{121ffacf-0000-0000-0000-100000000000}
2019-05-30 11:27:08: System dir: C:\Windows
2019-05-30 11:27:08: Volpath: \.\C:
2019-05-30 11:27:08: Device is not GPT formatted (0)
2019-05-30 11:27:08: Found no EFI System Partition
2019-05-30 11:27:08: urbackupserver: No available slots… starting new Worker
2019-05-30 11:27:08: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 11:27:08: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 11:27:08: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 11:27:09: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 11:27:09: Looking for old Sessions… 0 sessions
2019-05-30 11:27:09: Internet only mode not enabled. Waiting for local server for 3:00…
2019-05-30 11:27:09: ERROR: CoInitializeEx(NULL, COINIT_APARTMENTTHREADED) failed. VSS error code UNDEF(-2147024888)
2019-05-30 11:27:09: ERROR: CoInitializeSecurity(NULL, -1, NULL, NULL, RPC_C_AUTHN_LEVEL_PKT_PRIVACY, RPC_C_IMP_LEVEL_IDENTIFY, NULL, EOAC_NONE, NULL) failed. VSS error code UNDEF(-2147221008

uroni · May 30, 2019, 4:32pm

If you google for 0x80070008 and CoInitializeEx you’ll find other people with the same problem

e.g. https://adsm.org/lists/html/Bacula-users/2015-04/msg00068.html

Digitalmatter · May 30, 2019, 7:36pm

So the error code states not enough disk space to proceed is what that page is showing.
Disk space is fine on client, storage space is also good on the server. Other backups are running correctly.

So I figured I would dig into VSS and take a look. Running vssadmin list shdowstorage I can see that the utilized space was full with some shadowcopies somehow as shown below. Even though there is more than enough space I removed what was there. Next attempt of a backup fails after backing up SYSVOL.

For volume: (C:)\?\Volume{121ffacf-0000-0000-0000-501f00000000}
Shadow Copy Storage volume: (C:)\?\Volume{121ffacf-0000-0000-0000-501f00000000}
Used Shadow Copy Storage space: 7.74 GB (7%)
Allocated Shadow Copy Storage space: 8.09 GB (8%)
Maximum Shadow Copy Storage space: 9.95 GB (10%)

Deleted the shadow copies

Do you really want to delete 10 shadow copies (Y/N): [N]? y

Successfully deleted 10 shadow copies.

Reran the job and it failed with the following info from the debug file.

Started connection to SERVICE_COMMANDS
2019-05-30 15:21:42: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#MBR driveletter=D
2019-05-30 15:21:42: GUID partition table found
2019-05-30 15:21:42: GUID partition table size is 16 KB
2019-05-30 15:21:42: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:42: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=0&status_id=267&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:21:42: rc=0 hasError=true state=0
2019-05-30 15:21:42: SERVICE_COMMANDS finished
2019-05-30 15:21:43: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:43: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:43: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#FULL IMAGE letter=D:&token=Sn6OgOlDXW0jlIRhVCV5&bitmap=1&status_id=267&running_jobs=1
2019-05-30 15:21:43: Device W:\ isn’t NTFS formatted
2019-05-30 15:21:43: Script “C:\Program Files\UrBackup\preimagebackup.bat” does not exist
2019-05-30 15:21:43: Creating shadowcopy of “D:”…
2019-05-30 15:21:43: ERROR: backupcom->InitializeForBackup() failed. VSS error code VSS_E_UNEXPECTED
2019-05-30 15:21:43: done.
2019-05-30 15:21:43: Disabling CBT on volume “D:”
2019-05-30 15:21:43: ERROR: Creating shadowcopy of “D:” failed.
2019-05-30 15:21:43: ERROR: Creating shadow copy failed. See client log file for details.
2019-05-30 15:21:43: Sending full image done
2019-05-30 15:21:43: SERVICE_COMMANDS finished
2019-05-30 15:21:44: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:44: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:44: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2LOGDATA 1559244095 0-1559244094-Starting unscheduled full image backup of volume “D:”…
0-1559244094-Basing image backup on last incremental or full image backup
1-1559244094-Error retrieving last image backup. Doing full image backup instead.
2-1559244095-Request of image backup failed. Reason: Creating shadow copy failed. See client log file for details.
0-1559244095-Transferred 850 bytes - Average speed: 109.672 KBit/s
0-1559244095-Time taken for backing up client APA-APAsrv01: 951ms
2-1559244095-Backup failed

2019-05-30 15:21:44: rc=0 hasError=true state=0
2019-05-30 15:21:44: SERVICE_COMMANDS finished
2019-05-30 15:21:44: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:44: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=0&status_id=268&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:21:44: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:44: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#MBR driveletter=E
2019-05-30 15:21:44: GUID partition table found
2019-05-30 15:21:44: GUID partition table size is 16 KB
2019-05-30 15:21:45: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:45: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:45: rc=0 hasError=true state=0
2019-05-30 15:21:45: SERVICE_COMMANDS finished
2019-05-30 15:21:45: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:45: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#FULL IMAGE letter=E:&token=Sn6OgOlDXW0jlIRhVCV5&bitmap=1&status_id=268&running_jobs=1
2019-05-30 15:21:45: Device W:\ isn’t NTFS formatted
2019-05-30 15:21:45: Script “C:\Program Files\UrBackup\preimagebackup.bat” does not exist
2019-05-30 15:21:45: Creating shadowcopy of “E:”…
2019-05-30 15:21:45: ERROR: backupcom->InitializeForBackup() failed. VSS error code VSS_E_UNEXPECTED
2019-05-30 15:21:45: done.
2019-05-30 15:21:45: Disabling CBT on volume “E:”
2019-05-30 15:21:45: ERROR: Creating shadowcopy of “E:” failed.
2019-05-30 15:21:45: ERROR: Creating shadow copy failed. See client log file for details.
2019-05-30 15:21:45: Sending full image done
2019-05-30 15:21:45: SERVICE_COMMANDS finished
2019-05-30 15:21:46: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:46: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:46: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2LOGDATA 1559244098 0-1559244097-Starting unscheduled full image backup of volume “E:”…
0-1559244097-Basing image backup on last incremental or full image backup
1-1559244097-Error retrieving last image backup. Doing full image backup instead.
2-1559244098-Request of image backup failed. Reason: Creating shadow copy failed. See client log file for details.
0-1559244098-Transferred 850 bytes - Average speed: 109.672 KBit/s
0-1559244098-Time taken for backing up client APA-APAsrv01: 1s
2-1559244098-Backup failed

2019-05-30 15:21:46: rc=0 hasError=true state=0
2019-05-30 15:21:46: SERVICE_COMMANDS finished
2019-05-30 15:21:47: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:47: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:47: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:47: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=0&status_id=270&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:21:47: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:47: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#MBR driveletter=SYSVOL
2019-05-30 15:21:47: rc=0 hasError=true state=0
2019-05-30 15:21:47: SERVICE_COMMANDS finished
2019-05-30 15:21:47: Started connection to SERVICE_COMMANDS
2019-05-30 15:21:47: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#FULL IMAGE letter=SYSVOL&token=Sn6OgOlDXW0jlIRhVCV5&bitmap=1&status_id=270&running_jobs=1
2019-05-30 15:21:47: Filesystem type is ntfs (\?\Volume{121ffacf-0000-0000-0000-100000000000})
2019-05-30 15:21:47: TotalNumberOfClusters=127999 numberOfClusters=127999 n_clusters=16000 StartingLcn=0 BitmapSize=127999 r_bytes=16016
2019-05-30 15:21:47: FSINFO: blocksize=4096 size=524287488 has_error=false used_space=358768640
2019-05-30 15:21:48: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:49: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:49: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:50: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:51: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:52: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:52: rc=0 hasError=true state=0
2019-05-30 15:21:52: SERVICE_COMMANDS finished
2019-05-30 15:21:53: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:54: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:54: rc=0 hasError=true state=0
2019-05-30 15:21:54: SERVICE_COMMANDS finished
2019-05-30 15:21:55: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:56: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:57: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:57: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=12&status_id=270&speed_bpms=0&total_bytes=358768640&done_bytes=41844736&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:21:58: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:59: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:21:59: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:00: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:01: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:02: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:03: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:04: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:05: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:06: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:06: ClientService cmd: PONG
2019-05-30 15:22:07: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:07: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=27&status_id=270&speed_bpms=0&total_bytes=358768640&done_bytes=97558528&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:22:08: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:09: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:09: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:10: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:11: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:12: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:13: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:14: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:15: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:16: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:17: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:17: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=38&status_id=270&speed_bpms=3927.65&total_bytes=358768640&done_bytes=138051584&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:22:18: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:19: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:19: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:20: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:21: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:22: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:23: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:24: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:25: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:26: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:27: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:27: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=50&status_id=270&speed_bpms=3972.8&total_bytes=358768640&done_bytes=178728960&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:22:28: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:29: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:29: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:30: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:31: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:32: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:33: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:34: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:35: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:36: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:37: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:37: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=61&status_id=270&speed_bpms=3978.05&total_bytes=358768640&done_bytes=219721728&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:22:38: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:39: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:39: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:40: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:41: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:42: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:43: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:44: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:45: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:46: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:47: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:47: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=71&status_id=270&speed_bpms=3468&total_bytes=358768640&done_bytes=255909888&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:22:48: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:49: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:49: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:50: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:51: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:52: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:53: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:54: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:55: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:56: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:57: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:58: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:22:58: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=82&status_id=270&speed_bpms=3906.72&total_bytes=358768640&done_bytes=295813120&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:22:59: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:00: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:00: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:01: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:02: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:03: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:04: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:05: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:06: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:06: ClientService cmd: PONG
2019-05-30 15:23:07: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:08: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:08: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=93&status_id=270&speed_bpms=3971.43&total_bytes=358768640&done_bytes=332288000&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:23:09: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:10: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:10: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:11: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:12: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:13: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:13: Sending full image done
2019-05-30 15:23:13: Service finished. Transferred 318.525 MB
2019-05-30 15:23:13: Encryption overhead: 52.3184 KB
2019-05-30 15:23:13: Transferred uncompressed: 342.832 MB (ratio: 1.07648)
2019-05-30 15:23:13: Average sent paket size: 57.1387 MB
2019-05-30 15:23:13: SERVICE_COMMANDS finished
2019-05-30 15:23:14: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:15: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:16: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:16: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:16: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#MBR driveletter=ESP
2019-05-30 15:23:16: rc=0 hasError=true state=0
2019-05-30 15:23:16: SERVICE_COMMANDS finished
2019-05-30 15:23:16: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:16: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=0&status_id=271&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:23:16: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:16: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#FULL IMAGE letter=ESP&token=Sn6OgOlDXW0jlIRhVCV5&bitmap=1&status_id=271&running_jobs=1
2019-05-30 15:23:16: ERROR: Not found
2019-05-30 15:23:16: rc=0 hasError=true state=0
2019-05-30 15:23:16: SERVICE_COMMANDS finished
2019-05-30 15:23:17: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:17: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:17: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#MBR driveletter=C
2019-05-30 15:23:17: rc=0 hasError=true state=0
2019-05-30 15:23:17: SERVICE_COMMANDS finished
2019-05-30 15:23:17: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:17: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2PING RUNNING pc_done=0&status_id=269&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=Sn6OgOlDXW0jlIRhVCV5
2019-05-30 15:23:17: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:17: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#FULL IMAGE letter=C:&token=Sn6OgOlDXW0jlIRhVCV5&bitmap=1&status_id=269&running_jobs=1
2019-05-30 15:23:17: Device W:\ isn’t NTFS formatted
2019-05-30 15:23:17: Script “C:\Program Files\UrBackup\preimagebackup.bat” does not exist
2019-05-30 15:23:17: Creating shadowcopy of “C:”…
2019-05-30 15:23:17: ERROR: backupcom->InitializeForBackup() failed. VSS error code VSS_E_UNEXPECTED
2019-05-30 15:23:17: done.
2019-05-30 15:23:17: Disabling CBT on volume “C:”
2019-05-30 15:23:17: ERROR: Creating shadowcopy of “C:” failed.
2019-05-30 15:23:17: ERROR: Creating shadow copy failed. See client log file for details.
2019-05-30 15:23:17: Sending full image done
2019-05-30 15:23:17: SERVICE_COMMANDS finished
2019-05-30 15:23:18: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:18: rc=0 hasError=true state=0
2019-05-30 15:23:18: SERVICE_COMMANDS finished
2019-05-30 15:23:19: ClientService cmd: STATUS#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:19: Started connection to SERVICE_COMMANDS
2019-05-30 15:23:19: ClientService cmd: STATUS DETAIL#pw=xRc279I9TAvhdhJYM1io3EAcdlbiUW
2019-05-30 15:23:19: ClientService cmd: #IMgDhDnh9ZK4Aureg15hA#2LOGDATA 1559244190 0-1559244099-Starting unscheduled full image backup of volume “C:”…
0-1559244189-Basing image backup on last incremental or full image backup
1-1559244189-Error retrieving last image backup. Doing full image backup instead.
2-1559244190-Request of image backup failed. Reason: Creating shadow copy failed. See client log file for details.
0-1559244190-Transferred 850 bytes - Average speed: 107.936 KBit/s
0-1559244190-Time taken for backing up client APA-APAsrv01: 1m 31s
2-1559244190-Backup failed

2019-05-30 15:23:19: rc=0 hasError=true state=0
2019-05-30 15:23:19: SERVICE_COMMANDS finished

uroni · May 30, 2019, 7:40pm

I wouldn’t say its not enough disk space. CoInitializeEx is a very basic function for initializing inter process communication and if that fails it more or less indicates that Windows is completely broken.