Exchange Backups

[orddie]

Hey all,

Does anyone use Veeam to backup Exchange 2016? Currently, the only way i can get backups to work is via VMware which exchange is not aware of the backup (so the logs keep growing).

When i try and do a windows backup on the exchange database and log file drives, i get access denied. My Support case is 03981779

Code: Select all

[01.02.2020 16:47:19] <01> Info     -------------------------------------------------------------------------------------
[01.02.2020 16:47:19] <01> Info     STARTEPAGENTPOLICYJOB
[01.02.2020 16:47:19] <01> Info     owner=[vbsvc]
[01.02.2020 16:47:19] <01> Info     Normal
[01.02.2020 16:47:19] <01> Info     08bf6727-fdec-4ad3-ace1-dceb147dca27
[01.02.2020 16:47:19] <01> Info     3634831e-1273-4260-9ad6-f9fd25f5ed04
[01.02.2020 16:47:19] <01> Info     -------------------------------------------------------------------------------------
[01.02.2020 16:47:19] <01> Info     Starting job mode: 'Normal'
[01.02.2020 16:47:19] <01> Info     [Session] Id '3634831e-1273-4260-9ad6-f9fd25f5ed04', State 'Working'
[01.02.2020 16:47:19] <01> Info     Custom command execution (pre script) disabled
[01.02.2020 16:47:20] <01> Info     Checking compatibility between client and server (Client='9.5.4.2866', Server='9.5.4.2866', Components=2)
[01.02.2020 16:47:20] <01> Info     Client session [9eb017c4-8411-47c4-a890-a94f3ceb44cf] was opened with info
[01.02.2020 16:47:20] <01> Error    Access denied. (System.Security.SecurityException)
[01.02.2020 16:47:20] <01> Error    Server stack trace: 
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.ServiceLib.CBackupUacAccessChecker.DoCheck(IPrincipal principal, Permissions permission)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Service.CJobMgmtService.PopPolicyForProcessingSafe(Guid policyId)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Messaging.StackBuilderSink._PrivateProcessMessage(IntPtr md, Object[] args, Object server, Object[]& outArgs)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Messaging.StackBuilderSink.SyncProcessMessage(IMessage msg)
[01.02.2020 16:47:20] <01> Error    Exception rethrown at [0]: 
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Proxies.RealProxy.HandleReturnMessage(IMessage reqMsg, IMessage retMsg)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Proxies.RealProxy.PrivateInvoke(MessageData& msgData, Int32 type)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Interaction.Management.IJobManagementService.PopPolicyForProcessingSafe(Guid policyId)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Interaction.Management.Client.CJobManagementService.<>c__DisplayClass116.<PopPolicyForProcessingSafe>b__115()
[01.02.2020 16:47:20] <01> Error       at Veeam.Common.Remoting.CRetryableMethod.DoInvoke[Ret](ActionDelegate`1 dlg)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CEpAgentPolicyTaskScheduler.AcceptPolicyTaskForSession(CBackupJob job, CEpPolicyJobSessionContextEx sessionContext)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CEpAgentBackupJobPerformer.Perform()
[01.02.2020 16:47:20] <01> Error    Access denied. (System.Security.SecurityException)
[01.02.2020 16:47:20] <01> Error    Server stack trace: 
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.ServiceLib.CBackupUacAccessChecker.DoCheck(IPrincipal principal, Permissions permission)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Service.CJobMgmtService.PopPolicyForProcessingSafe(Guid policyId)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Messaging.StackBuilderSink._PrivateProcessMessage(IntPtr md, Object[] args, Object server, Object[]& outArgs)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Messaging.StackBuilderSink.SyncProcessMessage(IMessage msg)
[01.02.2020 16:47:20] <01> Error    Exception rethrown at [0]: 
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Proxies.RealProxy.HandleReturnMessage(IMessage reqMsg, IMessage retMsg)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Proxies.RealProxy.PrivateInvoke(MessageData& msgData, Int32 type)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Interaction.Management.IJobManagementService.PopPolicyForProcessingSafe(Guid policyId)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Interaction.Management.Client.CJobManagementService.<>c__DisplayClass116.<PopPolicyForProcessingSafe>b__115()
[01.02.2020 16:47:20] <01> Error       at Veeam.Common.Remoting.CRetryableMethod.DoInvoke[Ret](ActionDelegate`1 dlg)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CEpAgentPolicyTaskScheduler.AcceptPolicyTaskForSession(CBackupJob job, CEpPolicyJobSessionContextEx sessionContext)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CEpAgentBackupJobPerformer.Perform()
[01.02.2020 16:47:20] <01> Info     Job has been stopped successfully. Name: [Exchange - Backups], JobId: [08bf6727-fdec-4ad3-ace1-dceb147dca27]
[01.02.2020 16:47:20] <01> Info     Waiting for completion of management jobs.
[01.02.2020 16:47:20] <01> Info     [BackupJobPostActivity] JobSession '3634831e-1273-4260-9ad6-f9fd25f5ed04' PostActivity: 'AskService'
[01.02.2020 16:47:20] <01> Info     [BackupJobPostActivity] Session result is Failed. Checking if it is last retry
[01.02.2020 16:47:20] <01> Info     Job has been stopped with failures. Name: [Exchange - Backups], JobId: [08bf6727-fdec-4ad3-ace1-dceb147dca27]
[01.02.2020 16:47:20] <01> Error    Access denied. (System.Security.SecurityException)
[01.02.2020 16:47:20] <01> Error    Server stack trace: 
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.ServiceLib.CBackupUacAccessChecker.DoCheck(IPrincipal principal, Permissions permission)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Service.CJobMgmtService.Veeam.Backup.Interaction.Management.IJobManagementService.WouldTheFailedJobBeRetried(Guid sessionId)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Messaging.StackBuilderSink._PrivateProcessMessage(IntPtr md, Object[] args, Object server, Object[]& outArgs)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Messaging.StackBuilderSink.SyncProcessMessage(IMessage msg)
[01.02.2020 16:47:20] <01> Error    Exception rethrown at [0]: 
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Proxies.RealProxy.HandleReturnMessage(IMessage reqMsg, IMessage retMsg)
[01.02.2020 16:47:20] <01> Error       at System.Runtime.Remoting.Proxies.RealProxy.PrivateInvoke(MessageData& msgData, Int32 type)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Interaction.Management.IJobManagementService.WouldTheFailedJobBeRetried(Guid sessionId)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Interaction.Management.Client.CJobManagementService.<>c__DisplayClass44.<Veeam.Backup.Interaction.Management.IJobManagementService.WouldTheFailedJobBeRetried>b__43()
[01.02.2020 16:47:20] <01> Error       at Veeam.Common.Remoting.CRetryableMethod.DoInvoke[Ret](ActionDelegate`1 dlg)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CBackupJobPostActivityExecutor.IsNeedPostActivity(CBackupSession session)
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CEpAgentPolicyJobExecuter.Execute()
[01.02.2020 16:47:20] <01> Error       at Veeam.Backup.Core.CJobLauncher.Execute()
[01.02.2020 16:47:20] <01> Info         Job event 'ready2finish' was created for session '3634831e-1273-4260-9ad6-f9fd25f5ed04'. Event full name: 'Global\ready2finishvmjobevent3634831e-1273-4260-9ad6-f9fd25f5ed04'
[01.02.2020 16:47:20] <01> Info     Job [Exchange - Backups] is ready to finish. SessionId: [3634831e-1273-4260-9ad6-f9fd25f5ed04]
[01.02.2020 16:47:20] <01> Info         Job event 'ready2finish' was disposed. Session: '3634831e-1273-4260-9ad6-f9fd25f5ed04'.
[01.02.2020 16:47:20] <01> Info         Job event 'finished' was disposed. Session: '3634831e-1273-4260-9ad6-f9fd25f5ed04'.
[01.02.2020 16:47:20] <01> Info     Disposing SVeeamBackupService...
[01.02.2020 16:47:20] <01> Info         Unregistering TCP client channel [bstcp]
[01.02.2020 16:47:20] <01> Info         Channel successfully unregistered
[01.02.2020 16:47:20] <01> Info         Unregistering TCP client channel [bs_tcp]
[01.02.2020 16:47:20] <01> Info         Channel successfully unregistered
[01.02.2020 16:47:20] <01> Info         Unregistering TCP client channel [cat_tcp]
[01.02.2020 16:47:20] <01> Info         Channel successfully unregistered
[01.02.2020 16:47:20] <01> Info         Job process lock was disposed.
[01.02.2020 16:47:20] <01> Info         Job process lock was disposed.
[01.02.2020 16:47:20] <01> Info     [Ssh] Clearing connection cache
[01.02.2020 16:47:20] <01> Info     [Ssh] Connection cache cleared
[01.02.2020 16:47:20] <01> Info     Disposing SVeeamBackupService...
[01.02.2020 16:47:20] <01> Info     ------- Veeam Manager Stopped -------

[veremin]

We have been supporting application-consistent backups for Exchange 2016 for several years already and we can confirm there are numerous users doing exactly this without any issues.

Based on log snippet, it looks like permission issue, but let support team investigate the debug logs and find the actual root cause of the problem experienced.

Thanks!

[orddie]

Thank you for the confirmation.

Currently I use VMware snap shots on the entire VM. Because of this method, Exchange does not see the update and the logs are not purged.

how are others backing up? maybe i could mirror the setup.

[Regnor]

When i try and do a windows backup on the exchange database and log file drives

With Windows Backup do you mean Agent backup?
And do you backup the whole system our just the data disks/partitions?