Video Screencast Help
Search Video Help Close Back
to help
New in the Rewards Catalog: Vouchers for "Symantec Technical Specialist" and "Symantec Certified Specialist" exams.

Exchange Mailbox backup failed

Updated: 01 Jun 2010 | 25 comments
Zahid.Haseeb's picture
-2 2 Votes
Login to vote

 :17:28.966 PM: [27784.26460] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\111609.LOG

 

5:17:28.966 PM: [27784.26460] <4> ov_log::OVInit: GENERAL Log Level: 0

5:17:28.966 PM: [27784.26460] <4> ov_log::OVInit: TCP Log Level: 0

5:17:28.966 PM: [27784.26460] <4> ov_log::OVInit: INF - the log mutex: 1800

BPBKAR  NetBackup Backup/Archive  6.5GA  [Jul 23 2007]

Copyright 1993 - 2007 VERITAS Software Corporation

All Rights Reserved.

 

5:17:28.982 PM: [27784.26460] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'

5:17:28.982 PM: [27784.26460] <2> WinMain: DAT - lpCmdLine = '-r 1209600 -ru root -dt 0 -to 0 -clnt evsmail -class Exchange_MailBoxex -sched Full -st FULL -bpstart_to 300 -bpend_to 300 -read_to 3600 -use_otm -fso -b evsmail_1258373845 -kl 28 -ct 16 -use_ofb '

5:17:28.982 PM: [27784.26460] <2> date_debug: DAT - timezone: West Asia Standard Time, offset=-18000, dst: NONE

5:17:28.982 PM: [27784.26460] <2> date_debug: DAT - current time: 1258373848, 11/16/2009 5:17:28 PM

5:17:28.982 PM: [27784.26460] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 5:00:00 AM

5:17:28.982 PM: [27784.26460] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 5:00:00 AM

5:17:28.982 PM: [27784.26460] <2> WinMain: DAT - standard input handle = 468

5:17:28.982 PM: [27784.26460] <2> WinMain: DAT - standard output handle = 1900

5:17:28.982 PM: [27784.26460] <2> WinMain: DAT - standard error handle = 1844

5:17:29.013 PM: [27784.26460] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff

5:17:29.013 PM: [27784.26460] <4> tar_backup::V_SetupJobData: INF -     dwJob: ffffffff

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - user name: root

5:17:29.029 PM: [27784.26460] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup

5:17:29.263 PM: [27784.26460] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received

5:17:29.576 PM: [27784.26460] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = Microsoft Exchange Mailboxes:\

5:17:29.576 PM: [27784.29852] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds

5:17:29.591 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: M:

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Q:

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\evsmail\Microsoft Exchange Mailboxes

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\evsmail\Microsoft Exchange Public Folders

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\evsmail\Microsoft Information Store

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\evsmail\Microsoft Information Store\First Storage Group

5:17:31.279 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\evsmail\Microsoft Information Store\Second Storage Group

5:17:31.279 PM: [27784.26460] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Microsoft Exchange Mailboxes:\' --> 10020019

5:17:31.279 PM: [27784.26460] <4> dos_backup::V_VerifyFileList: INF - unable to determine UBS type for:_BACKUP_SPECIAL_OBJECTS BEFORE Microsoft Exchange Mailboxes:

5:17:31.279 PM: [27784.26460] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS BEFORE Microsoft Exchange Mailboxes:' --> 00000000

5:17:31.279 PM: [27784.26460] <4> dos_backup::V_VerifyFileList: INF - unable to determine UBS type for:_BACKUP_SPECIAL_OBJECTS AFTER Microsoft Exchange Mailboxes:

5:17:31.279 PM: [27784.26460] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER Microsoft Exchange Mailboxes:' --> 00000000

5:17:31.279 PM: [27784.26460] <4> dos_backup::V_Initialize: INF - Exchange Backup - Disabling Open File Backups, Archive Bit processing, TIR and Job Estimating.

5:17:31.279 PM: [27784.26460] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'

5:17:32.013 PM: [27784.26460] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request BEFORE Microsoft Exchange Mailboxes:

5:17:32.013 PM: [27784.26460] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER Microsoft Exchange Mailboxes:

5:17:32.013 PM: [27784.26460] <2> tar_base::backup_finish: TAR - backup:                     0 files

5:17:32.013 PM: [27784.26460] <2> tar_base::backup_finish: TAR - backup:          file data:          0 bytes

5:17:32.013 PM: [27784.26460] <2> tar_base::backup_finish: TAR - backup:         image data:          0 bytes

5:17:32.013 PM: [27784.26460] <2> tar_base::backup_finish: TAR - backup:       elapsed time:          1 secs            0 bps

5:17:32.044 PM: [27784.26460] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0

5:17:32.044 PM: [27784.26460] <4> tar_backup::backup_done_state: INF -     number of file directives found: 3

5:17:32.044 PM: [27784.29852] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)

5:17:32.044 PM: [27784.26460] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)

5:17:32.044 PM: [27784.26460] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 71: none of the files in the file list exist

5:17:32.044 PM: [27784.26460] <4> tar_backup::backup_done_state: INF - Not waiting for server status

5:17:32.044 PM: [27784.26460] <4> dos_backup::tfs_reset: INF - Snapshot deletion start

5:17:32.076 PM: [27784.26460] <4> OVStopCmd: INF - EXIT - status = 0

5:17:32.076 PM: [27784.26460] <2> tar_base::V_Close:

5:17:32.076 PM: [27784.26460] <4> dos_backup::tfs_reset: INF - Snapshot deletion start

5:17:32.076 PM: [27784.26460] <2> ov_log::V_GlobalLog: INF - BEDS_Term() Enter InitFlags:0x1

5:17:32.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:33.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:34.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:35.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:36.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:37.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:38.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:39.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:40.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:41.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:42.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:43.091 PM: [27784.26460] <16> dtcp_read: TCP - failure: recv socket (468) (TCP 10053: Software caused connection abort)

5:17:43.091 PM: [27784.26460] <4> OVShutdown: INF - Finished process

5:17:43.107 PM: [27784.26460] <4> WinMain: INF - Exiting C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe

5:17:45.107 PM: [27784.26460] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\111609.LOG

discussion Filed Under:

Comments

rjrumfelt's picture
16
Nov
2009
0 Votes 0
Login to vote

These are just log files

Please state what you have done so far to resolve the failure.  Your threads are usually fairly descriptive.

Zahid.Haseeb's picture
16
Nov
2009
0 Votes 0
Login to vote

I am using Veritas Netbackup

I am using Veritas Netbackup Server 6.5 on win2003 Server R2
My exchange Mailbox backup failed. the above are my bpbkar logs

Any comment will be appreciated. Mark as Solution if your query is resolved
__________________
Thanks in Advance
Zahid Haseeb

zahidhaseeb.wordpress.com
 

Deepak W's picture
16
Nov
2009
3 Votes +3
Login to vote

You may refer to below

You may refer to below mentioned TN to resolve the issue...

http://seer.entsupport.symantec.com/docs/276763.htm

ftp://exftpp.symantec.com/pub/support/products/NetBackup_Enterprise_Server/278505.pdf

-- Deepak W (Kindly close the thread if your query is resolved)

Hasan's picture
20
Nov
2009
0 Votes 0
Login to vote

I have the same issue as

I have the same issue as Haseeb, the bpbkar logs look identical. In my case I am running a evaluation copy of Netbackup for a client and cannot perform a backup for GRT. I have update the MS MAPI dll, given the Netbackup service Enterprise Admin/Domain Admin rights, checked the registry for Exchange_Mailbox name, installed NFS services on the exchange box, checked the class_type folder for MS_Exchange and the only thing that I can't do is enable document restore on the policy attributes for exchange - it is greyed out.

Hasan

Hasan's picture
20
Nov
2009
0 Votes 0
Login to vote
Zahid.Haseeb's picture
22
Nov
2009
1 Vote -1
Login to vote

Hassan follow the below link

Hassan follow the below link , your problem will definately be resolved.

 https://www-secure.symantec.com/connect/articles/exchange-backup-and-restore-netbackup-65-part-ii


Any comment will be appreciated. Mark as Solution if your query is resolved
__________________
Thanks in Advance
Zahid Haseeb

zahidhaseeb.wordpress.com
 

liyaqat@almoayyedintl.com.bh's picture
23
Nov
2009
2 Votes +2
Login to vote

Netbackup GRT please don't use it

Symantec is not tested the Product of GRT for Exchange before Launch.
We have Log the Case with Symantec and it is more than 2 months without solution for GRT backup of Exchange.
The Symantec Engineer keep collecting Fresh Logs without giving proper solution.

First they told to remove microsoft patch from exchange server as GRT backup alway use to fails.

we removed that patch.

Than told to reinstall hotfix for NFS, change the online maintaince time from night to Day time so that it won't run with the back.
 

the backup run sucessfull few days and keep failing after sometime.till now no solution from Symantec Technical Support. 2 months now the case is still open.

But do you know the worst part. just imagine any guess.

The backup which somtime shows sucessful.

We cannot restore single mailbox with that successfull backup.

So this is a advise to All technical people out there please don't use GRT for Exchange.
 

Hasan's picture
24
Nov
2009
0 Votes 0
Login to vote

Thanks Haseeb, That is how

Thanks Haseeb,

That is how I configured the policy in the first place. It looks to me more like a network related issue, maybe a disparity in the link speeds of the Network adaptors?

Hasan

Hasan's picture
24
Nov
2009
0 Votes 0
Login to vote

Liyaqat I did an install for

Liyaqat

I did an install for a client in Feb 09 and configured the policy for GRT and it has been working fine, however the only difference is that they are using exchange 2003 rather than 2007.

Hasan

Hasan's picture
27
Nov
2009
1 Vote -1
Login to vote

GRT Config

I have resolved my issue.

I had basically installed Netbackup 6.5 trial version and the GRT feature was available from 6.5.3, I had to
1. upgrade to 6.5.3
2. get NFS services working on the media server
3. Uncheck "Enable single instance backup for message attachments" and it all started to work

I am now running 6.5.4 and the GRT backups are running fine. 

Thanks Haseeb, I have used your procedures to configure the individual mailboxes and it worked great!

Regards
Hasan

lu's picture
30
Nov
2009
0 Votes 0
Login to vote

Are you sure you're using GRT

Are you sure you're using GRT ?
Because the option "Enable single instance backup..." applies only to streaming Exchange backups, not GRT.
For GRT you need to check "Enable Granular recovery".

Hasan's picture
27
Nov
2009
0 Votes 0
Login to vote

Restore

I haven't tested a restore yet, the question was whether I can restore to the original location with exchange server running?

Hasan

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

GRT

Yes "Enable Granular recovery" is checked and I have taken a good backup of some mailboxes which brings me to my next issue:-) I configured the mailbox backup by using the directive set MS_Exchange_Mailbox and directive Miscrosoft Exchange Mailboxes:\. The resulting backup has selectively backed up only 62 out of 220 possible mailboxes. Any ideas? 

lu's picture
01
Dec
2009
0 Votes 0
Login to vote

If you use "Miscrosoft

If you use "Miscrosoft Exchange Mailboxes:\" it's not GRT. GRT=backuping the whole stores at the file level (=very fast) and be able to restore individual items.

Only 62 out of 220 and you get a status 0 ?

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

GRT

No got status code 1's - the requested operation was partially successful(1).

So from what I understand if I backup the information store with the "enable granular recovery" it should give me the ability to restore individual mailboxes. Also can I do a normal exchange RSG restore with these backups? 

Regards
Hasan 

lu's picture
01
Dec
2009
0 Votes 0
Login to vote

No, for a RSG restore, you

No, for a RSG restore, you need a "Microsoft Information Store:\" backup (with or without granular recovery enabled).

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

GRT

Okay, I am slightly confused - please excuse my ignorance.

1. In order to use GRT, and from what I understand, we must backup the infornation store using the MS_Exchange_200x Directive Set with the Miscrosoft Information Store:\ directive keeping the GRT option enabled? Or is there some other config for this?

2. The backup of the information store will also be done in a similar fashion only that the recovery will involve an exhange RSG?

Hasan

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

GRT

I have just run a backup with GRT checked using Microsoft Information Store:\First Storage Group in the backup selection. It has backed up this storage group fine but when I try and restore I cannot do it at the file level rather I have to restore the whole DB's under this storage group.

Hasan

lu's picture
01
Dec
2009
0 Votes 0
Login to vote

Did you get a status 1 ?

Did you get a status 1 ?

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

GRT

Yes I did?

I hopimg that its a good thing to get status 1:-)

Hasan

lu's picture
01
Dec
2009
0 Votes 0
Login to vote

If you have GRT enabled, and

If you have GRT enabled, and get a status 1, you will only be able to do store level restore, not a message level one.

To find why you got a status 1, you now need to dig into the bpbkar log file on your Exchange server.

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

GRT

I looked at the bpbkar on the exchange server and found this error :

ERR - Unable to initialize nbfsd. 

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote

The fix as stated by symantec

The fix as stated by symantec is to stop the Server For NFS service on the media server and start portmap. However, this service was not running on my media server and is disabled so I can't see this to be the problem.

Hasan

Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote
Hasan's picture
01
Dec
2009
0 Votes 0
Login to vote