"No recent backup" status of successfully full image backup

Hi there!

Server side: Ubuntu 18.04.3, Urbackup server version 2.4.9.
Client side: Windows 7 Pro SP1 x64, Urbackup client version 2.4.8.

Client configured only for full image backup. Sheduled or manually - it doen’t matter. Backup is successful. But “Image backup status” is still “No recent backup”.

Client side log:

2019-10-14 10:31:05: ClientService cmd: #ItzdVas2yLTDzL748y9KE#MBR driveletter=SYSVOL&disk_path=SYSVOL&image_full=1&running_jobs=1&token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:05: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=0&status_id=2&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:05: rc=0 hasError=true state=0
2019-10-14 10:31:05: ClientService cmd: #ItzdVas2yLTDzL748y9KE#FULL IMAGE letter=SYSVOL&token=FdYKRkxBleB3b9IOeGw7&checksum=1&bitmap=1&status_id=2&running_jobs=1&zero_skipped=1
2019-10-14 10:31:05: Filesystem type is ntfs (\?\Volume{58a2f843-db9b-11e9-aa96-806e6f6e6963})
2019-10-14 10:31:05: TotalNumberOfClusters=25599 numberOfClusters=25599 n_clusters=3200 StartingLcn=0 BitmapSize=25599 r_bytes=3216
2019-10-14 10:31:05: FSINFO: blocksize=4096 size=104857088 has_error=false used_space=25337856
2019-10-14 10:31:05: Sending full image done
2019-10-14 10:31:05: Removing running process (1) id 5 server_id 2 token FdYKRkxBleB3b9IOeGw7 action 3
2019-10-14 10:31:06: ClientService cmd: #ItzdVas2yLTDzL748y9KE#MBR driveletter=ESP&disk_path=ESP&image_full=1&running_jobs=1&token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:06: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=0&status_id=3&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:06: rc=0 hasError=true state=0
2019-10-14 10:31:06: ClientService cmd: #ItzdVas2yLTDzL748y9KE#FULL IMAGE letter=ESP&token=FdYKRkxBleB3b9IOeGw7&checksum=1&bitmap=1&status_id=3&running_jobs=1&zero_skipped=1
2019-10-14 10:31:06: ERROR: Not found
2019-10-14 10:31:06: rc=0 hasError=true state=0
2019-10-14 10:31:06: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:31:07: ClientService cmd: #ItzdVas2yLTDzL748y9KE#MBR driveletter=C&disk_path=C:&image_full=1&running_jobs=1&token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:07: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=0&status_id=1&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:07: rc=0 hasError=true state=0
2019-10-14 10:31:07: ClientService cmd: #ItzdVas2yLTDzL748y9KE#FULL IMAGE letter=C:&token=FdYKRkxBleB3b9IOeGw7&checksum=1&bitmap=1&status_id=1&running_jobs=1&zero_skipped=1
2019-10-14 10:31:07: Script “C:\Program Files\UrBackup\preimagebackup.bat” does not exist
2019-10-14 10:31:07: Creating shadowcopy of “C:”…
2019-10-14 10:31:08: Number of Writers: 10
2019-10-14 10:31:08: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer ASR Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer MSSearch Service Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer Shadow Copy Optimization Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Preparing change block tracking reset for volume c: failed: Неверная функция. (code: 1)
2019-10-14 10:31:08: ClientService cmd: PONG
2019-10-14 10:31:08: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:31:08: Number of Writers: 10
2019-10-14 10:31:08: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer ASR Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer MSSearch Service Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer Shadow Copy Optimization Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:08: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:10: Number of Writers: 10
2019-10-14 10:31:10: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:10: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:10: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:31:10: Writer System Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Writer WMI Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Writer ASR Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Writer MSSearch Service Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Writer COM+ REGDB Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Writer Shadow Copy Optimization Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Writer Registry Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2019-10-14 10:31:10: Shadowcopy path: \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8
2019-10-14 10:31:10: done.
2019-10-14 10:31:10: Disabling CBT on volume “C:”
2019-10-14 10:31:10: Filesystem type is ntfs (\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8)
2019-10-14 10:31:10: TotalNumberOfClusters=8362495 numberOfClusters=8362495 n_clusters=1045312 StartingLcn=0 BitmapSize=8362495 r_bytes=1045328
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\HIBERFIL.SYS from backup…
2019-10-14 10:31:10: Error opening file handle to \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\HIBERFIL.SYS
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\pagefile.sys from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\swapfile.sys from backup…
2019-10-14 10:31:10: Error opening file handle to \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\swapfile.sys
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{1f4d2de4-ec19-11e9-a295-0800271b392a}{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{1f4d2e01-ec19-11e9-a295-0800271b392a}{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{632878e1-ee4d-11e9-9d69-0800271b392a}{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{63287918-ee4d-11e9-9d69-0800271b392a}{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{e06da731-ec1d-11e9-b340-0800271b392a}{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: Trying to exclude contents of file \?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8\System Volume Information{f75bcbb6-ec14-11e9-b7c2-0800271b392a}{3808876b-c176-4e48-b7ae-04046e6cc752} from backup…
2019-10-14 10:31:10: FSINFO: blocksize=4096 size=34252783104 has_error=false used_space=20052819968
2019-10-14 10:31:15: rc=0 hasError=true state=0
2019-10-14 10:31:16: rc=0 hasError=true state=0
2019-10-14 10:31:17: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=1&status_id=1&speed_bpms=0&total_bytes=20052819968&done_bytes=259854336&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:18: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:31:27: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=3&status_id=1&speed_bpms=0&total_bytes=20052819968&done_bytes=676507648&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:28: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:31:37: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=5&status_id=1&speed_bpms=41771.7&total_bytes=20052819968&done_bytes=1076207616&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:38: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:31:47: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=7&status_id=1&speed_bpms=39565&total_bytes=20052819968&done_bytes=1492963328&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:48: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:31:57: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=10&status_id=1&speed_bpms=41938.9&total_bytes=20052819968&done_bytes=1910161408&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:31:58: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:32:07: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=12&status_id=1&speed_bpms=41751.9&total_bytes=20052819968&done_bytes=2314469376&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:32:08: ClientService cmd: PONG
2019-10-14 10:32:08: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:32:17: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=14&status_id=1&speed_bpms=40434.9&total_bytes=20052819968&done_bytes=2751447040&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:32:18: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:32:27: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=16&status_id=1&speed_bpms=43894.9&total_bytes=20052819968&done_bytes=3193225216&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:32:28: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:32:37: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=18&status_id=1&speed_bpms=44143.9&total_bytes=20052819968&done_bytes=3620044800&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:32:38: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:32:47: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=20&status_id=1&speed_bpms=42512.2&total_bytes=20052819968&done_bytes=4075229184&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:32:48: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:32:57: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=22&status_id=1&speed_bpms=45693.7&total_bytes=20052819968&done_bytes=4455350272&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:32:58: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:33:07: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=24&status_id=1&speed_bpms=36989.7&total_bytes=20052819968&done_bytes=4883566592&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:33:08: ClientService cmd: PONG
2019-10-14 10:33:08: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:33:17: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=26&status_id=1&speed_bpms=43914.6&total_bytes=20052819968&done_bytes=5288923136&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:33:18: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:33:27: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=28&status_id=1&speed_bpms=40605.3&total_bytes=20052819968&done_bytes=5655339008&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:33:28: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:33:37: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=30&status_id=1&speed_bpms=39078.5&total_bytes=20052819968&done_bytes=5920890880&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:33:38: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:33:47: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=30&status_id=1&speed_bpms=12187.1&total_bytes=20052819968&done_bytes=5957873664&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:33:57: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=32&status_id=1&speed_bpms=40829.3&total_bytes=20052819968&done_bytes=6374424576&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:33:58: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:34:07: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=34&status_id=1&speed_bpms=44992.5&total_bytes=20052819968&done_bytes=6829477888&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:34:08: ClientService cmd: PONG
2019-10-14 10:34:08: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:34:17: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=36&status_id=1&speed_bpms=42207.5&total_bytes=20052819968&done_bytes=7253626880&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:34:18: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:34:27: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=38&status_id=1&speed_bpms=43993.1&total_bytes=20052819968&done_bytes=7648374784&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:34:28: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:34:38: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=38&status_id=1&speed_bpms=43993.1&total_bytes=20052819968&done_bytes=7654141952&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:34:48: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=40&status_id=1&speed_bpms=36873.4&total_bytes=20052819968&done_bytes=8024166400&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:34:49: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:34:58: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=42&status_id=1&speed_bpms=41709.5&total_bytes=20052819968&done_bytes=8446238720&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:34:59: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:35:08: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=44&status_id=1&speed_bpms=41802.4&total_bytes=20052819968&done_bytes=8818917376&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:35:08: ClientService cmd: PONG
2019-10-14 10:35:09: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:35:18: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=46&status_id=1&speed_bpms=33606.8&total_bytes=20052819968&done_bytes=9198981120&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:35:19: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:35:28: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=47&status_id=1&speed_bpms=33606.8&total_bytes=20052819968&done_bytes=9415540736&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:35:29: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:35:38: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=47&status_id=1&speed_bpms=19685.8&total_bytes=20052819968&done_bytes=9467899904&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:35:48: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=49&status_id=1&speed_bpms=9792.76&total_bytes=20052819968&done_bytes=9853026304&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:35:49: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:35:58: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=51&status_id=1&speed_bpms=39871.4&total_bytes=20052819968&done_bytes=10297737216&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:35:59: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:36:08: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=53&status_id=1&speed_bpms=44504.3&total_bytes=20052819968&done_bytes=10669797376&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:36:08: ClientService cmd: PONG
2019-10-14 10:36:09: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:36:18: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=55&eta_ms=278039&status_id=1&speed_bpms=38976.9&total_bytes=20052819968&done_bytes=11115245568&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:36:19: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:36:28: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=56&eta_ms=268038&status_id=1&speed_bpms=44114.4&total_bytes=20052819968&done_bytes=11246747648&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:36:35: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:36:44: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=57&eta_ms=252574&status_id=1&speed_bpms=18224.5&total_bytes=20052819968&done_bytes=11518132224&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:36:45: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:36:54: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=59&eta_ms=242574&status_id=1&speed_bpms=32032.7&total_bytes=20052819968&done_bytes=11835432960&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:36:55: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:37:04: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=61&eta_ms=232573&status_id=1&speed_bpms=47151.7&total_bytes=20052819968&done_bytes=12303982592&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:37:05: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:37:08: ClientService cmd: PONG
2019-10-14 10:37:14: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=64&eta_ms=238747&status_id=1&speed_bpms=43344.2&total_bytes=20052819968&done_bytes=12735254528&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:37:15: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:37:24: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=64&eta_ms=228746&status_id=1&speed_bpms=19337.5&total_bytes=20052819968&done_bytes=12863909888&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:37:39: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=66&eta_ms=213143&status_id=1&speed_bpms=5439.75&total_bytes=20052819968&done_bytes=13147230208&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:37:41: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:37:49: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=67&eta_ms=203143&status_id=1&speed_bpms=35777.1&total_bytes=20052819968&done_bytes=13532811264&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:37:51: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:37:59: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=70&eta_ms=193141&status_id=1&speed_bpms=40933&total_bytes=20052819968&done_bytes=13984497664&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:38:01: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:38:08: ClientService cmd: PONG
2019-10-14 10:38:09: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=71&eta_ms=183140&status_id=1&speed_bpms=41830.7&total_bytes=20052819968&done_bytes=14331138048&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:38:11: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:38:19: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=72&eta_ms=209919&status_id=1&speed_bpms=19555.3&total_bytes=20052819968&done_bytes=14369394688&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:38:23: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:38:31: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=74&eta_ms=197899&status_id=1&speed_bpms=15171.6&total_bytes=20052819968&done_bytes=14740029440&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:38:33: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:38:41: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=76&eta_ms=187896&status_id=1&speed_bpms=38272.1&total_bytes=20052819968&done_bytes=15183220736&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:38:43: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:38:51: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=78&eta_ms=177895&status_id=1&speed_bpms=45189.1&total_bytes=20052819968&done_bytes=15562936320&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:38:53: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:39:01: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=80&eta_ms=167892&status_id=1&speed_bpms=39642&total_bytes=20052819968&done_bytes=15983878144&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:39:03: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:39:08: ClientService cmd: PONG
2019-10-14 10:39:11: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=81&eta_ms=157891&status_id=1&speed_bpms=42125.6&total_bytes=20052819968&done_bytes=16312668160&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:39:23: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:39:32: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=83&eta_ms=121136&status_id=1&speed_bpms=8230.21&total_bytes=20052819968&done_bytes=16599736320&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:39:33: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:39:42: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=85&eta_ms=111134&status_id=1&speed_bpms=37464.2&total_bytes=20052819968&done_bytes=17044234240&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:39:43: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:39:46: Looking for old Sessions… 0 sessions
2019-10-14 10:39:52: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=87&eta_ms=101133&status_id=1&speed_bpms=44733.7&total_bytes=20052819968&done_bytes=17443856384&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:39:53: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:40:02: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=89&eta_ms=91132&status_id=1&speed_bpms=39533.9&total_bytes=20052819968&done_bytes=17755791360&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:40:03: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:40:11: ClientService cmd: PONG
2019-10-14 10:40:12: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=89&eta_ms=81130&status_id=1&speed_bpms=20455.7&total_bytes=20052819968&done_bytes=17766780928&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:40:22: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=90&eta_ms=71130&status_id=1&speed_bpms=7945.69&total_bytes=20052819968&done_bytes=18059522048&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:40:23: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:40:32: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=92&eta_ms=61000&status_id=1&speed_bpms=34579&total_bytes=20052819968&done_bytes=18481491968&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:40:33: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:40:42: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=93&eta_ms=61000&status_id=1&speed_bpms=42302.5&total_bytes=20052819968&done_bytes=18707288064&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:40:43: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:40:52: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=94&eta_ms=61000&status_id=1&speed_bpms=11234&total_bytes=20052819968&done_bytes=18800377856&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:40:53: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:41:02: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=96&eta_ms=61000&status_id=1&speed_bpms=25055.7&total_bytes=20052819968&done_bytes=19188781056&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:41:03: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:41:11: ClientService cmd: PONG
2019-10-14 10:41:12: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=98&eta_ms=61000&status_id=1&speed_bpms=43194&total_bytes=20052819968&done_bytes=19644542976&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:41:13: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:41:22: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=98&eta_ms=61000&status_id=1&speed_bpms=43194&total_bytes=20052819968&done_bytes=19743600640&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:41:37: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2PING RUNNING pc_done=99&eta_ms=61000&status_id=1&speed_bpms=14853.1&total_bytes=20052819968&done_bytes=19944181760&paused_fb=1#token=FdYKRkxBleB3b9IOeGw7
2019-10-14 10:41:38: ClientService cmd: STATUS#pw=wfMoavdROWoxoi8utyVebgv0ZOyada
2019-10-14 10:41:39: Sending full image done
2019-10-14 10:41:39: Deleting shadowcopy for path "\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy8" -2
2019-10-14 10:41:39: rc=0 hasError=true state=4
2019-10-14 10:41:40: Number of Writers: 10
2019-10-14 10:41:40: Writer Task Scheduler Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer VSS Metadata Store Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer Performance Counters Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer ASR Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer MSSearch Service Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer Shadow Copy Optimization Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2019-10-14 10:41:40: Deleting Shadowcopy for dir "C:"
2019-10-14 10:41:40: Removing running process (1) id 6 server_id 1 token FdYKRkxBleB3b9IOeGw7 action 3
2019-10-14 10:41:41: ClientService cmd: #ItzdVas2yLTDzL748y9KE#2LOGDATA 1571038899 0-1571038263-Starting unscheduled full image backup of volume “C:”…
0-1571038899-Transferred 18.7148 GB - Average speed: 253.728 MBit/s
0-1571038899-Time taken for backing up client win7-backup: 10m 35s
0-1571038899-Backup succeeded
2019-10-14 10:41:41: rc=0 hasError=true state=0
2019-10-14 10:41:47: rc=0 hasError=true state=0

Server side log:

2019-10-14 10:31:03: msg=START IMAGE FULL
2019-10-14 10:31:03: Starting unscheduled full image backup of volume “C:”…
2019-10-14 10:31:03: Backing up SYSVOL…
2019-10-14 10:31:03: Starting unscheduled full image backup of volume “SYSVOL”…
2019-10-14 10:31:04: Transferred 24.2169 MB - Average speed: 229.285 MBit/s
2019-10-14 10:31:04: Script does not exist urbackup/post_full_imagebackup
2019-10-14 10:31:04: Updating statistics…
2019-10-14 10:31:04: Updating image stats…
2019-10-14 10:31:04: Updating file statistics…
2019-10-14 10:31:04: Done updating statistics.
2019-10-14 10:31:04: Backing up SYSVOL done.
2019-10-14 10:31:04: Backing up EFI System Partition…
2019-10-14 10:31:04: Starting unscheduled full image backup of volume “ESP”…
2019-10-14 10:31:04: Request of EFI System Partition failed. Reason: Not found
2019-10-14 10:31:04: Transferred 154 bytes - Average speed: 82.128 KBit/s
2019-10-14 10:31:04: Script does not exist urbackup/post_full_imagebackup
2019-10-14 10:31:04: Updating statistics…
2019-10-14 10:31:04: Updating image stats…
2019-10-14 10:31:04: Updating file statistics…
2019-10-14 10:31:04: Done updating statistics.
2019-10-14 10:31:05: msg=WAKEUP
2019-10-14 10:31:05: Backing up EFI System Partition done.
2019-10-14 10:31:05: msg=WAKEUP
2019-10-14 10:32:47: HTTP: No available slots… starting new Worker
2019-10-14 10:36:32: HTTP: No available slots… starting new Worker
2019-10-14 10:38:34: Looking for old Sessions… 1 sessions
2019-10-14 10:41:37: Sending file “/usr/share/urbackup/www/images/indicator.gif”
2019-10-14 10:41:38: Sending file: /usr/share/urbackup/www/images/indicator.gif
2019-10-14 10:41:39: Sending file: /usr/share/urbackup/www/images/indicator.gif done
2019-10-14 10:41:39: Transferred 18.7148 GB - Average speed: 253.728 MBit/s
2019-10-14 10:41:39: Script does not exist urbackup/post_full_imagebackup
2019-10-14 10:41:39: Time taken for backing up client win7-backup: 10m 35s
2019-10-14 10:41:39: Backup succeeded
2019-10-14 10:41:39: Updating statistics…
2019-10-14 10:41:39: Updating image stats…
2019-10-14 10:41:39: Updating file statistics…
2019-10-14 10:41:39: Done updating statistics.

1 Like

My guess is creating a custom alert script and changing line 11 from

if full_image_interval>0 and full_image_interval<image_interval

to

if full_image_interval>0 and (full_image_interval<image_interval or image_interval<0)

fixes it. Correct?

Yep. That fix my problem! Thanks!