Highlighted

VMware backup jobs stuck in 'Begin Writing'

Moved to new post from https://vox.veritas.com/t5/NetBackup/VMware-backup-jobs-stuck-in-quot-Begin-Writing-quot-after/m-p/7...


@Kristalia wrote:

no. I changed the ownwership of the case and with the new engineer, we are collecting logs. i will let you know if anything helps.

Hi

Could you please share the solution as we are also facing similar issue in our environment

Here is the backup job details ,

10/06/2017 00:38:53 - Info nbjm (pid=10944) starting backup job (jobid=1040671) for client BDC1RBMOVICAP09, policy special_BDC1RBMOVICAP09, schedule FULL
10/06/2017 00:38:53 - estimated 0 kbytes needed
10/06/2017 00:38:53 - Info nbjm (pid=10944) started backup (backupid=BDC1RBMOVICAP09_1507268333) job for client BDC1RBMOVICAP09, policy special_BDC1RBMOVICAP09, schedule FULL on storage unit stu_disk_nb5230-302 using backup host nb5230-302
10/06/2017 00:38:53 - started process bpbrm (pid=190039)
10/06/2017 00:38:54 - connecting
10/06/2017 00:38:54 - connected; connect time: 0:00:00
10/06/2017 00:38:58 - Info bpbrm (pid=190039) BDC1RBMOVICAP09 is the host to backup data from
10/06/2017 00:38:58 - Info bpbrm (pid=190039) reading file list for client
10/06/2017 00:38:59 - Info bpbrm (pid=190039) starting bpbkar on client
10/06/2017 00:38:59 - Info bpbkar (pid=190056) Backup started
10/06/2017 00:38:59 - Info bpbrm (pid=190039) bptm pid: 190057
10/06/2017 00:39:00 - Info bptm (pid=190057) start
10/06/2017 00:39:01 - Info bptm (pid=190057) using 262144 data buffer size
10/06/2017 00:39:01 - Info bptm (pid=190057) using 32 data buffers
10/06/2017 00:39:02 - Info bptm (pid=190057) start backup
10/06/2017 00:39:02 - begin writing
10/06/2017 00:39:03 - Info bpbkar (pid=190056) INF - Backing up vCenter server bdc1wfisnexvc01, ESX host bdc1efisnexvh99.fnfis.com, BIOS UUID 420a2369-d9c7-79de-da5a-081cd203818a, Instance UUID 500ab771-23fa-1a11-5442-9078ea0ad823, Display Name BDC1RBMOVICAP09, Hostname oos0a.prod-rids.bmo.com
10/06/2017 01:08:21 - Info bpbkar (pid=190056) INF - Transport Type =  nbd

 

 Snapshot job ,

10/06/2017 00:34:22 - Info nbjm (pid=10944) starting backup job (jobid=1040667) for client BDC1RBMOVICAP09, policy special_BDC1RBMOVICAP09, schedule FULL
10/06/2017 00:34:22 - Info nbjm (pid=10944) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=1040667, request id:{01F3FA2E-AA58-11E7-B015-CF2B0D0319CD})
10/06/2017 00:34:22 - requesting resource stu_disk_nb5230-302
10/06/2017 00:34:22 - requesting resource lbdocnbmas-01.NBU_CLIENT.MAXJOBS.BDC1RBMOVICAP09
10/06/2017 00:34:22 - requesting resource lbdocnbmas-01.NBU_POLICY.MAXJOBS.special_BDC1RBMOVICAP09
10/06/2017 00:34:23 - granted resource  lbdocnbmas-01.NBU_CLIENT.MAXJOBS.BDC1RBMOVICAP09
10/06/2017 00:34:23 - granted resource  lbdocnbmas-01.NBU_POLICY.MAXJOBS.special_BDC1RBMOVICAP09
10/06/2017 00:34:23 - granted resource  MediaID=@aaaal;DiskVolume=PureDiskVolume;DiskPool=dp_disk_nb5230-302;Path=PureDiskVolume;StorageServer=nb5230-302;MediaServer=nb5230-302
10/06/2017 00:34:23 - granted resource  stu_disk_nb5230-302
10/06/2017 00:34:23 - estimated 0 kbytes needed
10/06/2017 00:34:23 - begin Parent Job
10/06/2017 00:34:23 - begin VMware: Start Notify Script
10/06/2017 00:34:23 - Info RUNCMD (pid=28407) started
10/06/2017 00:34:23 - Info RUNCMD (pid=28407) exiting with status: 0
Operation Status: 0
10/06/2017 00:34:23 - end VMware: Start Notify Script; elapsed time 0:00:00
10/06/2017 00:34:23 - begin VMware: Step By Condition
Operation Status: 0
10/06/2017 00:34:23 - end VMware: Step By Condition; elapsed time 0:00:00
10/06/2017 00:34:23 - begin VMware: Read File List
Operation Status: 0
10/06/2017 00:34:23 - end VMware: Read File List; elapsed time 0:00:00
10/06/2017 00:34:23 - begin VMware: Create Snapshot
10/06/2017 00:34:24 - started process bpbrm (pid=188634)
10/06/2017 00:34:29 - Info bpbrm (pid=188634) BDC1RBMOVICAP09 is the host to backup data from
10/06/2017 00:34:29 - Info bpbrm (pid=188634) reading file list for client
10/06/2017 00:34:29 - Info bpbrm (pid=188634) start bpfis on client
10/06/2017 00:34:30 - Info bpbrm (pid=188634) Starting create snapshot processing
10/06/2017 00:34:30 - Info bpfis (pid=188653) Backup started
10/06/2017 00:34:31 - snapshot backup of client BDC1RBMOVICAP09 using method VMware_v2
10/06/2017 00:38:52 - end writing
Operation Status: 0
10/06/2017 00:38:52 - end Parent Job; elapsed time 0:04:29
10/06/2017 00:38:52 - Info nbjm (pid=10944) snapshotid=BDC1RBMOVICAP09_1507268063
10/06/2017 00:38:52 - begin VMware: Policy Execution Manager Preprocessed
10/06/2017 00:38:57 - end VMware: Create Snapshot; elapsed time 0:04:34
10/06/2017 00:38:57 - Info bpfis (pid=188653) done. status: 0
10/06/2017 00:38:57 - Info bpfis (pid=188653) done. status: 0: the requested operation was successfully completed

 


 

Tags (2)
4 Replies

Re: VMware backup jobs stuck in 'Begin Writing'

@adiharini it seems that @Kristalia has not posted anything in the last 2 years and has not replied to a request for an update to the post that you have found.

Best to share detailed information about your environment - 
Current NBU version
VMware version
Backup host details
bpbkar log on backup host for PID 190056.

Re: VMware backup jobs stuck in 'Begin Writing'

Hi Marianne

Thanks for your response . Here is the information

Current NBU version  - NBU 7.7.3
VMware version  -  vSphere 6.0 update 3
Backup host details  -  vmx-08           rhel6_64Guest              BDC1RBMOVICAP09
bpbkar log on backup host for PID 190056

I dont have access to the client network to check bpbkar logs , however we have opened a case with Veritas and they pulled all the logs needed and they are doing analysis , with veritas recomendations we have initiated backup again but its been 4 hours not showing any progress .

RE: 22359539:VADP backup getting hang ( Veritas Case)

 

Re: VMware backup jobs stuck in 'Begin Writing'

Re: VMware backup jobs stuck in 'Begin Writing'

Hi,

Would be possible you attached VxMS and BPFIS logs? Another think, are you using NBU appliance 5230 as VMware backup Host? If yes, whats NBU version? Also 7.7.3 (2.7.3)?

 

 

Thiago