Error 2817 on VM Restore to ESX

[HEMANPR]

Hello People:

Im trying to restore a VM FlashBackup-Windows Backup to a ESX Server. I select all the option on the restore wizard and the job starting fine. But the job failed with statud 2817 Here the Details:

7/22/2011 3:48:36 PM - begin Restore
7/22/2011 3:48:41 PM - restoring image server_1310900560
7/22/2011 3:48:41 PM - requesting resource @aaab3
7/22/2011 3:48:41 PM - granted resource MediaID=@Disk;DiskVolume=DiskVolume;DiskPool=DiskPool;Path=DiskPath;StorageServer=Storage;MediaServer...

7/22/2011 3:48:48 PM - Info bpdm(pid=12236) started           
7/22/2011 3:48:48 PM - started process bpdm (12236)
7/22/2011 3:48:48 PM - Info bpdm(pid=12236) reading backup image         
7/22/2011 3:48:49 PM - Info bpdm(pid=12236) requesting nbjm for media        
7/22/2011 3:48:49 PM - Info bpdm(pid=12236) using 32 data buffers        
7/22/2011 3:48:49 PM - Info bpdm(pid=12236) spawning a child process        
7/22/2011 3:48:49 PM - Info bpbrm(pid=12236) child pid: 6124         
7/22/2011 3:48:49 PM - Info bpdm(pid=6124) started           
7/22/2011 3:48:49 PM - started process bpdm (6124)
7/22/2011 3:48:50 PM - begin reading
7/22/2011 3:48:53 PM - end reading; read time: 00:00:03
7/22/2011 3:48:55 PM - Info bpdm(pid=12236) completed reading backup image        
7/22/2011 3:48:55 PM - Info bpdm(pid=12236) EXITING with status 0        
7/22/2011 3:55:08 PM - end Restore; elapsed time: 00:06:32
FlashBackup-Windows policy restore error(2817)

I try to restore using san and all types transfer mode, Same error.

Any help are welcome.

[Marianne]

Have you seen these TN's?

http://www.symantec.com/docs/HOWTO44491   

http://www.symantec.com/docs/HOWTO51780   

[HEMANPR]

Look the error log bpbrm:

10:52:27.963 [6340.2808] <2> bpbrm main: from client MASTER: INF - Open File Backup license is not installed on the server.  Open File Backup usage will be disabled.

Open File Backup is available just with the Ent License Then Why I have this error???

[pikachu]

On the backup create the vmcloglevel dword and set it to 3. Create the bpvmutil log folder and re-run the restore.

Also make sure you have the latest vmware rollup patch installed for your version of NBU.

[Stormchaser]

Hi pikachu

Sorry for my question. Did this patches come from Symantec or from VMWare ?

Did there exist any list of recommendations for 7.0.1 and ESXi 4.1 ?

The Rollup NB_7.0.1_ET2105102_5 for 7.0.1 was applied. 

Thanks

Thomas

[pikachu]

Did this patches come from Symantec or from VMWare ?

=> Symantec

Did there exist any list of recommendations for 7.0.1 and ESXi 4.1 ?

=> In what regard?

The Rollup NB_7.0.1_ET2105102_5 for 7.0.1 was applied. 

=> The highest one is 14.

Did you have a chance to get the bpvmutil log yet?

[Stormchaser]

Hi pikachu

I've set the loglevel to 3 and restarted the services, but there will be no change for bpvmutil. All entries are from Backup-Jobs. 

What about this Rollup. This "14" is it a Part of it or a Follow-Up ?

Kind regards

Thomas

[pikachu]

Restarting nbu is not necessary for bpvmutil, because it is a legacy service and it will only be called if needed aka dynamic.

I am pretty sure the issue will be in the bpvmutil log file. You can setup vxms logging, however I do not think it even gets that far. Get me the log and I will try to help.

[monty_222]

1/16/2012 11:11:08 AM - begin Restore

1/16/2012 11:11:21 AM - media 300014 required

1/16/2012 11:11:21 AM - restoring image INV23ODS01_1320851118

1/16/2012 11:11:35 AM - Info bptm(pid=6100) start            

1/16/2012 11:11:35 AM - started process bptm (6100)

1/16/2012 11:11:35 AM - Info bpdm(pid=6100) reading backup image          

1/16/2012 11:11:35 AM - Info bptm(pid=6100) using 30 data buffers         

1/16/2012 11:11:35 AM - Info bptm(pid=6100) spawning a child process         

1/16/2012 11:11:35 AM - Info bptm(pid=6100) child pid: 6424          

1/16/2012 11:11:36 AM - Info bptm(pid=6424) start            

1/16/2012 11:11:36 AM - started process bptm (6424)

1/16/2012 11:11:37 AM - Info bptm(pid=6100) Waiting for mount of media id 300014 (copy 1) on server in2kbu01. 

1/16/2012 11:11:37 AM - started process bptm (6100)

1/16/2012 11:11:37 AM - mounting 300014

1/16/2012 11:11:37 AM - requesting resource 300014

1/16/2012 11:11:37 AM - granted resource 300014

1/16/2012 11:11:37 AM - granted resource IBM.ULTRIUM-TD3.000

1/16/2012 11:11:38 AM - Info bptm(pid=6100) INF - Waiting for mount of media id 300014 on server in2kbu01 for reading.

1/16/2012 11:12:14 AM - mounted; mount time: 00:00:37

1/16/2012 11:12:14 AM - Info bptm(pid=6100) 300014            

1/16/2012 11:12:15 AM - Info bptm(pid=6100) INF - Waiting for positioning of media id 300014 on server in2kbu01 for reading.

1/16/2012 11:12:15 AM - positioning 300014 to file 25

1/16/2012 11:13:30 AM - positioned 300014; position time: 00:01:15

1/16/2012 11:13:32 AM - begin reading

1/16/2012 11:14:43 AM - Info bptm(pid=6100) waited for empty buffer 1 times, delayed 18 times    

1/16/2012 11:14:43 AM - end reading; read time: 00:01:11

1/16/2012 11:14:43 AM - Info bptm(pid=6100) completed reading backup image         

1/16/2012 11:14:43 AM - Info bptm(pid=6100) EXITING with status 0 <----------        

1/16/2012 11:14:59 AM - end Restore; elapsed time: 00:03:51

FlashBackup-Windows policy restore error(2817)