Hi i have VMWorkstation 10 with win 7 installed .
my goal is to run tests on the machine on each night ,each test lasts 5 minute max , after each test i revert to the same "clean" snapshot
on the last run the machine is faild to revert snapshot beacuse :
SnapshotVMXRevertToSnapshot: Couldn't revert to snapshot at power off: The process cannot access the file because it is being used by another process.
here is the log of the specific time : (I didnt copy all )
2016-07-14T15:56:37.830+03:00| vmx| I120: Vix: [9192 vmxCommands.c:351]: VMAutomation_InitiatePowerOff
2016-07-14T15:56:37.830+03:00| vmx| I120: Vix: [9192 vmxCommands.c:472]: VMAutomation_InitiatePowerOffImpl: going to revert to snapshot uid 68 upon poweroff
2016-07-14T15:56:37.830+03:00| vmx| I120: Vix: [9192 vmxCommands.c:551]: VMAutomation_InitiatePowerOff. Trying hard powerOff
2016-07-14T15:56:37.830+03:00| vmx| W110:
2016-07-14T15:56:37.830+03:00| vmx| W110+
2016-07-14T15:56:37.830+03:00| vmx| W110+ VMXRequestRevert
2016-07-14T15:56:37.830+03:00| vmx| I120: Stopping VCPU threads...
2016-07-14T15:56:37.830+03:00| svga| I120: SVGA thread is exiting
2016-07-14T15:56:38.469+03:00| mks| I120: GDI-Backend: stopped by HWinMux to do window composition.
2016-07-14T15:56:38.469+03:00| mks| I120: MKS-SWB: Number of MKSWindows changed: 0 rendering MKSWindow(s) of total 0.
2016-07-14T15:56:38.469+03:00| vmx| I120: USB: Disconnecting device 0x400000050e0f0003
2016-07-14T15:56:38.469+03:00| vmx| I120:
2016-07-14T15:56:38.469+03:00| vmx| I120+ OvhdMem: Final (Power Off) Overheads
2016-07-14T15:56:38.469+03:00| vmx| I120: VMMEM: Maximum Reservation: 421MB (MainMem=2048MB)
2016-07-14T15:56:38.469+03:00| vmx| I120: TOOLS received request in VMX to set option 'enableDnD' -> '0'
2016-07-14T15:56:38.469+03:00| vmx| I120: GuestRpc: Attempt to send TCLO msg for 'toolbox' while GuestRpc is powering off.
2016-07-14T15:56:38.469+03:00| vmx| I120: TOOLS received request in VMX to set option 'copypaste' -> '0'
2016-07-14T15:56:38.469+03:00| vmx| I120: GuestRpc: Attempt to send TCLO msg for 'toolbox' while GuestRpc is powering off.
2016-07-14T15:56:38.485+03:00| vmx| I120: USB: Disconnecting device 0x10e0f0002
2016-07-14T15:56:38.516+03:00| mks| I120: MKS PowerOff
2016-07-14T15:56:38.516+03:00| mks| I120: MKS thread is exiting
2016-07-14T15:56:38.516+03:00| usbCCIDEnumCards| I120: USB-CCID: Card enum thread exiting.
2016-07-14T15:56:38.516+03:00| vmx| I120: scsi0:0: numIOs = 39061 numMergedIOs = 4753 numSplitIOs = 104 ( 2.1%)
2016-07-14T15:56:38.516+03:00| vmx| I120: Closing disk scsi0:0
2016-07-14T15:56:39.468+03:00| vmx| I120: AIOWIN32C: asyncOps=43737 syncOps=640 bufSize=156Kb fixedOps=201 sgOps=37509 sgOn=1
2016-07-14T15:56:39.468+03:00| aioCompletion| I120: AIO thread processed 43737 completions
2016-07-14T15:56:39.608+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.vmx~): The system cannot find the file specified (2)
2016-07-14T15:56:39.686+03:00| vmx| I120: Vix: [9192 mainDispatch.c:1222]: VMAutomationPowerOff: Powering off.
2016-07-14T15:56:39.702+03:00| vmx| I120: Policy_SavePolicyFile: invalid arguments to function.
2016-07-14T15:56:39.702+03:00| vmx| I120: PolicyVMX_Exit: Could not write out policies: 15.
2016-07-14T15:56:39.702+03:00| vmx| I120: WORKER: asyncOps=244 maxActiveOps=2 maxPending=0 maxCompleted=1
2016-07-14T15:56:39.702+03:00| WinNotifyThread| I120: WinNotify thread exiting
2016-07-14T15:56:39.920+03:00| vmx| I120: Vix: [9192 mainDispatch.c:3985]: VMAutomation_ReportPowerOpFinished: statevar=1, newAppState=1873, success=1 additionalError=0
2016-07-14T15:56:39.920+03:00| vmx| I120: Vix: [9192 mainDispatch.c:4004]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.
2016-07-14T15:56:39.920+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.vmx~): The system cannot find the file specified (2)
2016-07-14T15:56:39.983+03:00| vmx| I120: Vix: [9192 mainDispatch.c:3985]: VMAutomation_ReportPowerOpFinished: statevar=0, newAppState=1870, success=1 additionalError=0
2016-07-14T15:56:39.983+03:00| vmx| I120: Vix: [9192 mainDispatch.c:4004]: VMAutomation: Ignoring ReportPowerOpFinished because the VMX is shutting down.
2016-07-14T15:56:39.983+03:00| vmx| I120: Transitioned vmx/execState/val to poweredOff
2016-07-14T15:56:39.983+03:00| vmx| I120: SnapshotVMXRevertToSnapshot: Reverting to snapshot UID: 68
2016-07-14T15:56:39.983+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.vmx~): The system cannot find the file specified (2)
2016-07-14T15:56:40.045+03:00| vmx| I120: SNAPSHOT: Snapshot_Revert: 'Automation.vmx' : 68
2016-07-14T15:56:46.176+03:00| vmx| I120: DUMPER: Restoring checkpoint version 8.
2016-07-14T15:56:46.176+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert~): The system cannot find the file specified (2)
2016-07-14T15:56:46.207+03:00| vmx| I120: SNAPSHOT: SnapshotConfigInfoReadEx: Creating new snapshot dictionary, 'C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert.vmsd'.
2016-07-14T15:56:46.223+03:00| vmx| I120: DISKLIB-LIB : CREATE CHILD: "C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000040.vmdk" -- twoGbMaxExtentSparse grainSize=128 policy=''
2016-07-14T15:56:46.223+03:00| vmx| I120: DISKLIB-LIB : CREATE-CHILD: Creating disk backed by 'default'
2016-07-14T15:56:46.285+03:00| vmx| I120: DISKLIB-DSCPTR: "C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000040.vmdk" : creation successful.
2016-07-14T15:56:46.285+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000040.vmdk~): The system cannot find the file specified (2)
2016-07-14T15:56:46.659+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000040.vmdk~): The system cannot find the file specified (2)
2016-07-14T15:56:46.691+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000040.vmdk~): The system cannot find the file specified (2)
2016-07-14T15:56:46.706+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert~): The system cannot find the file specified (2)
2016-07-14T15:56:46.737+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert~): The system cannot find the file specified (2)
2016-07-14T15:56:46.769+03:00| vmx| I120: FILE: File_RenameRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert, C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.vmx): Access is denied (5)
2016-07-14T15:56:46.987+03:00| vmx| I120: SNAPSHOT: SnapshotDeleteDisks 'C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000050.vmdk'.
2016-07-14T15:56:47.003+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000050-s001.vmdk): The process cannot access the file because it is being used by another process (32)
2016-07-14T15:56:47.003+03:00| vmx| I120: OBJLIB-FILEBE :FileBEUnlink : Failed to unlink the file 'C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000050-s001.vmdk' : 2097156
2016-07-14T15:56:47.003+03:00| vmx| I120: DISKLIB-LIB : Cannot remove extent `C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000050-s001.vmdk': The process cannot access the file because it is being used by another process
2016-07-14T15:56:47.003+03:00| vmx| I120: DISKLIB-LIB : Failed to delete disk 'C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000050.vmdk' or one of its components: The process cannot access the file because it is being used by another process
2016-07-14T15:56:47.003+03:00| vmx| I120: SNAPSHOT: SnapshotDeleteDisks failed to unlink C:\Users\yosia\Documents\Virtual Machines\Automation\Automation-000050.vmdk, The process cannot access the file because it is being used by another process: 2097161
2016-07-14T15:56:47.003+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert): The system cannot find the file specified (2)
2016-07-14T15:56:47.003+03:00| vmx| I120: FILE: FileDeletionRetry: Non-retriable error encountered (C:\Users\yosia\Documents\Virtual Machines\Automation\Automation.tmpRevert.nvram): The system cannot find the file specified (2)
2016-07-14T15:56:47.003+03:00| vmx| I120: SNAPSHOT: Snapshot_Revert failed: The process cannot access the file because it is being used by another process (5)
2016-07-14T15:56:47.003+03:00| vmx| I120: SnapshotVMXRevertToSnapshot: Couldn't revert to snapshot at power off: The process cannot access the file because it is being used by another process.
2016-07-14T15:56:47.003+03:00| vmx| I120: Revert to snapshot 68 failed.
edit by wila Discussion moved from Workstation Player to Workstation Pro
Hi,
Are you running an antivirus product on your host?
If so, have you excluded scanning VMware virtual disks?
PS: As for attaching vmware log excerpts, please use the attach button and attach the full vmware.log as a file. Highlighting a few lines where you think the problem is displayed as you did now can help and is certainly preferred over copy&pasting the entire contents, but not all the necessary info might be included.