MOON
Server: Apache/2.2.23 (Unix) mod_ssl/2.2.23 OpenSSL/0.9.8e-fips-rhel5 mod_auth_passthrough/2.1 mod_bwlimited/1.4 PHP/5.4.10
System: Linux vps.presagepowered.net 2.6.18-398.el5 #1 SMP Tue Sep 16 20:51:48 EDT 2014 i686
User: mckernan (512)
PHP: 5.4.10
Disabled: NONE
$ pwd: /var/lib/Acronis/Scheduler/logs/
Upload Files
File: //var/lib/Acronis/Scheduler/logs/2019.08.06-22.27.01.236-D8F5D63C-34B8-45CE-A9CB-2297CAFCD812.log
2019-08-06T18:27:01-0400 unknown(0)(0): task 1, mode cron

2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:crontab_intf:pw_dir = /root
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:crontab_user:Start. id=1
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Found user with uid=1.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Postpone:EnumPostponeRunsDir:Started
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Postpone:LoadPostponeRuns:Load times
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Postpone:LoadPostponeRuns:Delete from disk
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Postpone:LoadPostponeRuns:Delete in memory
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:ExecuteFromWrapper:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): User:ExecuteFromWrapper:Start mode=cron, sessid=(null)
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): User:ExecuteFromWrapper:Started uid=1
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:crontab_task:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Postpone:PostponeRunWaitThreadFunc:Started
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:crontab_intf:Already inited.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:GetWaitId:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): User:ExecuteFromWrapper:taskFailedRetriesLeft=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Start. mode=0, cron, sess ---
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:Load:OK. State=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:CheckModeAndFlags:Start. mode=cron
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:CheckModeAndFlags:ret=1
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:CheckModeAndFlags OK
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:CanRunNow:Start. minuteAgo 8:6 18:26 Wday=2. now 8:6 18:27 Wday=2, to_run 8:6 18:27 Wday=2
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:CanRunNow:Can run task on: 8:6 18:27 Wday=2
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:UpdateInternalData:Start. wpid=16858, tpid=0. Writing to /var/lib/Acronis/Scheduler/tasks/user1/1/1.idata.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Postpone:PostponeRunWaitThreadFunc:Wait changes 3
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:crontab_intf:Already inited.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:WaitChangesEx:Start wait on /var/lib/Acronis/Scheduler/waitdata/waitcmn/3_0_16858.wait.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Try to run task
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:TryRun:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=0
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=1
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:crontab_task:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:Load:OK. State=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): User:ReadNextTask:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=1
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=2
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(2): Task:crontab_task:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(2): Task:Load:OK. State=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(2): User:ReadNextTask:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=2
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=3
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(3): Task:crontab_task:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(3): Task:Load:OK. State=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(3): User:ReadNextTask:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=3
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=0
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): User:ReadNextTask:No more tasks.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=0
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:GetTaskPendingFlags:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:GetTaskPendingFlags:OK. pending=0
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): TryRun: pending == 0
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:TryRun:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): PShed:CancelSchedule:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): PShed:CronFile:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:WaitChangesEx:read error /var/lib/Acronis/Scheduler/waitdata/waitcmn/3_0_16858.wait.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:isRoot:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): PShed:Read:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): PShed:WrapperCommand:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): PShed:RemoveEntry:Start.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): PShed:ObtainParameter:Unable to obtain s parameter
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): PShed:WrapperCommand:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): PShed:ObtainParameter:Unable to obtain s parameter
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): PShed:WrapperCommand:OK.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:TryRun OK
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:CheckSetExecDir:Dir empty.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:CheckRunParameters:ret "/usr/lib/Acronis/BackupAndRecovery/Common/act" /script:8B7631D3-B098-4676-BD8C-7ECECBF24578 /MMS /run_mode 10.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:CheckRunParameters OK
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:RegisterServers:Start. req=0x0
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Do exec for <<"/usr/lib/Acronis/BackupAndRecovery/Common/act" /script:8B7631D3-B098-4676-BD8C-7ECECBF24578 /MMS /run_mode 10>>.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=2
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Exec OK
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=4
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:UpdateInternalData:Start. wpid=16858, tpid=16862. Writing to /var/lib/Acronis/Scheduler/tasks/user1/1/1.idata.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(0): Intf:WaitChangesEx:read error /var/lib/Acronis/Scheduler/waitdata/waitcmn/3_0_16858.wait.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:NotifySession:Start, code=0, save=1.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:NotifySession:Start save, code=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=2
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:NotifySession:End, code=0.
2019-08-06T18:27:01-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Start notify waiters
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Finished pid=16862 status=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:ReadInternalData:OK. wpid=16858, tpid=16862. /var/lib/Acronis/Scheduler/tasks/user1/1/1.idata.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:Load:Correcting task state wrappid=16858 taskpid=16862.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:Load:OK. State=2.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:Before TaskCompleted pid=16862 status=0 exitCode=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=10
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Intf:WaitChangesEx:read error /var/lib/Acronis/Scheduler/waitdata/waitcmn/3_0_16858.wait.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:TaskCompleted:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:PutServers:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:PutMutexes:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:UpdateInternalData:Start. wpid=0, tpid=0. Writing to /var/lib/Acronis/Scheduler/tasks/user1/1/1.idata.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:ExecuteFromWrapper:OK. exitCode=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): User:ExecuteFromWrapper:tsk.ExecuteFromWrapper ret=0, exitCode=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:RetryFailedTask:Start. exitCode=0.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:UpdateTimes:OK. flag=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:Save:OK.Flags=0x8819(TOKEN HIDDEN TIME EXECUTED ENABLED)
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:RetryFailedTask:Code OK. 0, TaskFailedRetriesLeft=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): PShed:CancelSchedule:Start.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): PShed:CronFile:Start.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Intf:isRoot:Start.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): PShed:Read:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): PShed:WrapperCommand:Start.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): PShed:RemoveEntry:Start.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): PShed:ObtainParameter:Unable to obtain s parameter
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): PShed:WrapperCommand:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): PShed:ObtainParameter:Unable to obtain s parameter
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): PShed:WrapperCommand:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): User:ExecuteFromWrapper:tsk.RetryFailedTask ret=0, exitCode=0, retryHappened=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): User:TaskFinishedNotify:Start
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=1
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:crontab_task:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:Load:OK. State=0.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): User:ReadNextTask:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): Task:crontab_task:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=1
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=2
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(2): Task:crontab_task:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(2): Task:Load:OK. State=0.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(2): User:ReadNextTask:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(2): Task:crontab_task:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=2
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=3
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(3): Task:crontab_task:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(3): Task:Load:OK. State=0.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(3): User:ReadNextTask:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(3): Task:crontab_task:OK.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:Start. prev=3
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirGetTasksSet:Found 43629995779686403 tasks
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:DirNextTaskId:next=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): User:ReadNextTask:No more tasks.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(1): User:ExecuteFromWrapper:Exit, ret=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Intf:ExecuteFromWrapper:ret=0
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Postpone:~PostponeRunWaitShutdowner:Stop wait changes 3
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Intf:crontab_intf:Already inited.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Intf:StopWaitChanges:Start.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Intf:WaitChangesEx:cancelled /var/lib/Acronis/Scheduler/waitdata/waitcmn/3_0_16858.wait.
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Postpone:PostponeRunWaitThreadFunc:Wait error 1223
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Postpone:PostponeRunWaitThreadFunc:Completed
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Postpone:~PostponeRunWaitShutdowner:Wait run wait thread for completion
2019-08-06T18:31:13-0400 schedwrapper-bin(16858)(0): Postpone:~PostponeRunWaitShutdowner:Completed api = 0x85a8440
@ Telegram