Networker

[Networker] NDMP restore fails with "Error during File NDMP Extraction"

2010-06-08 14:55:41
Subject: [Networker] NDMP restore fails with "Error during File NDMP Extraction"
From: Imran_ML <networker-forum AT BACKUPCENTRAL DOT COM>
To: NETWORKER AT LISTSERV.TEMPLE DOT EDU
Date: Tue, 8 Jun 2010 08:31:12 -0400
We are having serious issues with recovering NDMP data. The backups have 
completed succsfully but we are unable to recover most of the data backed up 
which fails with Error during File NDMP Extraction. We have checked that there 
is inconsistency in the file number of the NDMP data on the tape which should 
ideally be in multiples of 3. We have tuned of ndmp_auto_pos to disable 
dependancy on the ile mark and tried recovery but till the recovery fails. 
Below is a output of a D9 debug level restore.

 
mmdbd server host name: bakl038z
RPC Authentication: error in LookupAccountSid: No mapping between account names 
and security IDs was done.
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth: redirected to bakl038z prog 390103 vers 2
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth for `nsrmmdbd' succeeded
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
RPC Authentication: Client successfully authenticated using GSS Legato
clu_get_clustersvr_nsrdir: ENTRY.
clu_is_cluster_mode:ENTRY
app_name=NetWorker, app_dir=F:\Program Files\Legato\nsr\bin\
clu_is_cluster_host:ENTRY
clu_is_cluster_host:EXIT:returning FALSE
b_clusmode=0
clu_is_cluster_mode:EXIT
42879:nsrndmp_recover: Peforming recover with no file mark dependency..
Destructive Restore is specified.
SSID = 1960526258, Mount point =/root_vdm_1/SW_Home01/Restore, Raw device 
=(null)
save set name: /root_vdm_6/CTC_Home04
Not a Celestra retrieval.
save set name: /root_vdm_6/CTC_Home04
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth: redirected to bakl038z prog 390103 vers 2
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth for `nsrd' succeeded
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
ndmp_create_connect: host(nas1090),user(ndmp),data(00000000),timeout(60)
socket (1464) is opened for NDMP connection.
ndmp_wait_connect: ndp=02CBE8F8,timeout=60
ndmp_skiprecord: 1
Error in message header: Operation would block.
ndmp_skiprecord: 1
dispatch 1282 1
ndmp_notify_connect: ndp(02CBE8F8)
Receive successful NDMP connection.
ndmp_connect_open: ndp(02CBE8F8)
call 2304 1
ndmp_skiprecord: 1
NDMP version 4 is used.
ndmp_connect_auth= ndp(02CBE8F8), host(nas1090), user (ndmp)
call 264 2
ndmp_skiprecord: 1
dispatch 1539 3
NDMP Service Debug: The process id for NDMP service is 0x94f28460
ndmp_skiprecord: 1
type supported : 1
type supported : 2
The NDMP user 'ndmp' has a password for host 'nas1090'.
authentication method=2, host=nas1090, user=ndmp, pas=02F15F40
CreateMD5Digest: ndp(02CBE8F8)
call 259 3
ndmp_skiprecord: 1
call 2305 4
ndmp_skiprecord: 1
AUTH_MD5 connection succeeded!
call 258 5
ndmp_skiprecord: 1
It is not a IGS NDMP Service.
ndmp_connect_close
call 2306 6
ndmp_shutdown
42787:nsrndmp_recover:ssid'1960526258': Performing recover from NDMP type of 
device
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth for `nsrindexd' succeeded
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
RPC Authentication: Client successfully authenticated using GSS Legato
lg_open(): Calling win_open_secure().
There was an error in creating the file: "No such file or directory"
lg_stat(): Calling win_stat().
lg_open(): Calling win_open_secure().
There was an error in creating the file: "No such file or directory"
lg_stat(): Calling win_stat().
reset the ndmp_clnt_tbl to use the ndmp_bt_clnt_tbl.
task = 2
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth: redirected to bakl038z.bdn.neas.aero prog 390103 vers 2
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth for `nsrd' succeeded
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth: redirected to bakl038z prog 390103 vers 2
Calling clnttcp_create function
socket bound to arbitrary port
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
RPC Authentication: Client successfully authenticated using GSS Legato
lgto_auth for `nsrmmd' succeeded
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
lg_open(): Calling win_open_secure().
RPC Authentication: Client successfully authenticated using GSS Legato
connecting to mm prog 390104 vers 705 on `bakl038z.bdn.neas.aero'
Calling clnttcp_create function
Calling clnttcp_create function
socket bound to arbitrary port
socket bound to arbitrary port
RPC Authentication: Client successfully authenticated using GSS Legato
39077:nsrndmp_recover:ssid'1960526258': error, ndmp tape mtio failed, I/O error

42850:nsrndmp_recover:ssid'1960526258': Failed to load volume 115024427 fnum 6
42855:nsrndmp_recover:ssid'1960526258': Failed to load the tape.
42871:nsrndmp_recover:ssid'1960526258': Error during File NDMP Extraction.
Connections closed sucessfully
42840:nsrndmp_recover:ssid'1960526258': NDMP recover failed.
42880:nsrndmp_recover:ssid'1960526258': Error during NDMP recover

 
We have a support case open with EMC but going nowhere...

 
 
Backup server is Windows 2003 with Networker 7.4.2 Build 494

NAS Filer: EM Celerra

Dart Code:5.6.48

 
Any help with this is greatly appreciated



additonal information:

Have tried restoring for 2 different tapes ad savesets but no luck.

 
 
C:\>mminfo -S -q ssid=1960526258
ssid=1960526258 savetime=4/30/2010 9:46:42 PM (1272660402) 
nas1090:/root_vdm_6/CTC_Home04
  level=full sflags=vrNF     size=574837923844 files=2447093    insert=4/30/2010

  create=4/30/2010 complete=4/30/2010 browse=forever  retent=forever
  clientid=ae53cf35-00000004-49a11a80-49a11a7f-01730000-0a987837
                     *DIRECT: y, y;
                *EMC_EFILE01: \
/root_vdm_3/SW_App02/root/Shares/ProdApps/Tier4/A00033_Crystal_Reports_Standa\rd_9_b12/Windows/System32/Drvvfp.cnt,
/root_vdm_3/SW_App02/root/Shares/ProdApps/Tier4/A00033_Crystal_Reports_Standa\rd_9_b12/Windows/System32/Drvvfp.cnt;
                 *FILESYSTEM: /root_vdm_6/CTC_Home04;
                       *HIST: y, y;
                       *HOST: nas1090;
                      *LEVEL: 0;
                    *MD_SIZE: 935878656;
               *MD_SIZE_HIGH: 0;
                *NDMP_BUTYPE: vbb;
                    *OPTIONS: NT, NT;
                     *PREFIX: /root_vdm_6/CTC_Home04;
                   *SNAPSURE: y, y;
                       *TYPE: vbb;
                     *UPDATE: y, y;
                       group: SWNNAS1090R;
  Clone #1: cloneid=1272660402  time=4/30/2010 9:46:42 PM    retent=forever   
flags=F
    frag@         0 volid= 115024427 file/rec=       6/0     rn=0 last=4/30/2010

 
 
 
C:\>mminfo -S -q ssid=3539500036
ssid=3539500036 savetime=5/23/2010 1:46:57 AM (1274575617) nas1090:/root_vdm_6/C
TC_Home04
  level=full sflags=vNF      size=576808697860 files=2479887    insert=5/23/2010

  create=5/23/2010 complete=5/23/2010 browse=6/20/2010 11:59:56 PM retent=6/20/2
010 11:59:56 PM
  clientid=ae53cf35-00000004-49a11a80-49a11a7f-01730000-0a987837
                     *DIRECT: y, y;
                 *FILESYSTEM: /root_vdm_6/CTC_Home04;
                       *HIST: y, y;
                       *HOST: nas1090;
                      *LEVEL: 0;
                    *MD_SIZE: 947437568;
               *MD_SIZE_HIGH: 0;
                *NDMP_BUTYPE: vbb;
                    *OPTIONS: NT, NT;
                     *PREFIX: /root_vdm_6/CTC_Home04;
                   *SNAPSURE: y, y;
                       *TYPE: vbb;
                     *UPDATE: y, y;
                       group: SWNNAS1090R;
  Clone #1: cloneid=1274575876  time=5/23/2010 1:51:16 AM    retent=6/20/2010  f
lags=F
    frag@         0 volid=1928759058 file/rec=      12/0     rn=0 last=5/23/2010

    frag@23872880640 volid=1911981872 file/rec=      19/0     rn=0 last=5/23/201
0
    frag@236293079040 volid=1895204670 file/rec=      19/0     rn=0 last=5/23/20
10
    frag@477005598720 volid=3002670157 file/rec=       3/0     rn=0 last=5/23/20

+----------------------------------------------------------------------
|This was sent by imranullah.shukoor AT serco DOT com via Backup Central.
|Forward SPAM to abuse AT backupcentral DOT com.
+----------------------------------------------------------------------

To sign off this list, send email to listserv AT listserv.temple DOT edu and 
type "signoff networker" in the body of the email. Please write to 
networker-request AT listserv.temple DOT edu if you have any problems with this 
list. You can access the archives at 
http://listserv.temple.edu/archives/networker.html or
via RSS at http://listserv.temple.edu/cgi-bin/wa?RSS&L=NETWORKER

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