Start a Conversation

Unsolved

This post is more than 5 years old

3843

January 19th, 2017 06:00

Exchange VSS Backup: Waiting for another backup process to complete. Waiting time: #.#/# minutes

Hi guys,

I have an issue regarding an ExchangeVSS backup.

I've never had any problems with this backup job, until i've made some changes in the Exchange Database.

What i've done is: I've made 2 new mail databases.

Before changes:

- Database1

- Database2

After Changes:

- Database1

- Database2

- Database3

- Database4

And after the changes, the backup job can't completed :/

But i do get some information in the log file on Exchange Server, and that tells me: Waiting for another backup process to complete. Waiting time: #.#/# minutes

The log file:

2017-01-19 14:24:07 avexvss Info <12950>: Plug-in avexvss is started.

2017-01-19 14:24:07 avexvss Info <7967>: Using NT authentication.

2017-01-19 14:24:07 avexvss Info <6673>: CTL listening on port 46121

2017-01-19 14:24:07 avexvss Info <10684>: Setting ctl message version to 3 (from 1)

2017-01-19 14:24:07 avexvss Info <16136>: Setting ctl max message size to 268435456

2017-01-19 14:24:07 avexvss Info <18198>: Performing operation in the context of the root domain.

2017-01-19 14:24:11 avexvss Info <40342>: Initializing PowerShell interface, launching impersonated process

2017-01-19 14:24:29 avexvss Info <40252>: Setting search preferences for c_search query

2017-01-19 14:24:29 avexvss Info <40253>: Setting search preferences for db_search query

2017-01-19 14:24:29 avexvss Info <40253>: Setting search preferences for db_search query

2017-01-19 14:24:29 avexvss Info <40253>: Setting search preferences for db_search query

2017-01-19 14:24:29 avexvss Info <40253>: Setting search preferences for db_search query

2017-01-19 14:24:30 avexvss Info <19008>: Obtaining available VSS providers

2017-01-19 14:24:30 avexvss Info <8871>: Gathering writer metadata...

2017-01-19 14:24:30 avexvss Info <19007>: Adding writer Microsoft Exchange Writer  GUID: {76fe1ac4-15f7-4bcd-987e-8e1acb462fb7}  Instance: {1d33eabb-57ef-46f2-be6c-065fa48f7b9e}

2017-01-19 14:24:31 avexvss Info <16242>: Current log files for database Mailbox Database 1 are 0008F8D7 through 00092073.

2017-01-19 14:24:31 avexvss Info <16242>: Current log files for database Mailbox Database 2 are 0006829F through 00069A51.

2017-01-19 14:24:31 avexvss Info <16242>: Current log files for database Mailbox Database 3 are 00011FD8 through 000130E7.

2017-01-19 14:24:31 avexvss Info <16242>: Current log files for database Mailbox Database 4 are 0000E445 through 0000F427.

2017-01-19 14:24:31 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 0.0/720 minutes.

2017-01-19 14:25:31 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 1.0/720 minutes.

2017-01-19 14:26:32 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 2.0/720 minutes.

2017-01-19 14:27:32 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 3.0/720 minutes.

2017-01-19 14:28:32 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 4.0/720 minutes.

2017-01-19 14:29:33 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 5.0/720 minutes.

2017-01-19 14:30:33 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 6.0/720 minutes.

2017-01-19 14:31:33 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 7.0/720 minutes.

2017-01-19 14:32:34 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 8.0/720 minutes.

2017-01-19 14:33:34 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 9.0/720 minutes.

2017-01-19 14:34:34 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 10.0/720 minutes.

2017-01-19 14:35:34 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 11.1/720 minutes.

2017-01-19 14:36:35 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 12.1/720 minutes.

2017-01-19 14:37:35 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 13.1/720 minutes.

2017-01-19 14:38:35 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 14.1/720 minutes.

2017-01-19 14:39:36 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 15.1/720 minutes.

2017-01-19 14:40:36 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 16.1/720 minutes.

2017-01-19 14:41:36 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 17.1/720 minutes.

2017-01-19 14:42:37 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 18.1/720 minutes.

2017-01-19 14:43:37 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 19.1/720 minutes.

2017-01-19 14:44:37 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 20.1/720 minutes.

2017-01-19 14:45:37 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 21.1/720 minutes.

2017-01-19 14:46:38 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 22.1/720 minutes.

2017-01-19 14:47:38 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 23.1/720 minutes.

2017-01-19 14:48:38 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 24.1/720 minutes.

2017-01-19 14:49:39 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 25.1/720 minutes.

2017-01-19 14:50:39 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 26.1/720 minutes.

2017-01-19 14:51:39 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 27.1/720 minutes.

2017-01-19 14:52:40 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 28.1/720 minutes.

2017-01-19 14:53:40 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 29.1/720 minutes.

2017-01-19 14:54:40 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 30.2/720 minutes.

2017-01-19 14:55:41 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 31.2/720 minutes.

What I've done until now:

- Killed all sessions on the Avamar Utillity Node (via PuTTy)

- Deleted the orignal "AvamarBackupUser", incl. Mailbox

- Deleted the whole "avs" folder in C:/ProgramFiles/avs/

- Re-installed the whole client, incl. the ExchangeVSS Plug-in

- Created a new "AvamarBackupUser", incl. Mailbox and the correct permissions according the documentation

Any suggestions on this problem?

Thanks

David

2K Posts

January 19th, 2017 11:00

It sounds like Exchange itself is telling the Avamar plug-in that there is another backup running. If you re-run the backup in debug mode, the logs may provide more information.

January 20th, 2017 00:00

Okay, thanks - I'll try and do another backup in debug mode, and upload the log content.

10 Posts

January 23rd, 2017 07:00

So a few questions here:

  1. What version of exchange are you running?
  2. Are the four DS on the same lun?
  3. Is it parallel or linear backups you are performing?

I faced the similar issues with other Backup products, and when I spoke to MS, it was suggested, that we, not run parallel backups and if we had to the DS should not be on the same lun.

(DS = DataStore)

2 Posts

January 25th, 2017 10:00

I have the same problem.

Exchange 2013 RTM

Yes, ds the same LUN

Backup parallel/Linear: i don't know.

1 Message

May 24th, 2017 13:00

I'm running into the same issues for a client of mine.  not sure what changes were done to the Exchange server, but the job will periodically start throwing this error.  the only thing that resolves the issue is a reboot of the exchange server. 

Latest log file :

2017-05-23 19:12:14 avexvss Info <12950>: Plug-in avexvss is started.

2017-05-23 19:12:14 avexvss Info <7967>: Using NT authentication.

2017-05-23 19:12:14 avexvss Info <6673>: CTL listening on port 36028

2017-05-23 19:12:14 avexvss Info <10684>: Setting ctl message version to 3 (from 1)

2017-05-23 19:12:14 avexvss Info <16136>: Setting ctl max message size to 268435456

2017-05-23 19:12:14 avexvss Info <18198>: Performing operation in the context of the root domain.

2017-05-23 19:12:25 avexvss Info <40252>: Setting search preferences for c_search query

2017-05-23 19:12:25 avexvss Info <40253>: Setting search preferences for db_search query

2017-05-23 19:12:25 avexvss Info <40253>: Setting search preferences for db_search query

2017-05-23 19:12:25 avexvss Info <40253>: Setting search preferences for db_search query

2017-05-23 19:12:25 avexvss Info <40253>: Setting search preferences for db_search query

2017-05-23 19:12:25 avexvss Info <40253>: Setting search preferences for db_search query

2017-05-23 19:12:26 avexvss Info <19008>: Obtaining available VSS providers

2017-05-23 19:12:26 avexvss Info <8871>: Gathering writer metadata...

2017-05-23 19:12:26 avexvss Info <19007>: Adding writer Microsoft Exchange Writer GUID: {76fe1ac4-15f7-4bcd-987e-8e1acb462fb7} Instance: {632d7b6a-8617-4d15-be9c-f06aae845594}

2017-05-23 19:12:26 avexvss Info <16242>: Current log files for database Mailbox Database 5 are 0005E47C through 0005F0F0.

2017-05-23 19:12:26 avexvss Info <16242>: Current log files for database Mailbox Database 1 are 0016005F through 001613DE.

2017-05-23 19:12:26 avexvss Info <16242>: Current log files for database Mailbox Database 2 are 0022BD39 through 0022F72A.

2017-05-23 19:12:26 avexvss Info <16242>: Current log files for database Mailbox Database 3 are 001D2332 through 001D383B.

2017-05-23 19:12:26 avexvss Info <16242>: Current log files for database Mailbox Database 4 are 0021991F through 0021B33D.

2017-05-23 19:12:26 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 0.0/720 minutes.

2017-05-23 19:13:27 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 1.0/720 minutes.

...

2017-05-24 07:11:12 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 718.8/720 minutes.

2017-05-24 07:12:12 avexvss Info <0000>: Waiting for another backup process to complete. Waiting time: 719.8/720 minutes.

2017-05-24 07:13:12 avexvss Error <0000>: Terminating backup process because another backup is not completed after 720.8/720 minutes.
2017-05-24 07:13:12 avexvss Error <13077>: Unable to complete backup.
2017-05-24 07:13:12 avexvss Info <9772>: Starting graceful (staged) termination, Exiting main body (wrap-up stage)
2017-05-24 07:13:12 avexvss Info <7753>: Exit main body...
2017-05-24 07:13:12 avexvss Info <13180>: Final summary...
2017-05-24 07:13:12 avexvss Info <13181>: snapview_wid: 7PM-Exchange Nightly-1495591201176#0
2017-05-24 07:13:12 avexvss Info <7271>: Final summary generated subwork 0, cancelled/aborted 0, snapview 0, exitcode 536870919
2017-05-24 07:13:17 avexvss Info <12951>: Plug-in avexvss returning with exitcode 536870919

No Events found!

Top