Apr 12 01:10:14: app| Log for VMware Server pid=13657 version=1.0.5 build=build-80187 option=Release.3.2.2
Apr 12 01:10:14: app| Program: /usr/sbin/vmware-serverd
Apr 12 01:10:14: app| CWD: /var/log/vmware
Apr 12 01:10:14: app| Init script: /usr/lib/vmware/serverd/init.pl
Apr 12 01:10:14: app| 
Apr 12 01:10:14: app| Files included by init.pl:
Apr 12 01:10:14: app|    module Exporter.pm -> /usr/lib/vmware/perl5/site_perl/5.005/Exporter.pm
Apr 12 01:10:14: app|    module strict.pm -> /usr/lib/vmware/perl5/site_perl/5.005/strict.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/FileInfo.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/FileInfo.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/Info.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/Info.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/TaskManager.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/TaskManager.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/Who.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/Who.pm
Apr 12 01:10:14: app|    module overload.pm -> /usr/lib/vmware/perl5/site_perl/5.005/overload.pm
Apr 12 01:10:14: app|    module vars.pm -> /usr/lib/vmware/perl5/site_perl/5.005/vars.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/Stats.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/Stats.pm
Apr 12 01:10:14: app|    module Cwd.pm -> /usr/lib/vmware/perl5/site_perl/5.005/Cwd.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/VMConfigDefaults.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/VMConfigDefaults.pm
Apr 12 01:10:14: app|    module VMware/HConfig.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/HConfig.pm
Apr 12 01:10:14: app|    module /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/auto/VMware/VmPerl/autosplit.ix -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/auto/VMware/VmPerl/autosplit.ix
Apr 12 01:10:14: app|    module VMware/HConfig/CommonConstant.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/HConfig/CommonConstant.pm
Apr 12 01:10:14: app|    module SelectSaver.pm -> /usr/lib/vmware/perl5/site_perl/5.005/SelectSaver.pm
Apr 12 01:10:14: app|    module DynaLoader.pm -> /usr/lib/vmware/perl5/site_perl/5.005/DynaLoader.pm
Apr 12 01:10:14: app|    module IO/Seekable.pm -> /usr/lib/vmware/perl5/site_perl/5.005/IO/Seekable.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/Query.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/Query.pm
Apr 12 01:10:14: app|    module VMware/ExtHelpers.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/ExtHelpers.pm
Apr 12 01:10:14: app|    module /usr/lib/vmware/perl5/site_perl/5.005/auto/POSIX/autosplit.ix -> /usr/lib/vmware/perl5/site_perl/5.005/auto/POSIX/autosplit.ix
Apr 12 01:10:14: app|    module IO/File.pm -> /usr/lib/vmware/perl5/site_perl/5.005/IO/File.pm
Apr 12 01:10:14: app|    module VMware/Control/Server.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/Control/Server.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/FileManager.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/FileManager.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/VMDeleteEdit.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/VMDeleteEdit.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/GSXHostInfo.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/GSXHostInfo.pm
Apr 12 01:10:14: app|    module FileHandle.pm -> /usr/lib/vmware/perl5/site_perl/5.005/FileHandle.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/VMList.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/VMList.pm
Apr 12 01:10:14: app|    module XML/Parser.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/XML/Parser.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/AuthPolicy.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/AuthPolicy.pm
Apr 12 01:10:14: app|    module AutoLoader.pm -> /usr/lib/vmware/perl5/site_perl/5.005/AutoLoader.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/EventLog.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/EventLog.pm
Apr 12 01:10:14: app|    module VMware/DOMAccess.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/DOMAccess.pm
Apr 12 01:10:14: app|    module IO/Handle.pm -> /usr/lib/vmware/perl5/site_perl/5.005/IO/Handle.pm
Apr 12 01:10:14: app|    module VMware/Control/Keycode.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/Control/Keycode.pm
Apr 12 01:10:14: app|    module Config.pm -> /usr/lib/vmware/perl5/site_perl/5.005/Config.pm
Apr 12 01:10:14: app|    module Symbol.pm -> /usr/lib/vmware/perl5/site_perl/5.005/Symbol.pm
Apr 12 01:10:14: app|    module VMware/VmPerl.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/VmPerl.pm
Apr 12 01:10:14: app|    module VMware/Config.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/Config.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/Disk.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/Disk.pm
Apr 12 01:10:14: app|    module MIME/Base64.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/MIME/Base64.pm
Apr 12 01:10:14: app|    module XML/Parser/Expat.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/XML/Parser/Expat.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/Mac.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/Mac.pm
Apr 12 01:10:14: app|    module VMware/VMServerd.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd.pm
Apr 12 01:10:14: app|    module XML/DOM.pm -> /usr/lib/vmware/perl5/site_perl/5.005/XML/DOM.pm
Apr 12 01:10:14: app|    module VMware/Control.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/Control.pm
Apr 12 01:10:14: app|    module Carp.pm -> /usr/lib/vmware/perl5/site_perl/5.005/Carp.pm
Apr 12 01:10:14: app|    module File/Copy.pm -> /usr/lib/vmware/perl5/site_perl/5.005/File/Copy.pm
Apr 12 01:10:14: app|    module VMware/Management/Util.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/Management/Util.pm
Apr 12 01:10:14: app|    module /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/auto/VMware/Control/autosplit.ix -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/auto/VMware/Control/autosplit.ix
Apr 12 01:10:14: app|    module VMware/VMServerd/SecurityEdit.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/SecurityEdit.pm
Apr 12 01:10:14: app|    module VMware/HConfig/Host.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/HConfig/Host.pm
Apr 12 01:10:14: app|    module integer.pm -> /usr/lib/vmware/perl5/site_perl/5.005/integer.pm
Apr 12 01:10:14: app|    module VMware/VMServerd/VMDeleteInfo.pm -> /usr/lib/vmware/perl5/site_perl/5.005/VMware/VMServerd/VMDeleteInfo.pm
Apr 12 01:10:14: app|    module File/Find.pm -> /usr/lib/vmware/perl5/site_perl/5.005/File/Find.pm
Apr 12 01:10:14: app|    module URI/Escape.pm -> /usr/lib/vmware/perl5/site_perl/5.005/URI/Escape.pm
Apr 12 01:10:14: app|    module POSIX.pm -> /usr/lib/vmware/perl5/site_perl/5.005/POSIX.pm
Apr 12 01:10:14: app|    module VMware/Control/Profiler.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/Control/Profiler.pm
Apr 12 01:10:14: app|    module VMware/Control/VM.pm -> /usr/lib/vmware/perl5/site_perl/5.005/i386-linux/VMware/Control/VM.pm
Apr 12 01:10:14: app| 
Apr 12 01:10:14: app| 
Apr 12 01:10:14: app| Operations defined in function table:
Apr 12 01:10:14: app| Op CreateCOWDisk -> VMware::VMServerd::Disk::CreateCOWDisk_Handler (authuser)
Apr 12 01:10:14: app| Op Directory_GetSpaceUsage -> VMware::VMServerd::Handlers::Directory_GetSpaceUsage_Handler (authuser)
Apr 12 01:10:14: app| Op Directory_List -> VMware::VMServerd::Handlers::Directory_List_Handler (authuser)
Apr 12 01:10:14: app| Op Directory_Make -> VMware::VMServerd::Handlers::Directory_Make_Handler (authuser)
Apr 12 01:10:14: app| Op Directory_Remove -> VMware::VMServerd::Handlers::Directory_Remove_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_ChangeAttribs -> VMware::VMServerd::FileManager::ChangeAttribs_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_ChangeGroup -> VMware::VMServerd::FileManager::ChangeGroup_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_ChangeMode -> VMware::VMServerd::FileManager::ChangeMode_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_ChangeOwner -> VMware::VMServerd::FileManager::ChangeOwner_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_FileCopy -> VMware::VMServerd::FileManager::FileCopy_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_FileExists -> VMware::VMServerd::FileManager::FileExists_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_FileMakeLink -> VMware::VMServerd::FileManager::FileMakeLink_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_FileMove -> VMware::VMServerd::FileManager::FileMove_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_FileRemove -> VMware::VMServerd::FileManager::FileRemove_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_GetHomeDir -> VMware::VMServerd::FileManager::GetHomeDir_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_GetParentDir -> VMware::VMServerd::FileManager::GetParentDir_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_ListDir -> VMware::VMServerd::FileManager::ListDir_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_ListDirTree -> VMware::VMServerd::FileManager::ListDirTree_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_MakeDir -> VMware::VMServerd::FileManager::MakeDir_Handler (authuser)
Apr 12 01:10:14: app| Op FileManager_RemoveDir -> VMware::VMServerd::FileManager::RemoveDir_Handler (authuser)
Apr 12 01:10:14: app| Op File_Copy -> VMware::VMServerd::Handlers::File_Copy_Handler (authuser)
Apr 12 01:10:14: app| Op File_Create -> VMware::VMServerd::Handlers::File_Create_Handler (authuser)
Apr 12 01:10:14: app| Op File_Delete -> VMware::VMServerd::Handlers::File_Delete_Handler (authuser)
Apr 12 01:10:14: app| Op File_Exists -> VMware::VMServerd::Handlers::File_Exists_Handler (authuser)
Apr 12 01:10:14: app| Op File_Read -> VMware::VMServerd::Handlers::File_Read_Handler (authuser)
Apr 12 01:10:14: app| Op File_ReadLastN -> VMware::VMServerd::Handlers::File_ReadLastN_Handler (authuser)
Apr 12 01:10:14: app| Op GSXHostInfo_GetDiskSpace -> VMware::VMServerd::GSXHostInfo::GetDiskSpace_Handler (authuser)
Apr 12 01:10:14: app| Op GSXHostInfo_Query -> VMware::VMServerd::GSXHostInfo::Query_Handler (authuser)
Apr 12 01:10:14: app| Op Host_GetBridgedNet -> VMware::VMServerd::Handlers::Host_GetBridgedNet_Handler (authuser)
Apr 12 01:10:14: app| Op Host_GetHostOnlyNet -> VMware::VMServerd::Handlers::Host_GetHostOnlyNet_Handler (authuser)
Apr 12 01:10:14: app| Op Host_GetVirtualNet -> VMware::VMServerd::Handlers::Host_GetVirtualNet_Handler (authuser)
Apr 12 01:10:14: app| Op Security_ActivateConfig -> VMware::VMServerd::SecurityEdit::ActivateConfig_Handler (rootonly)
Apr 12 01:10:14: app| Op Security_CreateCertificate -> VMware::VMServerd::SecurityEdit::CreateCertificate_Handler (rootonly)
Apr 12 01:10:14: app| Op Security_GetConfig -> VMware::VMServerd::SecurityEdit::GetConfig_Handler (rootonly)
Apr 12 01:10:14: app| Op TaskManager_DeleteTask -> VMware::VMServerd::TaskManager::DeleteTask_Handler (authuser)
Apr 12 01:10:14: app| Op TaskManager_StatusOfTask -> VMware::VMServerd::TaskManager::StatusOfTask_Handler (authuser)
Apr 12 01:10:14: app| Op TaskManager_StopTask -> VMware::VMServerd::TaskManager::StopTask_Handler (authuser)
Apr 12 01:10:14: app| Op VMConfigDefaults_GetAll -> VMware::VMServerd::VMConfigDefaults::GetAll_Handler (authuser)
Apr 12 01:10:14: app| Op VMConfigDefaults_GetConfigVersion -> VMware::VMServerd::VMConfigDefaults::GetConfigVersion_Handler (authuser)
Apr 12 01:10:14: app| Op VMDeleteEdit_DeleteVM -> VMware::VMServerd::VMDeleteEdit::DeleteVM_Handler (authuser)
Apr 12 01:10:14: app| Op VMDeleteInfo_DeleteVMInfo -> VMware::VMServerd::VMDeleteInfo::DeleteVMInfo_Handler (authuser)
Apr 12 01:10:14: app| Op VMRegister -> VMware::VMServerd::VMList::Register_Handler (authuser)
Apr 12 01:10:14: app| Op VMServerd_GetConnectedVMList -> VMware::VMServerd::GetConnectedVMList_Handler (authuser)
Apr 12 01:10:14: app| Op VMServerd_GetOperationTable -> VMware::VMServerd::GetOperationTable_Handler (authuser)
Apr 12 01:10:14: app| Op VMServerd_GetProductInfo -> VMware::VMServerd::GetProductInfo_Handler (authuser)
Apr 12 01:10:14: app| Op VMServerd_GetRequestCount -> VMware::VMServerd::GetRequestCount_Handler (authuser)
Apr 12 01:10:14: app| Op VMServerd_IsAdminUser -> VMware::VMServerd::IsAdminUser_Handler (authuser)
Apr 12 01:10:14: app| Op VMUnRegister -> VMware::VMServerd::VMList::UnRegister_Handler (authuser)
Apr 12 01:10:14: app| Op VM_GetLastNEvents -> VMware::VMServerd::EventLog::VM_GetLastNEvents_Handler (authuser)
Apr 12 01:10:14: app| Op VM_INFO -> VMware::VMServerd::Info::VM_Info_Handler (authuser)
Apr 12 01:10:14: app| Op VM_Who -> VMware::VMServerd::Who::VM_Who_Handler (authuser)
Apr 12 01:10:14: app| Op dec -> main::decrement (authuser)
Apr 12 01:10:14: app| Op div -> main::divide (authuser)
Apr 12 01:10:14: app| Op inc -> main::increment (authuser)
Apr 12 01:10:14: app| 
Apr 12 01:10:14: app| LimitResources: limited address space size to 122976 kB
Apr 12 01:10:14: app| LimitResources: limited open fds to 2048
Apr 12 01:10:14: app| DB Handle: 0x89524c8
Apr 12 01:10:14: app| Debug level changing: Old: 0 : New: 2
Apr 12 01:10:14: app| SP: Adding from MemPool
Apr 12 01:10:14: app| SP: Allocated a new security policy
Apr 12 01:10:14: app| SP: Ref count incremented to :1
Apr 12 01:10:14: app| SP: Ref count incremented to :2
Apr 12 01:10:14: app| SP: Ref count decremented to :1
Apr 12 01:10:15: app| HOSTINFO: Seeing Intel CPU, numCoresPerCPU 2 numThreadsPerCore 1.
Apr 12 01:10:15: app| HOSTINFO: This machine has 1 physical CPUS, 2 total cores, and 2 logical CPUs.
Apr 12 01:10:15: app| SP: Host ID set to : /host2/#9e45edca9d3158a6/
Apr 12 01:10:15: app| SP: Registered with poll loop
Apr 12 01:10:15: app| vmsd_register: vm-list path is: /etc/vmware/vm-list
Apr 12 01:10:15: app| vmsd_register: Loading VM: /srv/vmware/vista/Windows Vista.vmx
Apr 12 01:10:15: app| SP: Adding VM: /srv/vmware/vista/Windows Vista.vmx, /vm/#991ef6a83b414da5, 0000000, 0000000
Apr 12 01:10:15: app| SP: Removing VM: /srv/vmware/vista/Windows Vista.vmx
Apr 12 01:10:15: app| SP: Adding VM: /srv/vmware/vista/Windows Vista.vmx, /vm/#991ef6a83b414da5, 0000001, 0000001
Apr 12 01:10:15: app| vm-list: private vm-list path is: /etc/vmware/vm-list-private
Apr 12 01:10:15: app| vmsd_register: Loading VM: /srv/vmware/netbsd/netbsd.vmx
Apr 12 01:10:15: app| SP: Adding VM: /srv/vmware/netbsd/netbsd.vmx, /vm/#e18a6e17f0401b8c, 0000002, 0000002
Apr 12 01:10:15: app| Error when reading from snhelper: Error:7:A needed file was not found
Apr 12 01:10:15: app| Undopoint_GetWorkingDirectory failed.
Apr 12 01:10:15: app| Error when reading from snhelper: Error:7:A needed file was not found
Apr 12 01:10:15: app| Undopoint_GetWorkingDirectory failed.
Apr 12 01:10:15: app| SP: Removing VM: /srv/vmware/netbsd/netbsd.vmx
Apr 12 01:10:15: app| SP: Adding VM: /srv/vmware/netbsd/netbsd.vmx, /vm/#e18a6e17f0401b8c, 0000003, 0000003
Apr 12 01:10:15: app| Set my connectionID to 127.0.1.1
Apr 12 01:10:15: app| [Netmap_OpenAlways] path: /etc/vmware/netmap.conf /build/mts/release/bora-80187/pompeii15/bora/lib/netmap/netmap.c:170
Apr 12 01:10:15: app| [Netmap_OpenAlways] path: /etc/vmware/netmap.conf exists. /build/mts/release/bora-80187/pompeii15/bora/lib/netmap/netmap.c:177
Apr 12 01:10:15: app| [Netmap_OpenAlways] path: /etc/vmware/netmap.conf exists. netmap 0x8b54000. /build/mts/release/bora-80187/pompeii15/bora/lib/netmap/netmap.c:183
Apr 12 01:10:15: app| VmsdNetworkPopulate: There is nothing in netmap
Apr 12 01:10:15: app| VM suddenly changed state: poweredOff.
Apr 12 01:10:15: app| VM suddenly changed state: poweredOff.
Apr 12 01:10:15: app| impersonate Impersonate_Undo called when refCount == 0
Apr 12 01:10:15: app| Serverd hostname: delta.bilbrey
Apr 12 01:10:15: app| Setting up serverd discovery channel for vmxes
Apr 12 01:10:15: app| Successfully set up serverd discovery channel for vmxes
Apr 12 01:10:15: app| vmware-serverd entering main loop.
Apr 12 01:10:30: app| New connection on socket server-vmdb from host localhost (ip address: local) , user: chip
Apr 12 01:10:30: app| SP: New user session for user: chip, pos: 0
Apr 12 01:10:30: app| The vm-list file has changed! Reloading the list of registered vms
Apr 12 01:10:30: app| SP: Retrieved username: chip
Apr 12 01:10:30: app| SP: Retrieved username: chip
Apr 12 01:10:30: app| Error when reading from snhelper: Error:25:The system cannot find the file specified
Apr 12 01:10:30: app| VMHS: failed to open '/srv/vmware/netbsd/netbsd.vmdk' : The system cannot find the file specified (25)
Apr 12 01:10:30: app| Cmd /host2/#9e45edca9d3158a6/util/disk/cmd/##41_78/op/getDiskInfo/ failed: The system cannot find the file specified
Apr 12 01:10:33: app| Adding to list of running vms: /srv/vmware/vista/Windows Vista.vmx
Apr 12 01:10:33: app| Attempting to launch vmx : /srv/vmware/vista/Windows Vista.vmx
Apr 12 01:10:33: app| Error during launch: 11, The process exited with an error:
Apr 12 01:10:33: app| End of error message
Apr 12 01:10:33: app| VmsdVmStatePendingCmdFailed: cmd status is already set