Veritas-bu

[Veritas-bu] Point In Time (PIT) restore from NetBackup for Lotus Notes failed

2005-05-10 14:43:25
Subject: [Veritas-bu] Point In Time (PIT) restore from NetBackup for Lotus Notes failed
From: rfang AT coke.umuc DOT edu (Rongsheng Fang)
Date: Tue, 10 May 2005 14:43:25 -0400
I almost forgot what I asked...

We only do weekly full back of the database and do hourly transaction
log backup. Every night there are some databases changing their DBIID's,
so we run a script nightly in cron to find out which databases have
changed their DBIID's and back'em up.

Rongsheng

On Tue, May 10, 2005 at 01:21:27PM -0500, Charles Ballowe wrote:
> Date: Tue, 10 May 2005 13:21:27 -0500
> From: Charles Ballowe <cballowe AT gmail DOT com>
> To: Rongsheng Fang <rfang AT coke.umuc DOT edu>, veritas-bu AT 
> mailman.eng.auburn DOT edu
> Subject: Re: [Veritas-bu] Point In Time (PIT) restore from NetBackup for 
> Lotus Notes failed
> Reply-To: Charles Ballowe <cballowe AT gmail DOT com>
> Message-ID: <5ad478c05051011217ef26d12 AT mail.gmail DOT com>
> 
> hmmm... just going through old e-mails and saw this.
> 
> Are you not running an incremental backup of any form through the
> week? If the DBIID changes on the notes database, it needs to be
> backed up again in order for application of the PIT restore from the
> transaction logging to work.
> 
> -Charlie
> 
> On 3/1/05, Rongsheng Fang <rfang AT coke.umuc DOT edu> wrote:
> > Hi list,
> > 
> > We have NetBackup Enterprise Server 5.0 MP4 and NetBackup for Lotus
> > Notes running on Solaris 9 and 8 systems. We do a full backup of out
> > database weekly and do the transaction log backup once every hour. The
> > Archive Logging mode is enabled for the Lotus Domino server.  Everytime
> > when I do a Point-In-Time restore from the NetBackup for Lotus Notes
> > agent, the restore always fails at the PIT database recovery step and
> > spits out the following message:
> > 
> > 14:46:56 (61990.001) ERR - 
> > /restore/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf Recovery 
> > Failed! (0x13F5:Recovery Manager: Database is not latest copy.)
> > 
> > The original database file is located at
> > /lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf and everytime I
> > restore it to /jodie directory.
> > 
> > The full tar log is attached:
> > 
> > 14:45:57 (61990.001) INF - NBLN_Initialize() <Enter>
> > 14:45:57 (61990.001) INF - LN_CreateSuffixList() <Enter>
> > 14:45:57 (61990.001) INF - LN_AddToSuffixList() <Enter>
> > 14:45:57 (61990.001) INF - LN_AddToSuffixList() <Enter>
> > 14:45:57 (61990.001) INF - LN_AddToSuffixList() <Enter>
> > 14:45:57 (61990.001) INF - LN_CreateSuffixList() Suffix: NSF
> > 14:45:57 (61990.001) INF - LN_CreateSuffixList() Suffix: NTF
> > 14:45:57 (61990.001) INF - LN_CreateSuffixList() Suffix: BOX
> > 14:45:57 (61990.001) INF - LN_CreateSuffixList() <Exit>
> > 14:45:57 (61990.001) INF - NBLN_Initialize() <Exit> Lotus Context 
> > Initialized
> > 14:45:57 (61990.001) INF - NBLN_SetNbInfo() <Enter> TempDir: 
> > ProgressLog:/usr/openv/netbackup/logs/user_ops/notesadm/logs/jbpHCBNSaa9l.log
> > 14:45:57 (61990.001) Setting notes.ini from bp.conf
> > 
> > 14:45:57 (61990.001) INF - NBLN_SetLotusInfo() <Enter> 
> > NotesIniPath:/lotus/notesadm/notesr5/notes.ini
> > 14:45:57 (61990.001) Lotus program directory read from PATH: 
> > Notes_ExecDirectory=/lotus/notes/latest/sunspa
> > 
> > 14:45:57 (61990.001) INF - NBLN_ParseRecoveryString() <Enter> Lotus recover 
> > options string:'LOTUS_NOTES ZapId YES'
> > 14:45:57 (61990.001) INF - Recovery Option ZapId = 1
> > 14:45:57 (61990.001) INF - NBLN_ParseRecoveryString() <Enter> Lotus recover 
> > options string:'LOTUS_NOTES ZapReplicaID YES'
> > 14:45:57 (61990.001) INF - Recovery Option ZapReplicaId = 1
> > 14:45:57 (61990.001) INF - NBLN_ParseRecoveryString() <Enter> Lotus recover 
> > options string:'LOTUS_NOTES PointInTime 1108926000'
> > 14:45:57 (61990.001) INF - Recovery Option PointInTime = 1108926000
> > 14:45:57 (61990.001) INF - NBLN_ParseRecoveryString() <Enter> Lotus recover 
> > options string:'LOTUS_NOTES WaitTime 0'
> > 14:45:57 (61990.001) INF - Recovery Option WaitTime = 0
> > 14:45:57 (61990.001) INF - NBLN_ParseRecoveryString() <Enter> Lotus recover 
> > options string:'LOTUS_NOTES RecoveryWait YES'
> > 14:45:57 (61990.001) INF - Recovery Option RecoveryWait = 1
> > 14:45:57 (61990.001) INF - NBLN_Connect() <Enter> 
> > NotesIniPath:'/lotus/notesadm/notesr5/notes.ini'
> > 14:45:58 (61990.001) INF - Lotus Notes Version R5.0.12.0
> > 14:45:58 (61990.001) INF - LN_StoreTransLogStyle() <Enter>
> > 14:45:58 (61990.001) INF - LN_StoreTransLogStyle() <Exit> TransLogStyle: 0x4
> > 14:45:58 (61990.001) INF - NBLN_Connect() <Exit> Connected to Lotus Notes 
> > Session
> > 14:45:58 (61990.001) INF - NBLN_GetLogDirectory() <Enter>
> > 14:45:58 (61990.001) INF - NBLN_GetLogDirectory() <Exit> 
> > TRANSLOG_Path=/domlog
> > 14:45:58 (61990.001) INF - TAR STARTED
> > 14:45:59 (61990.001) parent_bptm = 9526, num_bufs = 8, buff_size = 262144, 
> > dataport = 0, IS_MPX = 1, Ismpx = 0, CINDEX = 0, curr_buf = 0, b
> > uf_seq = 1, is_tape = 1
> > 14:45:59 (61990.001) dataipc = /tmp/vnetFAAM8aie3
> > 14:45:59 (61990.001) SHMID = 65127, BUF_PTR = 0xfd180000, BUF_CONTROL = 
> > 0xfd380000, ReadyPtr = 0xfd3800c0, MPX_RES_CNTL = 0xfd3800c4
> > 14:46:00 (61990.001) FRAGNUM = 1, COPYNUM = 1, KBYTES = 164294656, 
> > REMAINDER = 0, FIRSTBLK = 0, LASTBLK = 328589311
> > 14:46:00 (61990.001) FRAGNUM = 2, COPYNUM = 1, KBYTES = 53262176, REMAINDER 
> > = 0, FIRSTBLK = 328589312, LASTBLK = 435113663
> > 14:46:00 (61990.001) [9526] data socket to bprd is connected (5)
> > 14:46:54 (61990.001) [9526] skipping 261632 bytes, input length was 261632 
> > bytes
> > 14:46:54 (61990.001) [9526] received string: (432 30394367 22544384 0 0 0 
> > 22544384 /lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf)
> > 14:46:54 (61990.001) INF - NBLN_DbRestoreOpen() <Enter> Database 
> > Pathname:/jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf OpenFla
> > gs:0x1 WaitTime:0
> > 14:46:55 (61990.001) INF - 
> > /jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf Taken offline. (1 
> > seconds)
> > 14:46:55 (61990.001) INF - NBLN_DbRestoreOpen() <Exit>
> > 14:46:56 (61990.001) INF - NBLN_ChgInfoRestoreOpen() <Enter> Database 
> > Pathname:/jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf Si
> > ze(0:0)
> > 14:46:56 (61990.001) INF - NBLN_ChgInfoRestoreOpen() <Exit>
> > 14:46:56 (61990.001) INF - NBLN_ChgInfoRestoreClose() <Enter> ChgInfoFlags:0
> > 14:46:56 (61990.001) INF - NBLN_ChgInfoRestoreClose() Db 
> > Pathname:/jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf 
> > ApplyInfoContex
> > t:1
> > 14:46:56 (61990.001) INF - NBLN_ChgInfoRestoreClose() <Exit> Application of 
> > change info ended for:/jodie/lotus/notesadm/notesr5/ACCT221/050
> > 2/8800/class.nsf
> > 14:46:56 (61990.001) INF - NBLN_DbRestoreClose() <Enter> 
> > Database:/jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf 
> > CloseFlags:0x0
> > 14:46:56 (61990.001) INF - NBLN_DbRestoreClose() <Exit>
> > 14:46:56 (61990.001) [9526] received string: (EXIT STATUS 0)
> > 14:46:56 (61990.001) [9526] waited for full buffer 0 times, delayed 0 times
> > 14:46:56 (61990.001) [9526] sent 1 directories/files to client tychousa7
> > 14:46:56 (61990.001) [9526] Exit_shm status = 0
> > 14:46:56 (61990.001) INF - TAR EXITING WITH STATUS = 0
> > 14:46:56 (61990.001) INF - TAR RESTORED 1 OF 1 FILES SUCCESSFULLY
> > 14:46:56 (61990.001) INF - TAR KEPT 0 EXISTING FILES
> > 14:46:56 (61990.001) INF - TAR PARTIALLY RESTORED 0 FILES
> > 
> > 14:46:56 (61990.001) INF - NBLN_RecoverDb() <Enter> RecoveryFlags:27 
> > PointInTime:1108926000
> > 14:46:56 (61990.001) INF - NBLN_RecoverDb() Databases: 
> > /jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf
> > 14:46:56 (61990.001) INF - NBLN_GetTransLogStyle() <Enter>
> > 14:46:56 (61990.001) INF - NBLN_GetTransLogStyle() <Exit> TransLogStyle: 0x4
> > 14:46:56 (61990.001) INF - NBLN_RecoverDb() Opened RestoreRenameFile: 
> > /usr/openv/netbackup/logs/user_ops/LN_Restore_Rename_File_9531.chg
> > 14:46:56 (61990.001) INF - Begin Lotus point in time database recovery to: 
> > 02/20/2005 02:00:00 PM EST
> > 14:46:56 (61990.001) INF - NBLN_RecoverDb() RecoverErrorCode:0x13F5 
> > DbIndex:1
> > 14:46:56 (61990.001) ERR - 
> > /jodie/lotus/notesadm/notesr5/ACCT221/0502/8800/class.nsf Recovery Failed! 
> > (0x13F5:Recovery Manager: Database is
> >  not latest copy.)
> > 14:46:56 (61990.001) INF - TAR RECOVERED 0 of 1 DATABASES SUCCESSFULLY
> > 14:46:56 (61990.001) INF - NBLN_RecoverDb() <Exit> returning failure
> > 14:46:56 (61990.001) INF - NBLN_ReturnLastErrorString() <Enter>
> > 14:46:56 (61990.001) INF - NBLN_ReturnLastErrorString() <Exit> (Error 
> > code:5109)
> > 14:46:56 (61990.001) INF - NBLN_Disconnect() <Enter>
> > 14:46:56 (61990.001) INF - NBLN_DbBackupClose() <Enter> FullDbPath:
> > 14:46:56 (61990.001) INF - NBLN_DbBackupClose() <Exit> Lotus database: 
> > closed.
> > 14:46:56 (61990.001) INF - NBLN_Disconnect() <Exit> Lotus Notes Session 
> > Disconnected
> > 14:46:56 (61990.001) INF - NBLN_Terminate() <Enter>
> > 14:46:56 (61990.001) INF - NBLN_Terminate() <Exit> Freeing Lotus Context
> > 
> > Has anybody experienced such problem before?
> > 
> > Thanks,
> > 
> > Rongsheng
> > _______________________________________________
> > Veritas-bu maillist  -  Veritas-bu AT mailman.eng.auburn DOT edu
> > http://mailman.eng.auburn.edu/mailman/listinfo/veritas-bu
> >
> 
> !DSPAM:4280fbae1855715411288!

<Prev in Thread] Current Thread [Next in Thread>