Scheduled Backups never run on W7 machine
I'm trying for a while but have a scheduled backup on one machine and never get it running, even with uninstalling and re-installing the Acronis Backup Agent, using other accounts for the services and so on. Does anyone maybe have some similar experiences and could find a solution?
The Machine to be backed up is a Windows 7 machine with always 2 users logged in, one standard user and one administrator (logged in but switched user). When I start a backup form Acronis Backup Manager, there is no problem to run the job (once). I already tried to drop and recreate the backup-plan, reinstall the agent and use other target locations. The same backup plan runs fine on two other machines.
The problem seems to be at the scheduler, but I couldn't find what's wrong.
Here is one of the last logs at a scheduled backup time, thanks in advance for your ideas:
22/11/2018 15:29:35: OnServiceMainWake: begin
22/11/2018 15:29:35: Trying task 2-13 as TIME_NORMAL
22/11/2018 15:29:35: Already waiting
22/11/2018 15:29:35: Exclusive
22/11/2018 15:29:35: OnServiceMainWake: next time = 22.11.2018 15:35:03
22/11/2018 15:35:05: OnServiceMainWake: begin
22/11/2018 15:35:05: Trying task 3-3 as TIME_NORMAL
22/11/2018 15:35:05: Already waiting
22/11/2018 15:35:05: Exclusive
22/11/2018 15:35:05: OnServiceMainWake: next time = 22.11.2018 15:43:23
22/11/2018 15:43:24: OnServiceMainWake: begin
22/11/2018 15:43:24: Trying task 2-16 as TIME_NORMAL
22/11/2018 15:43:24: Stored token 00000000 replaced with 00000000
22/11/2018 15:43:24: OnServiceMainWake: next time = 22.11.2018 16:00:00
22/11/2018 15:43:24: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-16 Result=3(RUN_WAITED) Extra=8(TIME_NORMAL)
22/11/2018 15:43:24: Running task 3-3 pending because of: IDLE LOGON
22/11/2018 15:43:24: Running task 3-2 pending because of: IDLE LOGON
22/11/2018 15:43:24: Running task 2-13 pending because of: IDLE
22/11/2018 15:43:24: Running task 2-12 pending because of: IDLE
22/11/2018 15:43:24: Running task 2-16 pending because of: IDLE
22/11/2018 15:43:24: Runner wait for 4294967295 ms
22/11/2018 15:43:24: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 15:43:24: WaitId=219 Product=4 (ABR)
22/11/2018 15:43:24: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=3-3 Result=6(RUN_PENDING) Extra=129(IDLE LOGON)
22/11/2018 15:43:24: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 15:43:24: WaitId=219 Product=4 (ABR)
22/11/2018 15:43:24: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=3-2 Result=6(RUN_PENDING) Extra=129(IDLE LOGON)
22/11/2018 15:43:24: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 15:43:24: WaitId=219 Product=4 (ABR)
22/11/2018 15:43:24: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-13 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 15:43:24: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 15:43:24: WaitId=219 Product=4 (ABR)
22/11/2018 15:43:24: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-12 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 15:43:24: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 15:43:24: WaitId=219 Product=4 (ABR)
22/11/2018 15:43:24: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-16 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 15:43:24: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 15:43:24: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: OnServiceMainWake: begin
22/11/2018 16:00:01: Trying task 2-2 as TIME_NORMAL
22/11/2018 16:00:01: Stored token 00000000 replaced with 00000000
22/11/2018 16:00:01: OnServiceMainWake: next time = 22.11.2018 19:00:00
22/11/2018 16:00:01: Running task 3-3 pending because of: IDLE LOGON
22/11/2018 16:00:01: Running task 3-2 pending because of: IDLE LOGON
22/11/2018 16:00:01: Running task 2-13 pending because of: IDLE
22/11/2018 16:00:01: Running task 2-12 pending because of: IDLE
22/11/2018 16:00:01: Running task 2-16 pending because of: IDLE
22/11/2018 16:00:01: Running task 2-2
22/11/2018 16:00:01: DuplicateTokenEx: < token=000002EC > error=0 token=0000018C
22/11/2018 16:00:01: NewSecurityDescriptor: > error=0
22/11/2018 16:00:01: SetTokenInformation: > error=0
22/11/2018 16:00:01: Scheduler user for account found
22/11/2018 16:00:01: Session not found
22/11/2018 16:00:01: GetTokenUserName: > error=0 domain="NT AUTHORITY" user="SYSTEM"
22/11/2018 16:00:01: DsGetDcName: < domain="NT AUTHORITY" > error=1212
22/11/2018 16:00:01: GetUserProfileDirectory > error=0.
22/11/2018 16:00:01: LoadUserProfile: < user="SYSTEM" path="(null)" > error=0
22/11/2018 16:00:01: CreateEnvironmentBlock: > error=0
22/11/2018 16:00:01: CreateProcessAsUser: < token=0000018C > error=0
22/11/2018 16:00:01: Stored token 00000000 replaced with 00000000
22/11/2018 16:00:01: Runner wait for 4294967295 ms
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=3-3 Result=6(RUN_PENDING) Extra=129(IDLE LOGON)
22/11/2018 16:00:01: Task 2-2 completed with exit code=0
22/11/2018 16:00:01: Stored token 00000000 replaced with 00000000
22/11/2018 16:00:01: Running task 3-3 pending because of: IDLE LOGON
22/11/2018 16:00:01: Running task 3-2 pending because of: IDLE LOGON
22/11/2018 16:00:01: Running task 2-13 pending because of: IDLE
22/11/2018 16:00:01: Running task 2-12 pending because of: IDLE
22/11/2018 16:00:01: Running task 2-16 pending because of: IDLE
22/11/2018 16:00:01: Runner wait for 4294967295 ms
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=3-2 Result=6(RUN_PENDING) Extra=129(IDLE LOGON)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-13 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-12 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-16 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=3-3 Result=6(RUN_PENDING) Extra=129(IDLE LOGON)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=3-2 Result=6(RUN_PENDING) Extra=129(IDLE LOGON)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-13 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-12 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)
22/11/2018 16:00:01: API Reply: OP=WAIT_CHANGES_EX Ver=4 Status=0 Task=2-16 Result=6(RUN_PENDING) Extra=128(IDLE)
22/11/2018 16:00:01: API Entry: OP=WAIT_CHANGES_EX Ver=4 Misc=0 Id=0 IntUser=-1 LogonSid= User="NT AUTHORITY\SYSTEM" (S-1-5-18)
22/11/2018 16:00:01: WaitId=219 Product=4 (ABR)

- Log in to post comments