Problems with restoring VM
Hello!
I've a problem in restoring full VM.
I Use Restore from virtual machine backup, using SAN then NBD.
In restore wizzard I choose original location, Restore BIOS UUID, Overwrite existing VM and remove backing information for DVD/CDROM. All prerecovery check pass successfully.
In vCenter console I can see that netbackup creates my VM and try to restore it, but fails
There is some information in log:
7/31/2013 4:53:31 PM - begin Restore
7/31/2013 4:53:34 PM - restoring image NetBackupTest_1375255272
7/31/2013 4:53:41 PM - Info bprd(pid=4372) Restoring from copy 1 of image created 07/31/13 11:21:12
7/31/2013 4:53:41 PM - requesting resource @aaaab
7/31/2013 4:53:41 PM - granted resource MediaID=@aaaab;DiskVolume=E:\;DiskPool=Test_Pool;Path=E:\;StorageServer=sdc01ntbak;MediaServer=sdc01ntbak
7/31/2013 4:53:44 PM - Info bpdm(pid=1764) started
7/31/2013 4:53:44 PM - started process bpdm (1764)
7/31/2013 4:53:45 PM - Info bpdm(pid=1764) reading backup image
7/31/2013 4:53:45 PM - Info bpdm(pid=1764) requesting nbjm for media
7/31/2013 4:53:45 PM - Info bpdm(pid=1764) using 30 data buffers
7/31/2013 4:53:45 PM - Info bpdm(pid=1764) spawning a child process
7/31/2013 4:53:45 PM - Info bpbrm(pid=1764) child pid: 3540
7/31/2013 4:53:45 PM - Info bpdm(pid=3540) started
7/31/2013 4:53:45 PM - started process bpdm (3540)
7/31/2013 4:53:48 PM - begin reading
7/31/2013 4:53:48 PM - end reading; read time: 00:00:00
7/31/2013 4:53:48 PM - Info bpdm(pid=1764) completed reading backup image
7/31/2013 4:54:19 PM - requesting resource @aaaab
7/31/2013 4:54:19 PM - granted resource MediaID=@aaaab;DiskVolume=E:\;DiskPool=Test_Pool;Path=E:\;StorageServer=sdc01ntbak;MediaServer=sdc01ntbak
7/31/2013 4:54:22 PM - Info bpbrm(pid=4376) sdc01-pintbak05.dc-prod.tn.corp is the host to restore to
7/31/2013 4:54:22 PM - Info bpbrm(pid=4376) reading file list from client
7/31/2013 4:54:22 PM - connecting
7/31/2013 4:54:22 PM - Info bpbrm(pid=4376) starting bptm
7/31/2013 4:54:24 PM - Info tar32(pid=1796) Restore started
7/31/2013 4:54:24 PM - connected; connect time: 00:00:02
7/31/2013 4:54:24 PM - Info bptm(pid=1620) start
7/31/2013 4:54:24 PM - started process bptm (1620)
7/31/2013 4:54:25 PM - Info bpdm(pid=1620) reading backup image
7/31/2013 4:54:25 PM - Info bptm(pid=1620) using 30 data buffers
7/31/2013 4:54:25 PM - Info bptm(pid=1620) spawning a child process
7/31/2013 4:54:25 PM - Info bptm(pid=1620) child pid: 4192
7/31/2013 4:54:25 PM - Info bptm(pid=4192) start
7/31/2013 4:54:25 PM - started process bptm (4192)
7/31/2013 4:54:28 PM - begin reading
7/31/2013 4:56:40 PM - Critical bpbrm(pid=4376) from client sdc01ntbak: FTL - Virtual machine restore: file write failed
7/31/2013 4:56:40 PM - Critical bpbrm(pid=4376) from client sdc01ntbak: FTL - Virtual machine restore: file write failed
7/31/2013 4:57:04 PM - Info tar32(pid=1796) done. status 5
7/31/2013 4:57:05 PM - Info bptm(pid=1620) EXITING with status 24 <----------
7/31/2013 4:57:05 PM - Info tar32(pid=1796) done. status: 185
7/31/2013 4:57:05 PM - Info tar32(pid=1796) done. status: 24: socket write failed
7/31/2013 4:57:05 PM - Error bpbrm(pid=4376) client restore EXIT STATUS 24: socket write failed
7/31/2013 4:58:18 PM - restored image NetBackupTest_1375255272 - (the restore failed to recover the requested files(5)); restore time 00:04:44
7/31/2013 4:58:22 PM - end Restore; elapsed time: 00:04:51
VMware policy restore error(2820)
Netbackup version is 7.5.0.6
Can You help with it?
Thanks.
Don't use SAN to restore... use NBD. NBU might not have access to write to the Datastore (only read).

