VMware Cloud Community
ncrose
Contributor
Contributor

VCB + vRanger Pro Backup error

I have been running VCB backups combined with Ranger for a while now. All of my VMs were backing up just fine but for some reason lately, one of my larger VMs seems to be getting an error, deleteing the backups it has already completed. I can't seem to make heads or tails of the log files so I will attach both the vRanger and the vcb log.

Vcb 1.1 Log about the error:

Status: Converting "D:\Week Ending 4-25-2008\Bb 6\scsi0-1-0-Bb_3.vmdk" (flat file): 0%=====================50%=====================100% |#|p Status: [%1 ' Status: 2008-04-22 03:17:47.890 Status: ' Status: ' Status: blocklist Status: ' %1 %2] Status: %1 %2] Status: 3432 Status: %2] Status: error Status: ] Status: Status: Could not renew disk lease. Aborting operation. Status: [%1 ' Status: 2008-04-22 03:17:47.984 Status: ' Status: ' Status: BlockList Status: ' %1 %2] Status: %1 %2] Status: 1080 Status: %2] Status: error Status: ] Status: Status: [%1 ' Status: 2008-04-22 03:19:47.796 Status: ' Status: ' Status: BlockList Status: ' %1 %2] Status: %1 %2] Status: 1080 Status: %2] Status: error Status: ] Status: Status: The managed object of type "vim.host.DiskManager.Lease" identified by the MoRef "session[638A8F18-6EFF-40A5-9302-C77962568D91]2E97BB55-2BEE-4A1B-9136-5553E15D9CDD" could not be found. Status: [%1 ' Status: 2008-04-22 03:21:47.655 Status: ' Status: ' Status: vcbMounter Status: ' %1 %2] Status: %1 %2] Status: 1080 Status: %2] Status: error Status: ] Status: Status: Error: %1 Status: rror: %1 Status: ror: %1 Status: or: %1 Status: r: %1 Status: : %1 Status: %1 Status: Failed to export the disk: I/O Operation failed Status: [%1 ' Status: 2008-04-22 03:21:47.655 Status: ' Status: ' Status: vcbMounter Status: ' %1 %2] Status: %1 %2] Status: 1080 Status: %2] Status: error Status: ] Status: Status: An error occurred, cleaning up... Status: [%1 ' Status: 2008-04-22 03:23:48.140 Status: ' Status: ' Status: BaseLibs Status: ' %1 %2] Status: %1 %2] Status: 3424 Status: %2] Status: warning Status: ] Status: Status: SSLVerifyCertAgainstSystemStore: Subject mismatch: VMware vs 160.149.4.68 Status: [%1 ' Status: 2008-04-22 03:23:48.140 Status: ' Status: ' Status: BaseLibs Status: ' %1 %2] Status: %1 %2] Status: 3424 Status: %2] Status: warning Status: ] Status: Status: [%1 ' Status: 2008-04-22 03:23:48.140 Status: ' Status: ' Status: BaseLibs Status: ' %1 %2] Status: %1 %2] Status: 3424 Status: %2] Status: warning Status: ] Status: Status: SSLVerifyIsEnabled: failed to read registry value. Assuming verification is disabled. LastError = 0 Status: [%1 ' Status: 2008-04-22 03:23:48.140 Status: ' Status: ' Status: BaseLibs Status: ' %1 %2] Status: %1 %2] Status: 3424 Status: %2] Status: warning Status: ] Status: Status: SSLVerifyCertAgainstSystemStore: Certificate verification is disabled, so connection will proceed despite the error Status: [%1 ' Status: 2008-04-22 03:46:57.843 Status: ' Status: ' Modifying VM Configuration For Backup. Cleaning Up After Backup. Determining Backup Statistics. Writing Backup Information. </LogText><End>0001-01-01T00:00:00</End><Start>2008-04-21T11:25:13.2302841-05:00</Start><Error>Error</Error><BackupList><EsxFile><BackupSkip>false</BackupSkip><Type>DiskStub</Type><Name>Bb.vmdk</Name><Size>334</Size><Directory>/vmfs/volumes/SP Base/Bb_1/</Directory></EsxFile><EsxFile><BackupSkip>false</BackupSkip><Type>DiskStub</Type><Name>Bb-flat.vmdk</Name><Size>21474836480</Size><Directory>/vmfs/volumes/SP Base/Bb_1/</Directory></EsxFile><EsxFile><BackupSkip>false</BackupSkip><Type>DiskStub</Type><Name>Bb_3.vmdk</Name><Size>340</Size><Directory>/vmfs/volumes/SP Base/Bb_1/</Directory></EsxFile><EsxFile><BackupSkip>false</BackupSkip><Type>DiskStub</Type><Name>Bb_3-flat.vmdk</Name><Size>858993459200</Size><Directory>/vmfs/volumes/SP Base/Bb_1/</Directory></EsxFile></BackupList><VmConfigPath>/vmfs/volumes/SP Base/Bb 6.3_1/Bb 6.3.vmx</VmConfigPath><VmName>Bb 6.3</VmName><ConfigFile>#!/usr/bin/vmware config.version = "8" virtualHW.version = "4" floppy0.present = "true" nvram = "Bb 6.3.nvram" powerType.powerOff = "default" powerType.powerOn = "default" powerType.suspend = "default" powerType.reset = Ădefault" displayName = "Bb 6.3" extendedConfigFile = "Bb 6.3.vmxf" numvcpus = "4" scsi0.present = "true" scsi0.sharedBus = "none" scsi0.virtualDev = "lsilogic" memsize = "6000" scsi0:0.present = "true" scsi0:0.fileName = "/vmfs/volumes/45faaf05-588d9e9a-b8c1-00145e3fafac/Bb_1/Bb.vmdk" scsi0:0.deviceType = "scsi-hardDisk" ide0:0.present = "true" ide0:0.clientDevice = "true" ide0:0.deviceType = "cdrom-raw" ide0:0.startConnected = "false" floppy0.startConnected = "false" floppy0.clientDevice = "true" ethernet0.present = "true" ethernet0.allowGuestConnectionControl = "false" ethernet0.networkName = "RDMZ Network" ethernet0.addressType = "vpx" ethernet0.generatedAddress = "00:50:56:83:33:4e" guestOS = "winnetenterprise" uuid.bios = "50 03 e1 e0 3e c1 1b e2-7a f8 ed 83 bb b3 bd 0b" toolScripts.afterPowerOn = "true" toolScripts.afterResume = "true" toolScripts.beforeSuspend = "true" toolScripts.beforePowerOff = "true" scsi0:1.present = "true" scsi0:1.fileName = "/vmfs/volumes/45faaf05-588d9e9a-b8c1-00145e3fafac/Bb_1/Bb_3.vmdk" scsi0:1.deviceType = "scsi-hardDisk" floppy0.fileName = "/dev/fd0" sched.cpu.min = "0" sched.cpu.units = "mhz" sched.cpu.shares = "normal" sched.mem.minsize = "0" sched.mem.max = "unlimited" sched.mem.shares = "normal" scsi0:0.redo = "" scsi0:1.redo = "" uuid.location = "56 4d 97 c5 91 de 45 35-cb 33 e7 d8 2a 49 d9 03" sched.swap.derivedName = "/vmfs/volumes/45faaf05-588d9e9a-b8c1-00145e3fafac/Bb 6.3_1/Bb 6.3-34108008.vswp" tools.syncTime = "FALSE" migrate.hostlog = "./Bb 6.3-34108008.hlog"</ConfigFile><CompressStartTime>2008-04-21T11:25:13.3709091-05:00</CompressStartTime><CompressEndTime>2008-04-22T03:47:01.2184991-05:00</CompressEndTime><ArchiveSize>0</ArchiveSize><EndingHost /><BackupCompressionType>Gzip</BackupCompressionType></BackupInformation> And the vRanger Pro Error: 4/21/2008 11:42:24 AM: Converting "D:\Week Ending 4-25-2008\Bb 6\scsi0-1-0-Bb_3.vmdk" (flat file): 0%=====================50%=====================100% |#|p 4/22/2008 3:17:47 AM: [%1 ' 4/22/2008 3:17:48 AM: 2008-04-22 03:17:47.890 4/22/2008 3:17:49 AM: ' 4/22/2008 3:17:50 AM: ' 4/22/2008 3:17:51 AM: blocklist 4/22/2008 3:17:52 AM: ' %1 %2] 4/22/2008 3:17:53 AM: %1 %2] 4/22/2008 3:17:54 AM: 3432 4/22/2008 3:17:55 AM: %2] 4/22/2008 3:17:56 AM: error 4/22/2008 3:17:57 AM: ] 4/22/2008 3:17:58 AM: 4/22/2008 3:17:59 AM: Could not renew disk lease. Aborting operation. 4/22/2008 3:18:00 AM: [%1 ' 4/22/2008 3:18:01 AM: 2008-04-22 03:17:47.984 4/22/2008 3:18:02 AM: ' 4/22/2008 3:18:03 AM: ' 4/22/2008 3:18:04 AM: BlockList 4/22/2008 3:18:05 AM: ' %1 %2] 4/22/2008 3:18:06 AM: %1 %2] 4/22/2008 3:18:07 AM: 1080 4/22/2008 3:18:08 AM: %2] 4/22/2008 3:18:09 AM: error 4/22/2008 3:18:10 AM: ] 4/22/2008 3:18:11 AM: 4/22/2008 3:19:47 AM: [%1 ' 4/22/2008 3:19:48 AM: 2008-04-22 03:19:47.796 4/22/2008 3:19:49 AM: ' 4/22/2008 3:19:50 AM: ' 4/22/2008 3:19:51 AM: BlockList 4/22/2008 3:19:52 AM: ' %1 %2] 4/22/2008 3:19:53 AM: %1 %2] 4/22/2008 3:19:54 AM: 1080 4/22/2008 3:19:55 AM: %2] 4/22/2008 3:19:56 AM: error 4/22/2008 3:19:57 AM: ] 4/22/2008 3:19:58 AM: 4/22/2008 3:19:59 AM: The managed object of type "vim.host.DiskManager.Lease" identified by the MoRef "session[638A8F18-6EFF-40A5-9302-C77962568D91]2E97BB55-2BEE-4A1B-9136-5553E15D9CDD" could not be found. 4/22/2008 3:21:47 AM: [%1 ' 4/22/2008 3:21:48 AM: 2008-04-22 03:21:47.655 4/22/2008 3:21:49 AM: ' 4/22/2008 3:21:50 AM: ' 4/22/2008 3:21:51 AM: vcbMounter 4/22/2008 3:21:52 AM: ' %1 %2] 4/22/2008 3:21:53 AM: %1 %2] 4/22/2008 3:21:54 AM: 1080 4/22/2008 3:21:55 AM: %2] 4/22/2008 3:21:56 AM: error 4/22/2008 3:21:57 AM: ] 4/22/2008 3:21:58 AM: 4/22/2008 3:21:59 AM: Error: %1 4/22/2008 3:22:00 AM: rror: %1 4/22/2008 3:22:01 AM: ror: %1 4/22/2008 3:22:02 AM: or: %1 4/22/2008 3:22:03 AM: r: %1 4/22/2008 3:22:04 AM: : %1 4/22/2008 3:22:05 AM: %1 4/22/2008 3:22:06 AM: Failed to export the disk: I/O Operation failed 4/22/2008 3:22:07 AM: [%1 ' 4/22/2008 3:22:08 AM: 2008-04-22 03:21:47.655 4/22/2008 3:22:09 AM: ' 4/22/2008 3:22:10 AM: ' 4/22/2008 3:22:11 AM: vcbMounter 4/22/2008 3:22:12 AM: ' %1 %2] 4/22/2008 3:22:13 AM: %1 %2] 4/22/2008 3:22:14 AM: 1080 4/22/2008 3:22:15 AM: %2] 4/22/2008 3:22:16 AM: error 4/22/2008 3:22:17 AM: ] 4/22/2008 3:22:18 AM: 4/22/2008 3:22:19 AM: An error occurred, cleaning up... 4/22/2008 3:23:48 AM: [%1 ' 4/22/2008 3:23:49 AM: 2008-04-22 03:23:48.140 4/22/2008 3:23:50 AM: ' 4/22/2008 3:23:51 AM: ' 4/22/2008 3:23:52 AM: BaseLibs 4/22/2008 3:23:53 AM: ' %1 %2] 4/22/2008 3:23:54 AM: %1 %2] 4/22/2008 3:23:55 AM: 3424 4/22/2008 3:23:56 AM: %2] 4/22/2008 3:23:57 AM: warning 4/22/2008 3:23:58 AM: ] 4/22/2008 3:23:59 AM: 4/22/2008 3:24:00 AM: SSLVerifyCertAgainstSystemStore: Subject mismatch: VMware vs 160.149.4.68 4/22/2008 3:24:01 AM: [%1 ' 4/22/2008 3:24:02 AM: 2008-04-22 03:23:48.140 4/22/2008 3:24:03 AM: ' 4/22/2008 3:24:04 AM: ' 4/22/2008 3:24:05 AM: BaseLibs 4/22/2008 3:24:06 AM: ' %1 %2] 4/22/2008 3:24:07 AM: %1 %2] 4/22/2008 3:24:08 AM: 3424 4/22/2008 3:24:09 AM: %2] 4/22/2008 3:24:10 AM: warning 4/22/2008 3:24:11 AM: ] 4/22/2008 3:24:12 AM: 4/22/2008 3:24:13 AM: [%1 ' 4/22/2008 3:24:14 AM: 2008-04-22 03:23:48.140 4/22/2008 3:24:15 AM: ' 4/22/2008 3:24:16 AM: ' 4/22/2008 3:24:17 AM: BaseLibs 4/22/2008 3:24:18 AM: ' %1 %2] 4/22/2008 3:24:19 AM: %1 %2] 4/22/2008 3:24:20 AM: 3424 4/22/2008 3:24:21 AM: %2] 4/22/2008 3:24:22 AM: warning 4/22/2008 3:24:23 AM: ] 4/22/2008 3:24:24 AM: 4/22/2008 3:24:25 AM: SSLVerifyIsEnabled: failed to read registry value. Assuming verification is disabled. LastError = 0 4/22/2008 3:24:26 AM: [%1 ' 4/22/2008 3:24:27 AM: 2008-04-22 03:23:48.140 4/22/2008 3:24:28 AM: ' 4/22/2008 3:24:29 AM: ' 4/22/2008 3:24:30 AM: BaseLibs 4/22/2008 3:24:31 AM: ' %1 %2] 4/22/2008 3:24:32 AM: %1 %2] 4/22/2008 3:24:33 AM: 3424 4/22/2008 3:24:34 AM: %2] 4/22/2008 3:24:35 AM: warning 4/22/2008 3:24:36 AM: ] 4/22/2008 3:24:37 AM: 4/22/2008 3:24:38 AM: SSLVerifyCertAgainstSystemStore: Certificate verification is disabled, so connection will proceed despite the error 4/22/2008 3:46:57 AM: [%1 ' 4/22/2008 3:46:58 AM: 2008-04-22 03:46:57.843 4/22/2008 3:46:59 AM: ' 4/22/2008 3:47:00 AM: ' Task Finished OK. 4/22/2008 3:47:01 AM: Modifying VM Configuration For Backup.: Task Finished OK. 4/22/2008 3:47:01 AM: Cleaning Up After Backup.: 4/22/2008 3:47:01 AM: Error Performing Task Cleaning Up After Backup.. Error: No VMDK Files Found at Destination Path 'D:\Week Ending 4-25-2008\Bb 6' Errors Encountered. 4/22/2008 3:47:01 AM: Determining Backup Statistics.: Task Finished OK. 4/22/2008 3:47:01 AM: Writing Backup Information.: Task Finished OK. 4/22/2008 3:47:03 AM: Writing Backup Information to the Database.: Task Finished OK. 4/22/2008 3:47:05 AM: Disconnecting Open Connections. 4/22/2008 3:47:05 AM: Waiting for Disconnection. 4/22/2008 3:47:06 AM: Done. 4/22/2008 3:47:06 AM: Disconnection Sequence Complete. Pausing for 30 seconds... You can safely close this window now. Any Help is greatly appreciated...or just drop in a support ticket?

0 Kudos
0 Replies