VMware Cloud Community
FunkyD
Contributor
Contributor
‎04-13-2008 05:35 AM

Why can't I copy my vmdk files for backup?

Nearly all of my Vmachines wont allow me to take a snapshot for backup - they report an error that a snapshot already exists (which is incorrect). If I clone the server andthen take a snapshot then everything works fine.

I can't see anything clear in the vmware.log file but I have put it here in case anyone can shed any light.

Thanks :smileyblush:

Mar 26 09:59:26.094: vmx| Log for VMware ESX Server pid=101109 version=3.0.1 build=build-73009 option=Release

Mar 26 09:59:26.108: vmx| Hostname=VmwareServer.CompanyName.com

Mar 26 09:59:26.108: vmx| Command line: "/usr/lib/vmware/bin/vmware-vmx" "-ssched.group=host/user/pool1" "-@" "pipe=/tmp/vmhsdaemon-0/vmx1c9885a8b0d0a1db;vm=1c9885a8b0d0a1db" "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmx"

Mar 26 09:59:26.216: vmx| UI Connecting to pipe '/tmp/vmhsdaemon-0/vmx1c9885a8b0d0a1db' with user '(null)'

Mar 26 09:59:26.262: vmx| pcpu #0 CPUID numEntries=10 GenuntelineI

Mar 26 09:59:26.263: vmx| pcpu #0 CPUID version=0x6f6 id1.edx=0xbfebfbff id1.ecx=0x4e33d id1.ebx=0x20800

Mar 26 09:59:26.263: vmx| pcpu #0 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1

Mar 26 09:59:26.263: vmx| pcpu #1 CPUID numEntries=10 GenuntelineI

Mar 26 09:59:26.263: vmx| pcpu #1 CPUID version=0x6f6 id1.edx=0xbfebfbff id1.ecx=0x4e33d id1.ebx=0x1020800

Mar 26 09:59:26.263: vmx| pcpu #1 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1

Mar 26 09:59:26.263: vmx| pcpu #2 CPUID numEntries=10 GenuntelineI

Mar 26 09:59:26.263: vmx| pcpu #2 CPUID version=0x6f6 id1.edx=0xbfebfbff id1.ecx=0x4e33d id1.ebx=0x6020800

Mar 26 09:59:26.263: vmx| pcpu #2 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1

Mar 26 09:59:26.263: vmx| pcpu #3 CPUID numEntries=10 GenuntelineI

Mar 26 09:59:26.263: vmx| pcpu #3 CPUID version=0x6f6 id1.edx=0xbfebfbff id1.ecx=0x4e33d id1.ebx=0x7020800

Mar 26 09:59:26.263: vmx| pcpu #3 CPUID id80.eax=80000008 id81.edx=0x20100000 id81.ecx=0x1

Mar 26 09:59:26.263: vmx| CPUID id1.edx: 0xbfebfbff id1.ecx: 0x4e33d id81.edx: 0x20100000 id81.ecx: 0x1

Mar 26 09:59:26.263: vmx| CPUID id88.ecx: 0 id88.edx: 0

Mar 26 09:59:26.263: vmx| CPUID Maximum Physical Address Bits supported across all CPUs : 36

Mar 26 09:59:26.284: vmx| Setup symlink /var/run/vmware/%2fvmfs%2fvolumes%2f4603f48a%2d6c62fbae%2dfd89%2d00188b77740d%2fVmachine%2fVmachine%2evmx -> /var/run/vmware/root_0/1206525566114163_101109

Mar 26 09:59:26.285: vmx| ACL_InitCapabilities: current IPC thread

Mar 26 09:59:26.285: vmx| ACL_InitCapabilities: done

Mar 26 09:59:26.290: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Mar 26 09:59:26.290: vmx| Config file: /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmx

Mar 26 09:59:26.477: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-flat.vmdk" : open successful (23) size = 12884901888, hd = -1. Type 3

Mar 26 09:59:26.479: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-flat.vmdk" : closed.

Mar 26 09:59:26.742: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1-flat.vmdk" : open successful (23) size = 4294967296, hd = -1. Type 3

Mar 26 09:59:26.743: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1-flat.vmdk" : closed.

Mar 26 09:59:26.934: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2-flat.vmdk" : open successful (23) size = 21474836480, hd = -1. Type 3

Mar 26 09:59:26.935: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2-flat.vmdk" : closed.

Mar 26 09:59:27.161: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Mar 26 09:59:27.214: vmx| VMXVmdbCbVmVmxMigrate: Got SET callback for /vm/#1c9885a8b0d0a1db/vmx/migrateState/cmd/##1_57/op/=from

Mar 26 09:59:27.214: vmx| VmxMigrateGetParam: srcIp=0xc0a87803 dstIp=0xc0a87801 mid=ead41fed uuid=44454c4c-4300-1036-8059-b8c04f4c324a priority=low

Mar 26 09:59:27.214: vmx| MigrateSetInfo: state=7 srcIp=<192.168.120.3> dstIp=<192.168.120.1> mid=3939770349 uuid=44454c4c-4300-1036-8059-b8c04f4c324a priority=low

Mar 26 09:59:27.214: vmx| MigrateStateUpdate: Transitioning from state 0 to 7.

Mar 26 09:59:27.215: vmx| Migrate: Overriding message callbacks with migration handlers.

Mar 26 09:59:27.220: vmx| PowerOn

Mar 26 09:59:27.225: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Mar 26 09:59:27.262: vmx| VMMon_CreateVM: vmmon.numVCPUs=1

Mar 26 09:59:27.285: vmx| UNAME Linux VmwareServer.CompanyName.com 2.4.21-37.0.2.ELvmnix #1 Thu Dec 27 20:57:12 PST 2007 i686 (uwglibc version 4)

Mar 26 09:59:27.285: vmx| DICT --- USER PREFERENCES

Mar 26 09:59:27.285: vmx| DICT --- USER DEFAULTS

Mar 26 09:59:27.285: vmx| DICT --- HOST DEFAULTS

Mar 26 09:59:27.285: vmx| DICT libdir = /usr/lib/vmware

Mar 26 09:59:27.285: vmx| DICT authd.fullpath = /usr/sbin/vmware-authd

Mar 26 09:59:27.285: vmx| DICT authd.client.port = 902

Mar 26 09:59:27.285: vmx| DICT vmware.fullpath = /usr/bin/vmware

Mar 26 09:59:27.285: vmx| DICT control.fullpath = /usr/bin/vmware-cmd

Mar 26 09:59:27.285: vmx| DICT serverd.fullpath = /usr/sbin/vmware-serverd

Mar 26 09:59:27.285: vmx| DICT serverd.init.fullpath = /usr/lib/vmware/serverd/init.pl

Mar 26 09:59:27.285: vmx| DICT authd.proxy.vim = vmware-hostd:hostd-vmdb

Mar 26 09:59:27.285: vmx| DICT authd.proxy.nfc = vmware-hostd:ha-nfc

Mar 26 09:59:27.285: vmx| DICT --- SITE DEFAULTS

Mar 26 09:59:27.285: vmx| DICT tag.help = introduction.htm

Mar 26 09:59:27.285: vmx| DICT tag.configurationEditor = config_editor_newvm.htm

Mar 26 09:59:27.285: vmx| DICT tag.ideConfig = devices_virtualdrive.htm

Mar 26 09:59:27.285: vmx| DICT tag.floppyConfig = devices_floppy.htm

Mar 26 09:59:27.285: vmx| DICT tag.mouseConfig = devices_mouse.htm

Mar 26 09:59:27.285: vmx| DICT tag.netConfig = devices_netadapter.htm

Mar 26 09:59:27.285: vmx| DICT tag.parallelConfig = devices_parallel.htm

Mar 26 09:59:27.285: vmx| DICT tag.serialConfig = devices_serial.htm

Mar 26 09:59:27.285: vmx| DICT tag.soundConfig = devices_sound.htm

Mar 26 09:59:27.285: vmx| DICT tag.memConfig = configvm_memory.htm

Mar 26 09:59:27.285: vmx| DICT tag.miscConfig = configvm.htm

Mar 26 09:59:27.285: vmx| DICT tag.usbConfig = devices_usb.htm

Mar 26 09:59:27.285: vmx| DICT tag.displayConfig = configvm_display-problems.htm

Mar 26 09:59:27.285: vmx| DICT tag.tools = vmtools.htm

Mar 26 09:59:27.285: vmx| DICT --- COMMAND LINE

Mar 26 09:59:27.285: vmx| DICT sched.group = host/user/pool1

Mar 26 09:59:27.285: vmx| DICT --- CONFIGURATION

Mar 26 09:59:27.285: vmx| DICT config.version = 8

Mar 26 09:59:27.285: vmx| DICT virtualHW.version = 4

Mar 26 09:59:27.285: vmx| DICT floppy0.present = TRUE

Mar 26 09:59:27.285: vmx| DICT nvram = Vmachine.nvram

Mar 26 09:59:27.285: vmx| DICT powerType.powerOff = default

Mar 26 09:59:27.285: vmx| DICT powerType.powerOn = default

Mar 26 09:59:27.285: vmx| DICT powerType.suspend = default

Mar 26 09:59:27.285: vmx| DICT powerType.reset = default

Mar 26 09:59:27.285: vmx| DICT displayName = Vmachine

Mar 26 09:59:27.285: vmx| DICT extendedConfigFile = Vmachine.vmxf

Mar 26 09:59:27.285: vmx| DICT scsi0.present = TRUE

Mar 26 09:59:27.285: vmx| DICT scsi0.sharedBus = none

Mar 26 09:59:27.285: vmx| DICT scsi0.virtualDev = lsilogic

Mar 26 09:59:27.285: vmx| DICT memsize = 512

Mar 26 09:59:27.285: vmx| DICT scsi0:0.present = TRUE

Mar 26 09:59:27.285: vmx| DICT scsi0:0.fileName = Vmachine.vmdk

Mar 26 09:59:27.285: vmx| DICT scsi0:0.deviceType = scsi-hardDisk

Mar 26 09:59:27.285: vmx| DICT ide0:0.present = TRUE

Mar 26 09:59:27.285: vmx| DICT ide0:0.clientDevice = FALSE

Mar 26 09:59:27.285: vmx| DICT ide0:0.deviceType = cdrom-image

Mar 26 09:59:27.285: vmx| DICT ide0:0.startConnected = FALSE

Mar 26 09:59:27.285: vmx| DICT floppy0.startConnected = FALSE

Mar 26 09:59:27.285: vmx| DICT floppy0.fileName = /dev/fd0

Mar 26 09:59:27.285: vmx| DICT floppy0.clientDevice = TRUE

Mar 26 09:59:27.285: vmx| DICT ethernet0.present = TRUE

Mar 26 09:59:27.285: vmx| DICT ethernet0.allowGuestConnectionControl = FALSE

Mar 26 09:59:27.285: vmx| DICT ethernet0.networkName = Production

Mar 26 09:59:27.285: vmx| DICT ethernet0.addressType = vpx

Mar 26 09:59:27.285: vmx| DICT ethernet0.generatedAddress = 00:50:56:83:2b:d0

Mar 26 09:59:27.285: vmx| DICT guestOS = winnetstandard

Mar 26 09:59:27.285: vmx| DICT annotation = Internal web server

Mar 26 09:59:27.285: vmx| DICT uuid.bios = 50 03 b6 8e 5b 6c 89 e3-0c 9a 09 e1 ae 8b 0f f0

Mar 26 09:59:27.285: vmx| DICT log.fileName = vmware.log

Mar 26 09:59:27.285: vmx| DICT sched.cpu.min = 0

Mar 26 09:59:27.285: vmx| DICT sched.cpu.units = mhz

Mar 26 09:59:27.285: vmx| DICT sched.cpu.shares = 1210

Mar 26 09:59:27.285: vmx| DICT sched.mem.minsize = 0

Mar 26 09:59:27.285: vmx| DICT sched.mem.shares = 512

Mar 26 09:59:27.285: vmx| DICT toolScripts.afterPowerOn = TRUE

Mar 26 09:59:27.285: vmx| DICT toolScripts.afterResume = TRUE

Mar 26 09:59:27.285: vmx| DICT toolScripts.beforeSuspend = TRUE

Mar 26 09:59:27.285: vmx| DICT toolScripts.beforePowerOff = TRUE

Mar 26 09:59:27.285: vmx| DICT scsi0:0.redo =

Mar 26 09:59:27.285: vmx| DICT tools.syncTime = FALSE

Mar 26 09:59:27.285: vmx| DICT vmware.tools.requiredversion = 7202

Mar 26 09:59:27.285: vmx| DICT sched.cpu.max = unlimited

Mar 26 09:59:27.285: vmx| DICT workingDir = .

Mar 26 09:59:27.285: vmx| DICT sched.mem.max = 512

Mar 26 09:59:27.285: vmx| DICT uuid.location = 56 4d 86 90 ea 45 20 3b-a4 50 b4 8a 74 32 29 6e

Mar 26 09:59:27.285: vmx| DICT migrate.hostlog = ./Vmachine-b3da9b05.hlog

Mar 26 09:59:27.285: vmx| DICT sched.swap.derivedName = /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-b3da9b05.vswp

Mar 26 09:59:27.285: vmx| DICT config.readOnly = FALSE

Mar 26 09:59:27.285: vmx| DICT scsi0:1.present = TRUE

Mar 26 09:59:27.285: vmx| DICT scsi0:1.deviceType = scsi-hardDisk

Mar 26 09:59:27.285: vmx| DICT scsi0:1.filename = Vmachine_1.vmdk

Mar 26 09:59:27.285: vmx| DICT scsi0:1.mode = persistent

Mar 26 09:59:27.285: vmx| DICT scsi0:1.redo =

Mar 26 09:59:27.285: vmx| DICT ide0:0.fileName = /vmfs/volumes/46039dfb-f4868a38-4b4a-00188b77740d/Source/Microsoft/Win2003R2/32bit/Disc1/BX2VOL_EN.iso

Mar 26 09:59:27.285: vmx| DICT scsi0:2.present = TRUE

Mar 26 09:59:27.285: vmx| DICT scsi0:2.fileName = Vmachine_2.vmdk

Mar 26 09:59:27.285: vmx| DICT scsi0:2.deviceType = scsi-hardDisk

Mar 26 09:59:27.285: vmx| DICT scsi0:2.redo =

Mar 26 09:59:27.285: vmx| DICT --- USER DEFAULTS

Mar 26 09:59:27.285: vmx| DICT --- HOST DEFAULTS

Mar 26 09:59:27.285: vmx| DICT libdir = /usr/lib/vmware

Mar 26 09:59:27.285: vmx| DICT authd.fullpath = /usr/sbin/vmware-authd

Mar 26 09:59:27.285: vmx| DICT authd.client.port = 902

Mar 26 09:59:27.285: vmx| DICT vmware.fullpath = /usr/bin/vmware

Mar 26 09:59:27.285: vmx| DICT control.fullpath = /usr/bin/vmware-cmd

Mar 26 09:59:27.285: vmx| DICT serverd.fullpath = /usr/sbin/vmware-serverd

Mar 26 09:59:27.285: vmx| DICT serverd.init.fullpath = /usr/lib/vmware/serverd/init.pl

Mar 26 09:59:27.285: vmx| DICT authd.proxy.vim = vmware-hostd:hostd-vmdb

Mar 26 09:59:27.285: vmx| DICT authd.proxy.nfc = vmware-hostd:ha-nfc

Mar 26 09:59:27.285: vmx| DICT --- SITE DEFAULTS

Mar 26 09:59:27.285: vmx| DICT tag.help = introduction.htm

Mar 26 09:59:27.285: vmx| DICT tag.configurationEditor = config_editor_newvm.htm

Mar 26 09:59:27.285: vmx| DICT tag.ideConfig = devices_virtualdrive.htm

Mar 26 09:59:27.285: vmx| DICT tag.floppyConfig = devices_floppy.htm

Mar 26 09:59:27.285: vmx| DICT tag.mouseConfig = devices_mouse.htm

Mar 26 09:59:27.285: vmx| DICT tag.netConfig = devices_netadapter.htm

Mar 26 09:59:27.285: vmx| DICT tag.parallelConfig = devices_parallel.htm

Mar 26 09:59:27.285: vmx| DICT tag.serialConfig = devices_serial.htm

Mar 26 09:59:27.285: vmx| DICT tag.soundConfig = devices_sound.htm

Mar 26 09:59:27.285: vmx| DICT tag.memConfig = configvm_memory.htm

Mar 26 09:59:27.285: vmx| DICT tag.miscConfig = configvm.htm

Mar 26 09:59:27.285: vmx| DICT tag.usbConfig = devices_usb.htm

Mar 26 09:59:27.285: vmx| DICT tag.displayConfig = configvm_display-problems.htm

Mar 26 09:59:27.285: vmx| DICT tag.tools = vmtools.htm

Mar 26 09:59:27.285: vmx| DICT --- GLOBAL SETTINGS

Mar 26 09:59:27.354: vmx| STATDECLGROUP stats Root "" null

Mar 26 09:59:27.419: vmx| Host CPUID features: version 0x6f8 id1.edx 0xbfebfbff id1.ecx 0x4e33d id81.edx 0x20100000 id81.ecx 0x1

Mar 26 09:59:27.419: vmx| CPU.cpuFeatures = 0xb971ff37

Mar 26 09:59:27.419: vmx| CPUID after masking: version 0x6f8 id1.edx 0xfebbbff id1.ecx 0x2211 id81.edx 0x20100800 id81.ecx 0x1 id88.ecx 0x0

Mar 26 09:59:27.419: vmx| CPU.cpuFeatures = 0x9871ff33

Mar 26 09:59:27.601: vmx| KHZEstimate 1995021

Mar 26 09:59:27.601: vmx| MHZEstimate 1995

Mar 26 09:59:27.601: vmx| NumVCPUs 1

Mar 26 09:59:27.611: vmx| UUID: location-UUID is 56 4d 9d 69 f4 80 8f b6-e9 64 c3 3a 4c 0c bc 87

Mar 26 09:59:27.611: vmx| UUID: canonical path is /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmx

Mar 26 09:59:27.611: vmx| UUID: location-UUID is 56 4d 9d 69 f4 80 8f b6-e9 64 c3 3a 4c 0c bc 87

Mar 26 09:59:27.611: vmx| UUID: Writing uuid.location 56 4d 9d 69 f4 80 8f b6-e9 64 c3 3a 4c 0c bc 87

Mar 26 09:59:27.625: vmx| MStat: Creating Stat vm.uptime

Mar 26 09:59:27.625: vmx| MStat: Creating Stat vm.suspendTime

Mar 26 09:59:27.626: vmx| MStat: Creating Stat vm.powerOnTimeStamp

Mar 26 09:59:27.633: vmx| MigrateWaitForData: waiting for data.

Mar 26 09:59:27.633: vmx| MigrateStateUpdate: Transitioning from state 7 to 8.

Mar 26 09:59:28.475: vmx| MigrateStateUpdate: Transitioning from state 8 to 9.

Mar 26 09:59:34.481: vmx| MigrateWaitForData: Waited for 6.84 seconds.

Mar 26 09:59:34.481: vmx| MigrateStateUpdate: Transitioning from state 9 to 10.

Mar 26 09:59:34.481: vmx| DMotion not required

Mar 26 09:59:34.489: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Mar 26 09:59:34.495: vmx| DISK: OPEN scsi0:0 '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmdk' persistent R[(null)]

Mar 26 09:59:34.503: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-flat.vmdk" : open successful (10) size = 12884901888, hd = 2072. Type 3

Mar 26 09:59:34.503: vmx| DISKLIB-DSCPTR: Opened : "Vmachine-flat.vmdk" (0xa)

Mar 26 09:59:34.504: vmx| DISKLIB-LINK : Opened '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmdk' (0xa): vmfs, 25165824 sectors / 12288 Mb.

Mar 26 09:59:34.517: vmx| DISKLIB-LIB : Opened "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmdk" (flags 0xa). 0x85865d8

Mar 26 09:59:34.555: vmx| DISK: OPEN '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmdk' Geo (1566/255/63) BIOS Geo (0/0/0) freeSpace=51593Mb, DDB.adapterType=lsilogic

Mar 26 09:59:34.562: vmx| DISK: OPEN scsi0:1 '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1.vmdk' persistent R[(null)]

Mar 26 09:59:34.574: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1-flat.vmdk" : open successful (10) size = 4294967296, hd = 3097. Type 3

Mar 26 09:59:34.574: vmx| DISKLIB-DSCPTR: Opened : "Vmachine_1-flat.vmdk" (0xa)

Mar 26 09:59:34.574: vmx| DISKLIB-LINK : Opened '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1.vmdk' (0xa): vmfs, 8388608 sectors / 4096 Mb.

Mar 26 09:59:34.574: vmx| DISKLIB-LIB : Opened "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1.vmdk" (flags 0xa). 0x8568bb8

Mar 26 09:59:34.589: vmx| DISK: OPEN '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1.vmdk' Geo (522/255/63) BIOS Geo (0/0/0) freeSpace=51593Mb, DDB.adapterType=lsilogic

Mar 26 09:59:34.595: vmx| DISK: OPEN scsi0:2 '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2.vmdk' persistent R[(null)]

Mar 26 09:59:34.608: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2-flat.vmdk" : open successful (10) size = 21474836480, hd = 10266. Type 3

Mar 26 09:59:34.608: vmx| DISKLIB-DSCPTR: Opened : "Vmachine_2-flat.vmdk" (0xa)

Mar 26 09:59:34.609: vmx| DISKLIB-LINK : Opened '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2.vmdk' (0xa): vmfs, 41943040 sectors / 20480 Mb.

Mar 26 09:59:34.609: vmx| DISKLIB-LIB : Opened "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2.vmdk" (flags 0xa). 0x856dbb8

Mar 26 09:59:34.623: vmx| DISK: OPEN '/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2.vmdk' Geo (2610/255/63) BIOS Geo (0/0/0) freeSpace=51593Mb, DDB.adapterType=lsilogic

Mar 26 09:59:34.636: vmx| TimeTracker host to guest rate conversion 1374124794039750 @ 1995021000Hz -> 1374124794039750 @ 1995021000Hz

Mar 26 09:59:34.636: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 0

Mar 26 09:59:34.666: vmx| DumpDiskInfo: scsi0:0 createType=11, capacity = 25165824, numLinks = 1, allocationType = 0

Mar 26 09:59:34.666: vmx| SCSIDiskESXPopulateVDevDesc: Using FS backend

Mar 26 09:59:34.666: vmx| DumpDiskInfo: scsi0:1 createType=11, capacity = 8388608, numLinks = 1, allocationType = 0

Mar 26 09:59:34.666: vmx| SCSIDiskESXPopulateVDevDesc: Using FS backend

Mar 26 09:59:34.666: vmx| DumpDiskInfo: scsi0:2 createType=11, capacity = 41943040, numLinks = 1, allocationType = 1

Mar 26 09:59:34.666: vmx| SCSIDiskESXPopulateVDevDesc: Using FS backend

Mar 26 09:59:34.666: vmx| SCSI0: UNTAGGED commands will be converted to ORDER tags.

Mar 26 09:59:34.677: vmx| MStat: Creating Stat vm.heartbeat

Mar 26 09:59:34.694: vmx| DISKUTIL: scsi0:2 : toolsVersion = 7202

Mar 26 09:59:34.694: vmx| DISKUTIL: scsi0:1 : toolsVersion = 7202

Mar 26 09:59:34.694: vmx| DISKUTIL: scsi0:0 : toolsVersion = 7202

Mar 26 09:59:34.694: vmx| TOOLS INSTALL initializing state to IDLE on power on.

Mar 26 09:59:34.950: vmx| DVGA: Cannot map VGA physical frame buffer: Invalid argument.

Mar 26 09:59:34.950: vmx| DVGA: Full screen VGA will not be available.

Mar 26 09:59:35.183: vmx| SVGA: Truncated max res to VRAM size: 4194304 bytes VRAM, 1180x885 Max Resolution

Mar 26 09:59:35.183: vmx| VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks

Mar 26 09:59:35.187: vmx| Ethernet0 MAC Address: 00:50:56:83:2b:d0

Mar 26 09:59:35.187: vmx| Vmxnet2: ESX301 VMotion Fix

Mar 26 09:59:35.191: vmx| CPT: Restoring checkpoint (null)

Mar 26 09:59:35.191: vmx| MigrateOpen: Restoring from <192.168.120.3> with migration id 3939770349

Mar 26 09:59:35.191: vmx| DUMPER: restoring checkpoint version 8

Mar 26 09:59:35.194: vmx| DUMPER: item eip in group cpu not used

Mar 26 09:59:35.194: vmx| Checkpoint: found group Ethernet0

Mar 26 09:59:35.194: vmx| Checkpoint: no dumper group ethernet0

Mar 26 09:59:35.194: vmx| Checkpoint: no group Ethernet1

Mar 26 09:59:35.194: vmx| Checkpoint: no group Ethernet2

Mar 26 09:59:35.194: vmx| Checkpoint: no group Ethernet3

Mar 26 09:59:35.194: vmx| restoring Snapshot

Mar 26 09:59:35.194: vmx| DUMPER: item cfgFile in group Snapshot not used

Mar 26 09:59:35.194: vmx| DUMPER: item nvramFile in group Snapshot not used

Mar 26 09:59:35.194: vmx| restoring memory

Mar 26 09:59:35.204: vmx| Mapped mainmem as pageable

Mar 26 09:59:35.204: vmx| restoring MStats

Mar 26 09:59:35.204: vmx| restoring pic

Mar 26 09:59:35.205: vmx| restoring TimeTracker

Mar 26 09:59:35.205: vmx| TimeTracker host to guest rate conversion 1374124794039750 @ 1995021000Hz -> 16860516847497626 @ 1995021000Hz

Mar 26 09:59:35.205: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 15486392053457876

Mar 26 09:59:35.205: vmx| restoring Floppy

Mar 26 09:59:35.205: vmx| restoring GuestMsg

Mar 26 09:59:35.205: vmx| restoring GuestRpc

Mar 26 09:59:35.205: vmx| restoring PCI

Mar 26 09:59:35.205: vmx| restoring Cs440bx

Mar 26 09:59:35.206: vmx| DUMPER: item drb in group Cs440bx not used

Mar 26 09:59:35.206: vmx| DUMPER: item drb in group Cs440bx not used

Mar 26 09:59:35.206: vmx| restoring scsi0:2

Mar 26 09:59:35.206: vmx| restoring scsi0:1

Mar 26 09:59:35.206: vmx| restoring scsi0:0

Mar 26 09:59:35.206: vmx| restoring ide0:0

Mar 26 09:59:35.206: vmx| restoring vide

Mar 26 09:59:35.207: vmx| DUMPER: BlockItem monbuf not found

Mar 26 09:59:35.207: vmx| DUMPER: BlockItem monbuf not found

Mar 26 09:59:35.207: vmx| restoring SCSI0

Mar 26 09:59:35.207: vmx| restoring Timer

Mar 26 09:59:35.207: vmx| restoring Tools

Mar 26 09:59:35.207: vmx| restoring Tools Install

Mar 26 09:59:35.207: vmx| TOOLS INSTALL setting state to 0 on restore.

Mar 26 09:59:35.207: vmx| restoring MKSVMX

Mar 26 09:59:35.207: vmx| DUMPER: item imageData in group MKSVMX not used

Mar 26 09:59:35.207: vmx| restoring VGA

Mar 26 09:59:35.208: vmx| restoring DMA

Mar 26 09:59:35.208: vmx| restoring BackdoorAPM

Mar 26 09:59:35.208: vmx| restoring CMOS

Mar 26 09:59:35.208: vmx| restoring FlashRam

Mar 26 09:59:35.209: vmx| restoring A20

Mar 26 09:59:35.209: vmx| restoring Keyboard

Mar 26 09:59:35.209: vmx| restoring backdoorAbsMouse

Mar 26 09:59:35.209: vmx| restoring SIO

Mar 26 09:59:35.209: vmx| restoring serial0

Mar 26 09:59:35.209: vmx| restoring serial1

Mar 26 09:59:35.209: vmx| restoring serial2

Mar 26 09:59:35.209: vmx| restoring serial3

Mar 26 09:59:35.209: vmx| restoring parallel0

Mar 26 09:59:35.209: vmx| restoring parallel1

Mar 26 09:59:35.209: vmx| restoring parallel2

Mar 26 09:59:35.209: vmx| restoring SVGA

Mar 26 09:59:35.209: vmx| SVGA phys sizes: 1180x885x32 offset 0 fb 0x00400000

Mar 26 09:59:35.210: vmx| SVGA compatible geometry on checkpoint restore

Mar 26 09:59:35.210: vmx| SVGA old geometry 1180x885, max size = 4194304

Mar 26 09:59:35.210: vmx| SVGA new geometry 1180x885, max size = 4194304

Mar 26 09:59:35.218: vmx| restoring Ethernet0

Mar 26 09:59:35.218: vmx| MigrateDumperRead: Read 1205 bytes @ 5319499

Mar 26 09:59:35.218: vmx| restoring monitorLate

Mar 26 09:59:35.218: vmx| restoring devices

Mar 26 09:59:35.219: vmx| DUMPER: Dumper_EndRestore: update hdr magic

Mar 26 09:59:35.224: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-flat.vmdk" : open successful (21) size = 12884901888, hd = -1. Type 3

Mar 26 09:59:35.225: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-flat.vmdk" : closed.

Mar 26 09:59:35.228: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1-flat.vmdk" : open successful (21) size = 4294967296, hd = -1. Type 3

Mar 26 09:59:35.228: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1-flat.vmdk" : closed.

Mar 26 09:59:35.231: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2-flat.vmdk" : open successful (21) size = 21474836480, hd = -1. Type 3

Mar 26 09:59:35.232: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2-flat.vmdk" : closed.

Mar 26 09:59:35.239: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Mar 26 09:59:35.263: vmx| VMX_PowerOn: ModuleTable_PowerOn = 1

Mar 26 09:59:35.263: vmx| VMX setting maximum IPC write buffers to 0 packets, 0 bytes

Mar 26 09:59:35.282: mks| Async MKS thread is alive

Mar 26 09:59:35.282: vcpu-0| VMMon_Start: vcpu-0: worldID=1110

Mar 26 09:59:35.283: vcpu-0| APIC: version = 0x14, max LVT = 5

Mar 26 09:59:35.283: vcpu-0| APIC: LDR = 0x8000000, DFR = 0xffffffff

Mar 26 09:59:35.322: vcpu-0| guestCpuFeatures = 0x9871ff33

Mar 26 09:59:35.322: vcpu-0| Init modules.

Mar 26 09:59:35.327: vcpu-0| Cpt monModules(3).

Mar 26 09:59:35.329: vcpu-0| Done Cpt monModules(3).

Mar 26 09:59:35.347: vcpu-0| sz=3039200

Mar 26 09:59:35.348: vcpu-0| vmm32 initialized: Releasebuild-73009. cflags: 0x08000002.0c00c000.00000540

Mar 26 09:59:35.348: vcpu-0| Restoring VM

Mar 26 09:59:35.348: vcpu-0| Sync monModules(4).

Mar 26 09:59:35.349: vcpu-0| Migrate: Restoring original message callbacks.

Mar 26 09:59:35.350: vcpu-0| MigrateSetInfo: state=11 srcIp=<0.0.0.0> dstIp=<0.0.0.0> mid=0 uuid=(null) priority=(null)

Mar 26 09:59:35.350: vcpu-0| MigrateStateUpdate: Transitioning from state 10 to 11.

Mar 26 09:59:35.350: vcpu-0| Migrate_ClearDoneState: cleared state. State was 11.

Mar 26 09:59:35.350: vcpu-0| MigrateStateUpdate: Transitioning from state 11 to 0.

Mar 26 09:59:35.350: vcpu-0| Done Sync monModules(4).

Mar 26 09:59:35.351: vcpu-0| SVGA: Registering IOSpace at 0x1060 (0x0)

Mar 26 09:59:35.351: vcpu-0| SVGA: Registering MemSpace at 0xf8000000(0xf8000000) and 0xf4000000(0xf4000000)

Mar 26 09:59:35.477: vcpu-0| GuestRpc: Channel 1, registration number 3, guest application toolbox.

Mar 26 09:59:35.477: vcpu-0| DISKUTIL: scsi0:2 : toolsVersion = 7202

Mar 26 09:59:35.477: vcpu-0| DISKUTIL: scsi0:1 : toolsVersion = 7202

Mar 26 09:59:35.477: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7202

Mar 26 09:59:35.502: vcpu-0| HBACommon: First write on scsi0:0.fileName/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine.vmdk

Mar 26 09:59:35.514: vcpu-0| DISKLIB-CHAIN : UpdateContentID: old = 0xe35d94ff, new = 0xc4bc1ebe

Mar 26 09:59:35.535: vcpu-0| Guest: toolbox: Version: build-43424

Mar 26 09:59:35.536: vcpu-0| TOOLS setting the tools version to '7202'

Mar 26 09:59:35.552: vcpu-0| TOOLS unified loop capability requested by 'toolbox'; now sending options via TCLO

Mar 26 09:59:36.334: vcpu-0| HBACommon: First write on scsi0:2.fileName/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2.vmdk

Mar 26 09:59:36.339: vcpu-0| DISKLIB-CHAIN : UpdateContentID: old = 0x56253965, new = 0x26e45d73

Mar 26 09:59:38.800: vcpu-0| HBACommon: First write on scsi0:1.fileName/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1.vmdk

Mar 26 09:59:38.807: vcpu-0| DISKLIB-CHAIN : UpdateContentID: old = 0x81e1787f, new = 0x4c400aa2

Apr 01 18:07:58.605: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:07:58.644: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 01 18:07:58.649: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:09:39.082: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:09:39.093: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 01 18:09:39.098: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:37:04.605: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:37:04.619: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 01 18:37:04.625: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:47:54.762: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 01 18:47:54.774: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 01 18:47:54.779: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:32:06.853: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:32:06.988: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 02 08:32:06.993: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:41:48.289: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:41:48.343: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 02 08:41:48.348: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:44:18.499: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:44:18.539: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 02 08:44:18.544: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:54:09.487: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 02 08:54:09.540: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 02 08:54:09.545: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 21:44:53.542: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 21:44:53.554: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 21:44:53.558: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 21:45:33.563: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 21:45:33.578: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 21:45:33.583: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:00:52.675: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:00:52.686: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 22:00:52.691: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:01:28.384: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:01:28.395: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 22:01:28.400: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:12:50.618: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:12:50.637: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 22:12:50.642: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:13:30.636: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:13:30.648: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 22:13:30.652: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:57:56.184: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:57:56.323: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 22:57:56.328: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:58:25.794: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 22:58:25.806: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 22:58:25.811: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:03:22.784: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:03:22.839: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:03:22.844: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:08:56.129: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:08:56.183: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:08:56.188: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:09:56.536: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:09:56.585: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:09:56.590: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:14:39.511: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:14:39.557: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:14:39.562: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:18:42.293: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:18:42.337: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:18:42.342: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:24:57.845: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:24:57.896: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:24:57.901: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:35:43.182: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:35:43.226: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:35:43.231: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:36:22.874: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 03 23:36:22.927: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 03 23:36:22.932: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:14:56.417: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:14:56.455: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 00:14:56.460: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:17:17.103: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:17:17.151: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 00:17:17.156: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:29:15.538: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:29:15.576: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 00:29:15.581: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:30:00.142: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 00:30:00.153: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 00:30:00.158: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 01:00:24.047: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 01:00:24.165: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 01:00:24.170: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 01:03:18.960: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 01:03:18.971: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 01:03:18.976: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 01:13:14.973: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 01:13:14.985: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 01:13:14.989: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:19:10.141: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:19:10.202: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 02:19:10.207: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:21:07.047: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:21:07.058: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 02:21:07.063: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:55:27.138: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:55:27.171: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 02:55:27.176: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:57:36.917: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 02:57:36.931: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 02:57:36.936: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 10:00:27.331: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 10:00:27.475: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 10:00:27.480: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 10:27:08.969: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 04 10:27:09.004: vmx| changing directory to /vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/.

Apr 04 10:27:09.009: vmx| VMXVmdb_LoadRawConfig: Loading raw config

Apr 07 09:03:30.316: vcpu-0| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO

Apr 07 09:03:30.317: vcpu-0| GuestRpc: Channel 2, registration number 1, guest application toolbox-dnd.

Apr 07 09:03:30.317: vcpu-0| DISKUTIL: scsi0:2 : toolsVersion = 7202

Apr 07 09:03:30.317: vcpu-0| DISKUTIL: scsi0:1 : toolsVersion = 7202

Apr 07 09:03:30.317: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7202

Apr 07 09:49:59.436: vcpu-0| GuestRpc: Channel 2 reinitialized.

Apr 10 08:11:03.899: vcpu-0| MKS Backdoor get pointer: first time, notify tools are running

Apr 10 08:11:04.117: vcpu-0| VMMouse: CMD Read ID

Apr 10 08:11:04.117: vcpu-0| MKS switching absolute mouse on

Apr 10 08:11:09.040: mks| SOCKET 2 recv error 5: Input/output error

Apr 10 08:11:09.040: mks| SOCKET 2 destroying VNC backend on socket error: 5

Apr 11 08:06:16.015: vcpu-0| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO

Apr 11 08:06:16.015: vcpu-0| GuestRpc: Channel 2, registration number 1, guest application toolbox-dnd.

Apr 11 08:06:16.015: vcpu-0| DISKUTIL: scsi0:2 : toolsVersion = 7202

Apr 11 08:06:16.015: vcpu-0| DISKUTIL: scsi0:1 : toolsVersion = 7202

Apr 11 08:06:16.015: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7202

Apr 11 10:39:28.139: mks| SOCKET 3 recv error 5: Input/output error

Apr 11 10:39:28.139: mks| SOCKET 3 destroying VNC backend on socket error: 5

Apr 11 10:44:42.968: vcpu-0| GuestRpc: Channel 2 reinitialized.

Apr 13 11:43:56.176: vcpu-0| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO

Apr 13 11:43:56.176: vcpu-0| GuestRpc: Channel 2, registration number 1, guest application toolbox-dnd.

Apr 13 11:43:56.177: vcpu-0| DISKUTIL: scsi0:2 : toolsVersion = 7202

Apr 13 11:43:56.177: vcpu-0| DISKUTIL: scsi0:1 : toolsVersion = 7202

Apr 13 11:43:56.177: vcpu-0| DISKUTIL: scsi0:0 : toolsVersion = 7202

Apr 13 11:44:26.570: vcpu-0| Guest: toolbox: Got a logoff event.

Apr 13 11:44:30.289: vcpu-0| GuestRpc: Channel 2 reinitialized.

Apr 13 11:44:32.629: vcpu-0| Guest: toolbox: Got a logoff event.

Apr 13 11:46:59.227: vcpu-0| Guest: toolbox: VMware Tools Service Shutdown.

Apr 13 11:46:59.227: vcpu-0| Guest: toolbox: VMware Tools Service Stopping.

Apr 13 11:46:59.301: vcpu-0| GuestRpc: Channel 1 reinitialized.

Apr 13 11:47:42.035: vcpu-0| VMMouse: CMD Disable

Apr 13 11:47:42.035: vcpu-0| VMMouse: Disabling VMMouse mode

Apr 13 11:47:42.035: vcpu-0| MKS switching absolute mouse on

Apr 13 11:47:42.164: vcpu-0| PIIX4: PM Soft Off. Good-bye.

Apr 13 11:47:42.227: vmx| Stopping VCPU threads...

Apr 13 11:47:42.227: vcpu-0| VMMon_WaitForExit: vcpu-0: worldID=1110

Apr 13 11:47:42.261: mks| Async MKS thread is exiting

Apr 13 11:47:42.262: vmx| DnD rpc already set to 0

Apr 13 11:47:42.262: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '0'

Apr 13 11:47:42.290: vmx| SOCKET 4 close VNC socket on VNCBackendDestroy

Apr 13 11:47:42.300: vmx| MKS local poweroff

Apr 13 11:47:42.305: vmx| Lock before MKS lock created. Early poweroff?

Apr 13 11:47:42.305: vmx| Unlock before MKS lock created. Early poweroff?

Apr 13 11:47:42.325: vmx| scsi0:2: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)

Apr 13 11:47:42.325: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_2-flat.vmdk" : closed.

Apr 13 11:47:42.326: vmx| scsi0:1: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)

Apr 13 11:47:42.326: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine_1-flat.vmdk" : closed.

Apr 13 11:47:42.326: vmx| scsi0:0: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)

Apr 13 11:47:42.327: vmx| DISKLIB-VMFS : "/vmfs/volumes/4603f48a-6c62fbae-fd89-00188b77740d/Vmachine/Vmachine-flat.vmdk" : closed.

Apr 13 11:47:43.670: vmx| vmdbPipe_Streams Couldn't read: OVL_STATUS_EOF

Apr 13 11:47:43.673: vmx| VMX idle exit

Apr 13 11:47:43.683: vmx| Flushing VMX VMDB connections

Apr 13 11:47:43.696: vmx| IPC_exit: disconnecting all threads

Apr 13 11:47:43.696: vmx| VMX exit.

Apr 13 11:47:43.697: vmx| AIOMGR-S : stat o=3 r=0 w=0 i=6 br=0 bw=0.

Message was edited by: FunkyD - I can snapshot but I can't backup the files after the snapshot has been taken.

0 Kudos
4 Replies
weinstein5
Immortal
Immortal
‎04-13-2008 06:26 AM

The problem you might have is might be running your disk in independent more - you can not snapshot a disk that is in the independent persistent mode

Mar 26 09:59:27.285: vmx| DICT scsi0:1.filename = Vmachine_1.vmdk

Mar 26 09:59:27.285: vmx| DICT scsi0:1.mode = persistent

Mar 26 09:59:27.285: vmx| DICT scsi0:1.redo =

To change it back so it is not in Independent Mode you will have to power off your VM -

To change your disk from Independent Mode

  1. Choose Inventory > Virtual Machine > Edit Settings.|

  2. Click the Hardware tab, and select the hard disk you want to change - it should be Hard Disk 1 but check both

  3. Under Mode, deselect Independent.

If you find this or any other answer useful please consider awarding points by marking the answer correct or helpful
0 Kudos
FunkyD
Contributor
Contributor
‎04-13-2008 06:42 AM

I've checked and none of the machines are in independent mode.

At the moment I am in the process of shuting down, cloning and then starting up the machines just so I can take a snapshot to allow me to backup. :_|

0 Kudos
FunkyD
Contributor
Contributor
‎04-13-2008 10:08 AM

One of my servers despite being cloned wont let me snapshot and then backup. I am getting a message saying 'device or resource busy' which according to other posts seems to relate to independent disks which having checked I am not using.

Edit: I decided to backup again one of the machines that worked after cloning and now it won't let me take a backup.

It seems that either there is something seriously wrong with my ESX server that I am using to do backups.

I'm wondering whether it is the snapshot facility that is not working - it seems to make sense that if the snapshot is not working then it wont be possible to copy the vmdk files?

0 Kudos
FunkyD
Contributor
Contributor
‎04-14-2008 01:06 AM

I've taken another look at this.

I cloned one of my machines and then renamed the original vmx file and added the original machine back into VC. The snapshot and backup worked perfectly but not when I tried it again on the cloned machine.

Clearly my Vmachine setup with the disks is fine but I'm not sure I can attribute VC to the problems because even when I target the ESX server directly it doesn't work on the cloned machine.

Message was edited by: FunkyD

I've done another test. This time taking a manual snapshot in VC and then copying the flat.vmdk machines across the network - worked fine. Doesn't work at all when using the backup utility - vibackup

0 Kudos