ADSM-L

Re: [ADSM-L] NAS Restore failure, any thoughts?

2012-08-24 10:06:53
Subject: Re: [ADSM-L] NAS Restore failure, any thoughts?
From: white jeff <jeff.white3 AT BLUEYONDER.CO DOT UK>
To: ADSM-L AT VM.MARIST DOT EDU
Date: Fri, 24 Aug 2012 14:59:40 +0100
Hi Joni

Nothing suspect with the process itself then.

Can you do a 'q act' between the times below please? Something
happened between 13:58 and 14:01 to make the process fail

(q act begind=-1 begint=13:58:44 endd=-1 endt=14:01:30)

08/23/12 13:58:44     ANR0512I Process 23348 opened input volume QA0265.
                       (SESSION: 55984, PROCESS: 23348)
08/23/12 14:01:28     ANR9999D_3279216401 ssRtrvRemote(ssremote.c:1811)
                       Thread<175705>: Invalid offset 755.1600443456 for image
                       restore(SESSION: 55984, PROCESS: 23348)


Regards




On 24 August 2012 13:46, Moyer, Joni M <joni.moyer AT highmark DOT com> wrote:
> Hi Jeff,
>
> Here is the everything associated with that process.  Any ideas?  Thanks 
> again!
>
> Date/Time             Message
> --------------------  
> ----------------------------------------------------------
> 08/23/12 13:55:54     ANR0984I Process 23348 for RESTORE NAS (SELECTIVE) 
> started
>                        in the BACKGROUND at 13:55:54. (SESSION: 55984, 
> PROCESS:
>                        23348)
> 08/23/12 13:55:54     ANR1059I Selective restore of NAS node VNX5481_NAS_3, 
> file
>                        system /root_vdm_12/HMCH1026_I_bkup, started as process
>                        23348 by administrator LIDZR8V.  Specified files and/or
>                        directory trees will be restored to destination 
> /temp_3.
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 13:55:54     ANR0403I Session 55984 ended for node VNX5481_NAS_3
>                        (TSMNAS). (SESSION: 55984, PROCESS: 23348)
> 08/23/12 13:56:22     ANR8337I NAS volume QA0258 mounted in drive LTO5_5
>                        (c256t0l0). (SESSION: 55984, PROCESS: 23348)
> 08/23/12 13:56:22     ANR0512I Process 23348 opened input volume QA0258.
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 13:57:16     ANR0515I Process 23348 closed volume QA0258. (SESSION:
>                        55984, PROCESS: 23348)
> 08/23/12 13:58:18     ANR8468I NAS volume QA0258 dismounted from drive LTO5_5
>                        (c256t0l0) in library NAS_QI6000_ONSITE. (SESSION: 
> 55984,
>                        PROCESS: 23348)
> 08/23/12 13:58:44     ANR8337I NAS volume QA0265 mounted in drive LTO5_4
>                        (c272t0l0). (SESSION: 55984, PROCESS: 23348)
> 08/23/12 13:58:44     ANR0512I Process 23348 opened input volume QA0265.
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D_3279216401 ssRtrvRemote(ssremote.c:1811)
>                        Thread<175705>: Invalid offset 755.1600443456 for image
>                        restore(SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705> issued message 9999 from:
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000c7e8 StdPutText
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000fb90 OutDiagToCons
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000a2d0 outDiagfExt
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001004f8ab8 ssRtrvRemote
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001007f9838 
> AfRtrvRemoteThr-
>                        ead  (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010001509c StartThread
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR1078E NAS Restore process 23348 terminated - internal
>                        server error detected. (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705> issued message 1078 from:
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000e138 StdPutMsg
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  0000000100013cd8 outRptf
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001007f81e4 EndRemoteProc
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001007f98f0 
> AfRtrvRemoteThr-
>                        ead  (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010001509c StartThread
>                        (SESSION: 55984, PROCESS: 23348)
> 08/23/12 14:01:28     ANR0988I Process 23348 for RESTORE NAS (SELECTIVE) 
> running
>                        in the BACKGROUND processed 65,536 bytes with a
>                        completion state of FAILURE at 14:01:28. (SESSION: 
> 55984,
>                        PROCESS: 23348)
> 08/23/12 14:02:36     ANR8468I NAS volume QA0265 dismounted from drive LTO5_4
>                        (c272t0l0) in library NAS_QI6000_ONSITE. (SESSION: 
> 55984,
>                        PROCESS: 23348)
>
> -----Original Message-----
> From: ADSM: Dist Stor Manager [mailto:ADSM-L AT VM.MARIST DOT EDU] On Behalf 
> Of white jeff
> Sent: Friday, August 24, 2012 5:05 AM
> To: ADSM-L AT VM.MARIST DOT EDU
> Subject: Re: NAS Restore failure, any thoughts?
>
> Hi Joni
>
> I have seen these many times, but there are always some accompanying messages 
> with these. Try a 'q actlog s=23348' (the process number) from when the 
> process started. What is that showing?
>
> On 23 August 2012 19:03, Moyer, Joni M <joni.moyer AT highmark DOT com> wrote:
>> Hi Everyone,
>>
>> I have a TSM 5.5.5.0 AIX 5.3 server doing NAS NDMP backups/restores.  I got 
>> the following message.  Has anyone seen this before or know what it means?  
>> It's kind of cryptic.  Thanks in advance!
>>
>> Joni
>>
>> 08/23/12 14:01:28     ANR9999D_3279216401 ssRtrvRemote(ssremote.c:1811)
>>                        Thread<175705>: Invalid offset 755.1600443456 for 
>> image
>>                        restore(SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705> issued message 9999 from:
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000c7e8 StdPutText
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000fb90 OutDiagToCons
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000a2d0 outDiagfExt
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001004f8ab8 ssRtrvRemote
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001007f9838 
>> AfRtrvRemoteThr-
>>                        ead  (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010001509c StartThread
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR1078E NAS Restore process 23348 terminated - 
>> internal
>>                        server error detected. (SESSION: 55984, PROCESS: 
>> 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705> issued message 1078 from:
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010000e138 StdPutMsg
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  0000000100013cd8 outRptf
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001007f81e4 EndRemoteProc
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  00000001007f98f0 
>> AfRtrvRemoteThr-
>>                        ead  (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR9999D Thread<175705>  000000010001509c StartThread
>>                        (SESSION: 55984, PROCESS: 23348)
>> 08/23/12 14:01:28     ANR0988I Process 23348 for RESTORE NAS (SELECTIVE) 
>> running
>>                        in the BACKGROUND processed 65,536 bytes with a
>>                        completion state of FAILURE at 14:01:28. (SESSION: 
>> 55984,
>>                        PROCESS: 23348)
>>
>>
>> ________________________________
>>
>> This e-mail and any attachments to it are confidential and are intended 
>> solely for use of the individual or entity to whom they are addressed. If 
>> you have received this e-mail in error, please notify the sender immediately 
>> and then delete it. If you are not the intended recipient, you must not 
>> keep, use, disclose, copy or distribute this e-mail without the author's 
>> prior permission. The views expressed in this e-mail message do not 
>> necessarily represent the views of Highmark Inc., its subsidiaries, or 
>> affiliates.