Veritas-bu

[Veritas-bu] 6.0 MP4 and NDMP

2007-04-04 13:24:57
Subject: [Veritas-bu] 6.0 MP4 and NDMP
From: brooksje at longwood.edu (Brooks, Jason)
Date: Wed, 4 Apr 2007 13:24:57 -0400
The NDMP logs from the appliance show this:
2007 Apr 04 01:02:50 Notice: callbacks.cc:45 ndmp-image: performing
prolog for image backup. 
2007 Apr 04 01:03:00 Notice: callbacks.cc:45 ndmp-image: continuing
prolog for image backup...please wait. 
2007 Apr 04 01:03:10 Notice: callbacks.cc:45 ndmp-image: continuing
prolog for image backup...please wait. 
2007 Apr 04 01:03:10 Notice: callbacks.cc:45 ndmp-image: backing up
/usr/store. Level 4 requested by DMA. Timestamp of Apr 03 01:03:30 EDT
2007 based on previous level of 3.
2007 Apr 04 01:12:56 Warning: callbacks.cc:54 ndmp-image: aborted. 
2007 Apr 04 01:12:56 Notice: callbacks.cc:45
FileHistory(flushes/number/size): Dir(689/153867/905361)
Node(220/56208/0)
2007 Apr 04 01:26:56 Notice: callbacks.cc:45 ndmp-image: performing
prolog for image backup. 
2007 Apr 04 01:27:07 Notice: callbacks.cc:45 ndmp-image: backing up
/usr/store. Level 4 requested by DMA. Timestamp of Apr 03 01:03:30 EDT
2007 based on previous level of 3.
2007 Apr 04 01:28:52 Warning: couldn't get socket name for new
connection on https listener: 443: Connection reset by peer
2007 Apr 04 01:37:00 Warning: callbacks.cc:54 ndmp-image: aborted. 
2007 Apr 04 01:37:00 Notice: callbacks.cc:45
FileHistory(flushes/number/size): Dir(688/153699/904418)
Node(220/56311/0)
2007 Apr 04 01:51:06 Notice: callbacks.cc:45 ndmp-image: performing
prolog for image backup. 
2007 Apr 04 01:51:15 Notice: callbacks.cc:45 ndmp-image: backing up
/usr/store. Level 4 requested by DMA. Timestamp of Apr 03 01:03:30 EDT
2007 based on previous level of 3.
2007 Apr 04 02:00:42 Warning: callbacks.cc:54 ndmp-image: aborted. 
2007 Apr 04 02:00:42 Notice: callbacks.cc:45
FileHistory(flushes/number/size): Dir(720/161145/945416)
Node(230/58868/0)
2007 Apr 04 02:13:27 Notice: callbacks.cc:45 ndmp-image: performing
prolog for image backup. 
2007 Apr 04 02:13:35 Notice: callbacks.cc:45 ndmp-image: backing up
/usr/store. Level 4 requested by DMA. Timestamp of Apr 03 01:03:30 EDT
2007 based on previous level of 3.
2007 Apr 04 02:22:39 Warning: callbacks.cc:54 ndmp-image: aborted. 
2007 Apr 04 02:22:39 Notice: callbacks.cc:45
FileHistory(flushes/number/size): Dir(846/189145/1097467)
Node(263/67095/0)

2007 Apr 04 09:07:20 Notice: callbacks.cc:45 ndmp-image: performing
prolog for image backup. 
2007 Apr 04 09:07:31 Notice: callbacks.cc:45 ndmp-image: continuing
prolog for image backup...please wait. 
2007 Apr 04 09:07:41 Notice: callbacks.cc:45 ndmp-image: continuing
prolog for image backup...please wait. 
2007 Apr 04 09:07:42 Notice: callbacks.cc:45 ndmp-image: backing up
/usr/store. Level 4 requested by DMA. Timestamp of Apr 03 01:03:30 EDT
2007 based on previous level of 3.

2007 Apr 04 09:20:23 Warning: callbacks.cc:54 ndmp-image: aborted. 
2007 Apr 04 09:20:23 Notice: callbacks.cc:45
FileHistory(flushes/number/size): Dir(707/156661/922632)
Node(229/58506/0)


The appliance is a Mirapoint mail server, which is can be and has been
difficult with NDMP.  The Details of the Activity Monitor show this:
4/4/2007 2:10:55 AM - requesting resource Wormwood-Tape2
4/4/2007 2:10:55 AM - requesting resource
hobbes.NBU_CLIENT.MAXJOBS.159.230.4.30
4/4/2007 2:10:55 AM - requesting resource hobbes.NBU_POLICY.MAXJOBS.NDMP
4/4/2007 2:10:56 AM - granted resource
hobbes.NBU_CLIENT.MAXJOBS.159.230.4.30
4/4/2007 2:10:56 AM - granted resource hobbes.NBU_POLICY.MAXJOBS.NDMP
4/4/2007 2:10:56 AM - granted resource 000073
4/4/2007 2:10:56 AM - granted resource Tape3
4/4/2007 2:10:56 AM - granted resource Wormwood-Tape2
4/4/2007 2:11:12 AM - started process bpbrm (21247)
4/4/2007 2:11:12 AM - connecting
4/4/2007 2:11:12 AM - connected; connect time: 00:00:00
4/4/2007 2:11:16 AM - mounting 000073
4/4/2007 2:11:49 AM - mounted; mount time: 00:00:33
4/4/2007 2:11:49 AM - positioning 000073 to file 159
4/4/2007 2:13:25 AM - positioned 000073; position time: 00:01:36
4/4/2007 2:13:25 AM - begin writing
4/4/2007 2:18:27 AM - Error ndmpagent(pid=21252) terminated by parent
process         
4/4/2007 2:21:37 AM - Error bptm(pid=21253) media manager terminated by
parent process       
4/4/2007 2:21:38 AM - Error ndmpagent(pid=21252) NDMP backup failed,
path = /usr/store       
4/4/2007 2:22:46 AM - Error ndmpagent(pid=21252) connection 0x0818c230
ndmp_message_process_one failed, status = 18 (NDMP_XDR_DECODE_ERR)     
4/4/2007 2:22:45 AM - end writing; write time: 00:09:20
network connection timed out(41)

It was also the 4th attempt, which I believe is the max. 

> -----Original Message-----
> From: veritas-bu-bounces at mailman.eng.auburn.edu 
> [mailto:veritas-bu-bounces at mailman.eng.auburn.edu] On Behalf 
> Of Darren Dunham
> Sent: Wednesday, April 04, 2007 12:38 PM
> To: Veritas-bu at mailman.eng.auburn.edu
> Subject: Re: [Veritas-bu] 6.0 MP4 and NDMP
> 
> > 
> > Yes, we did.  It was from this file:
> >  
> > NB_DMP_60_4_M_285955.linux.tar
> 
> Okay.  You mention the NDMP server shows the attempts, but 
> not success.
> Any other messages associated with the NDMP backups?  Are 
> these Netapp filers or something else?  Can you post the 
> relevant sections from the log?
> 
> I haven't seen this issue before.  I've done some 6.0 -> 
> 6.0MP4 upgrades and they all worked fine (as long as I 
> actually installed NDMP portion).  :-)
> 
> Besides the unified log, does the "Detailed Status" from the 
> job in the activity monitor have any additional information?
> 
> -- 
> Darren Dunham                                           
> ddunham at taos.com
> Senior Technical Consultant         TAOS            
> http://www.taos.com/
> Got some Dr Pepper?                           San Francisco, 
> CA bay area
>          < This line left intentionally blank to confuse you. 
> > _______________________________________________
> Veritas-bu maillist  -  Veritas-bu at mailman.eng.auburn.edu 
> http://mailman.eng.auburn.edu/mailman/listinfo/veritas-bu
> 


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