Replication director - snapshot import failed (4213)

[Lumpi]

Hello

We use the Netbackup replication director for our netapps.

I have the following workflow:

snap of filer1 -> replicate to filer2 -> backup to tape

the snapshot and the replication works very well but the backup to tape gives me the error 4213 in one backup job.

12.12.2014 13:58:58 - Info nbjm(pid=3700) starting backup job (jobid=552328) for client filer0, policy filer0_swlib, schedule full-weekly  
12.12.2014 13:58:58 - estimated 0 Kbytes needed
12.12.2014 13:58:58 - begin Parent Job
12.12.2014 13:58:58 - begin Backup From Snapshot Mount, Start Notify Script
12.12.2014 13:58:58 - Info RUNCMD(pid=6372) started            
12.12.2014 13:58:58 - Info RUNCMD(pid=6372) exiting with status: 0         
Status 0
12.12.2014 13:58:58 - end Backup From Snapshot Mount, Start Notify Script; elapsed time: 0:00:00
12.12.2014 13:58:58 - begin Backup From Snapshot Mount, Read File List
Status 0
12.12.2014 13:58:58 - end Backup From Snapshot Mount, Read File List; elapsed time: 0:00:00
12.12.2014 13:58:58 - begin Backup From Snapshot Mount, Import Snapshot
12.12.2014 13:58:58 - Info RUNCMD(pid=4108) started            
12.12.2014 14:02:21 - Info RUNCMD(pid=4108) exiting with status: 4213         
Status 4213
12.12.2014 14:02:21 - end Backup From Snapshot Mount, Import Snapshot; elapsed time: 0:03:23
12.12.2014 14:02:21 - Info nbjm(pid=3700) ImportSnapshot failed, snapshotid=filer0_1418387544          
12.12.2014 14:02:21 - begin Backup From Snapshot Mount, Stop On Error
Status 0
12.12.2014 14:02:21 - end Backup From Snapshot Mount, Stop On Error; elapsed time: 0:00:00
12.12.2014 14:02:21 - begin Backup From Snapshot Mount, Unmount Snapshot
Status 4213
12.12.2014 14:02:21 - end Backup From Snapshot Mount, Unmount Snapshot; elapsed time: 0:00:00
12.12.2014 14:02:21 - begin Backup From Snapshot Mount, End Notify Script
12.12.2014 14:02:22 - Info RUNCMD(pid=7140) started            
12.12.2014 14:02:22 - Info RUNCMD(pid=7140) exiting with status: 0         
Status 0
12.12.2014 14:02:22 - end Backup From Snapshot Mount, End Notify Script; elapsed time: 0:00:01
Status 4213
12.12.2014 14:02:22 - end Parent Job; elapsed time: 0:03:24
Snapshot import failed(4213)

The NBUplugin has the following log entrires:

2014/12/12 13:42:36: ERROR       : 127.0.0.1: NDMP restore job with job-id: 2014/12/12 13:42:40: ERROR       : 10.1.2.112: Can't export. Reason: Invalid inputs to export the image
2014/12/12 13:44:05: INFORMATION : 10.1.2.112: Attempting to export image. Format NDMP
2014/12/12 13:52:24: ERROR       : 10.1.2.112: Can't export. Reason: Invalid inputs to export the image
2014/12/12 13:59:07: INFORMATION : 10.1.2.112: Attempting to export image. Format NDMP
2014/12/12 14:02:19: ERROR       : 10.1.2.112: Can't export. Reason: Invalid inputs to export the image
2014/12/12 14:09:06: INFORMATION : 10.1.2.112: Attempting to export image. Format NDMP
2014/12/12 14:12:15: ERROR       : 10.1.2.112: Can't export. Reason: Invalid inputs to export the image
2014/12/12 14:19:08: INFORMATION : 10.1.2.112: Attempting to export image. Format NDMP
2014/12/12 14:22:20: ERROR       : 10.1.2.112: Can't export. Reason: Invalid inputs to export the image

All other snapshots and replications are working.

What can be the problem. Where can I find better error messages?

My environment:

NBU Master: virtual (Windows 2008R2)

NBU Mediaserver: Appliance 5230

Netapp 8060 7-Mode

DFM with NBUPlugin 1.1

[INT_RND]

"A Backup From Snapshot operation must use a Snapshot operation as
its source."

I believe you would have to use "backup from snapshot" in place of the replicate step. Then you can use the duplicate function to copy that image to tape.

For more infromation please see the

Symantec NetBackup Replication Director 7.6 Solutions Guide:

http://www.symantec.com/business/support/index?page=content&id=DOC6465

(Starting at page 109)

[Lumpi]

Yes I use Backup from Snapshot but I get the error 4213.

1. Snapshot

2. Replication to filer 2

3. Backup from Snapshot of filer2

[INT_RND]

I'm saying that your problem is step 2.

Step 2 must be Backup from Snapshot NOT "2. Replication to filer 2"

[Lumpi]

My SLP is working with other policies! I only have a problem with 1 where i get this error.

I don't want to do a backup from snapshot of filer1! The backup should be done from a snapshot of filer 2 after the replication has finished. This is my backup filer. I don' want to have additional backup traffic from filer1!
 

I can see in the Netapp DFM that there is a second dataset of Netbackup with the same source and destination relationship. There is no backup left in this dataset. Will Netbackup do a cleanup of this unused data sets?

[Marcel123]

Hi I have exactly the same problems some policys worked very well but a lot of policy going wrong with the error. I think the Konfiguration is correct so this Kind of backup is described in the replication directory documentation. Is think the issue still exist we are using 7.6.1.1. Have you found a workaround ? Thanks for answer. RG Marcel

[Marcel123]

Hi I have exactly the same problems some policys worked very well but a lot of policy going wrong with the error. I think the Konfiguration is correct so this Kind of backup is described in the replication directory documentation. Is think the issue still exist we are using 7.6.1.1. Have you found a workaround ? Thanks for answer. RG Marcel

[Lumpi]

Hello

I have also upgraded to version 7.6.1.1. The problem ist still the same.

I have opend a call at netapp for this issue. Symantec said that this could be an issue in the replication director which is programmed by netapp. I will post the result of the call if I get one.

RG

[Lumpi]

Hello

I think the problem exist if you have a mixture of data in qtrees and in the root of the volume. If you enter the paths for the qtrees in you data selection it will work. In my case also the backup from snapshot was no problem. For the data in the root you can enter the path in this way /vol/thevolume/-

The only problem here is, that the backup will work but the restore will not work :)

Another interesting problem I have now is that I can restore the data of the qtrees (from the snapshot) but the restore job fails with error 2813. The files and folders are there and they are working but the restore job fails with the following error:

Any ideas?

----

11:01:12 07.04.2015: Restore Started

11:01:13 (603162.xxx) Found (5) files in (1) images for Restore Job ID 603162.xxx
11:01:13 (603162.xxx) Searched (2) files of (5) files for Restore Job ID 603162.xxx
11:01:13 (603162.001) Restoring from copy 1 of image created 02.04.2015 13:23:34 from policy filer0_volume1_it_sc_images
11:01:19 (603162.001) INF - Ignoring unrecognized option -connect_options
11:01:19 (603162.001) INF - Ignoring unrecognized option 0x01030202
11:01:19 (603162.001) INF - Selected Path /vol/volume1/it_sc_images, Copy 1, Fragment 1
11:01:19 (603162.001) INF - Selected Path /vol/volume1/jpsa_downloads, Copy 1, Fragment 2
11:01:19 (603162.001) INF - Selected Path /vol/volume1/qtree_cifs_thinapps, Copy 1, Fragment 3
11:01:19 (603162.001) INF - Selected Path /vol/volume1/qtree_ftp_secbackup, Copy 1, Fragment 4
11:01:19 (603162.001) INF - Selected Path /vol/volume1/-, Copy 1, Fragment 5
11:01:19 (603162.001) INF - Selected Path /vol/volume1/it_sc_images, Copy 1, Fragment 1
11:01:19 (603162.001) INF - Selected Path /vol/volume1/jpsa_downloads, Copy 1, Fragment 2
11:01:19 (603162.001) INF - Selected Path /vol/volume1/qtree_cifs_thinapps, Copy 1, Fragment 3
11:01:19 (603162.001) INF - Selected Path /vol/volume1/qtree_ftp_secbackup, Copy 1, Fragment 4
11:01:19 (603162.001) INF - Selected Path /vol/volume1/-, Copy 1, Fragment 5
11:01:19 (603162.001) INF - Connect to hostname=atrznbumaster.test.local, port=0, IPC="62984".
11:01:19 (603162.001) INF - Data socket to atrznbumaster.test.local is connected, fd 4
11:01:20 (603162.001) INF - /vol/volume1/qtree_cifs_thinapps/DMSW/Package.ini
11:01:21 (603162.001) INF - /vol/volume1/qtree_cifs_thinapps/DMSW/HKEY_USERS.txt
11:01:21 (603162.001) INF - /vol/volume1/qtree_cifs_thinapps/DMSW/HKEY_LOCAL_MACHINE.txt
11:01:21 (603162.001) INF - /vol/volume1/qtree_cifs_thinapps/DMSW/HKEY_CURRENT_USER.txt
11:01:21 (603162.001) INF - /vol/volume1/qtree_cifs_thinapps/DMSW/build.bat
11:01:21 (603162.001) INF - /vol/volume1/qtree_cifs_thinapps/DMSW/Support/
11:01:22 (603162.001) INF - Restoring Package.ini to /vol/volume1/IT-IS/Symantec_NB/DMSW_RESTORE1/
11:01:22 (603162.001) INF - Restoring HKEY_USERS.txt to /vol/volume1/IT-IS/Symantec_NB/DMSW_RESTORE1/
11:01:22 (603162.001) INF - Restoring HKEY_LOCAL_MACHINE.txt to /vol/volume1/IT-IS/Symantec_NB/DMSW_RESTORE1/
11:01:22 (603162.001) INF - Restoring HKEY_CURRENT_USER.txt to /vol/volume1/IT-IS/Symantec_NB/DMSW_RESTORE1/
11:01:22 (603162.001) INF - Restoring build.bat to /vol/volume1/IT-IS/Symantec_NB/DMSW_RESTORE1/
11:01:22 (603162.001) INF - Restoring Support to /vol/volume1/IT-IS/Symantec_NB/DMSW_RESTORE1/
11:01:22 (603162.001) INF - filer0.test.local: DUMP: Using Partial Volume Dump of selected subtrees
11:01:25 (603162.001) INF - filer0.test.local: DUMP: Date of this level 0 dump: Thu Apr  2 13:25:17 2015.
11:01:25 (603162.001) INF - filer0.test.local: DUMP: Date of last level 0 dump: the epoch.
11:01:25 (603162.001) INF - filer0.test.local: DUMP: Dumping /vol/volume1/.snapshot/NBU_filer0_1551462015_04_02_01_25_17/qtree_cifs_thinapps//DMSW to NDMP connection
11:01:25 (603162.001) INF - filer0.test.local: DUMP: mapping (Pass I)[regular files]
11:01:25 (603162.001) INF - filer0.test.local: DUMP: Reading file names from NDMP.
11:01:25 (603162.001) INF - filer0.test.local: DUMP: mapping (Pass II)[directories]
11:01:34 (603162.001) INF - filer0.test.local: DUMP: estimated 103 KB.
11:01:34 (603162.001) INF - filer0.test.local: DUMP: dumping (Pass III) [directories]
11:01:37 (603162.001) INF - filer0.test.local: DUMP: dumping (Pass IV) [regular files]
11:01:38 (603162.001) INF - filer0.test.local: ACL_START is '8497152'
11:01:39 (603162.001) INF - filer0.test.local: RESTORE: Tue Apr  7 11:01:39 2015: Writing data to files.
11:01:43 (603162.001) INF - filer0.test.local: RESTORE: RESTORE IS DONE
11:01:43 (603162.001) ERR -  filer0.test.local: DUMP: Write to socket failed
11:01:43 (603162.001) INF - filer0.test.local: DUMP: DUMP IS ABORTED
11:01:44 (603162.001) ERR -  filer0.test.local: DATA: Operation terminated: EVENT: ABORTED (for /vol/volume1/.snapshot/NBU_filer0_1551462015_04_02_01_25_17/qtree_cifs_thinapps//DMSW/)
11:01:44 (603162.001) ERR -  NDMP Copy failed, path = /vol/volume1/.snapshot/NBU_filer0_1551462015_04_02_01_25_17/qtree_cifs_thinapps/
11:01:44 (603162.001) INF - BPPFI RESTORED 0 FILES OR SUBTREES SUCCESSFULLY
11:01:44 (603162.001) INF - BPPFI KEPT 0 EXISTING FILES
11:01:44 (603162.001) INF - BPPFI KEPT 0 EXISTING DIRECTORIES
11:01:44 (603162.001) INF - BPPFI PARTIALLY RESTORED 6 FILES OR SUBTREES
11:01:44 (603162.001) INF - BPPFI EXITING WITH STATUS = 5
11:01:45 (603162.001) Status of restore from copy 1 of image created 02.04.2015 13:23:34 = the restore failed to recover the requested files
----

If I try to restore the data in the root I get the following error. No file or folder was restored:

---

11:28:23 07.04.2015: Restore Started

11:28:24 (603164.xxx) Found (5) files in (1) images for Restore Job ID 603164.xxx
11:28:25 (603164.xxx) Searched (2) files of (5) files for Restore Job ID 603164.xxx
11:28:25 (603164.001) Restoring from copy 1 of image created 02.04.2015 13:23:36 from policy filer_volume1_it_sc_images
11:28:31 (603164.001) INF - Ignoring unrecognized option -connect_options
11:28:31 (603164.001) INF - Ignoring unrecognized option 0x01030202
11:28:31 (603164.001) INF - Selected Path /vol/volume1/it_sc_images, Copy 1, Fragment 1
11:28:31 (603164.001) INF - Selected Path /vol/volume1/jpsa_downloads, Copy 1, Fragment 2
11:28:31 (603164.001) INF - Selected Path /vol/volume1/qtree_cifs_thinapps, Copy 1, Fragment 3
11:28:31 (603164.001) INF - Selected Path /vol/volume1/qtree_ftp_secbackup, Copy 1, Fragment 4
11:28:31 (603164.001) INF - Selected Path /vol/volume1/-, Copy 1, Fragment 5
11:28:31 (603164.001) INF - Selected Path /vol/volume1/it_sc_images, Copy 1, Fragment 1
11:28:31 (603164.001) INF - Selected Path /vol/volume1/jpsa_downloads, Copy 1, Fragment 2
11:28:31 (603164.001) INF - Selected Path /vol/volume1/qtree_cifs_thinapps, Copy 1, Fragment 3
11:28:31 (603164.001) INF - Selected Path /vol/volume1/qtree_ftp_secbackup, Copy 1, Fragment 4
11:28:31 (603164.001) INF - Selected Path /vol/volume1/-, Copy 1, Fragment 5
11:28:31 (603164.001) INF - Connect to hostname=atrznbumaster.test.local, port=0, IPC="63168".
11:28:32 (603164.001) INF - Data socket to atrznbumaster.test.local is connected, fd 4
11:28:33 (603164.001) INF - /vol/volume1/-/IT-IS/Symantec_NB/7_5_0_5/
11:28:34 (603164.001) INF - Restoring IT-IS/Symantec_NB/7_5_0_5 to /vol/volume1/
11:28:34 (603164.001) ERR -  filer.test.local: DATA: Operation terminated: backup configuration failure (2) on RPC error: ERROR: BAD ENV OP (for /vol/volume1/.snapshot/NBU_filer_1551462015_04_02_01_25_17/-//)
11:28:34 (603164.001) ERR -  NDMP Copy failed, path = /vol/volume1/.snapshot/NBU_filer_1551462015_04_02_01_25_17/-/
11:28:34 (603164.001) ERR -  filer.test.local: DATA: Operation terminated: NDMPD can not classify error (for volume1)
11:28:34 (603164.001) INF - BPPFI RESTORED 0 FILES OR SUBTREES SUCCESSFULLY
11:28:34 (603164.001) INF - BPPFI KEPT 0 EXISTING FILES
11:28:34 (603164.001) INF - BPPFI KEPT 0 EXISTING DIRECTORIES
11:28:34 (603164.001) INF - BPPFI PARTIALLY RESTORED 1 FILES OR SUBTREES
11:28:34 (603164.001) INF - BPPFI EXITING WITH STATUS = 5
11:28:35 (603164.001) Status of restore from copy 1 of image created 02.04.2015 13:23:36 = the restore failed to recover the requested files

11:28:36 (603164.xxx) INF - Status = NDMP policy restore error.

----

[Lumpi]

Hello

if you use only qtrees or volumes without qtrees it works.

[Marianne]

Thanks for sharing your solution. If you don't mind, please post a summary of the issue and (bit more detailed ) solution. I will gladly mark that post as Solution as it will help others with similar issues.