Dec 17 22:54:04.381: vmx| Log for VMware Workstation pid=8189 version=6.5.1 build=build-126130 option=Release
Dec 17 22:54:04.381: vmx| Host codepage=UTF-8 encoding=UTF-8
Dec 17 22:54:04.382: vmx| Hostname=linux-k3md.site
Dec 17 22:54:04.382: vmx| IP=127.0.0.1 (lo)
Dec 17 22:54:04.382: vmx| IP=127.0.0.2 (lo)
Dec 17 22:54:04.382: vmx| IP=192.168.1.5 (wlan0)
Dec 17 22:54:04.382: vmx| IP=192.168.222.1 (vmnet0)
Dec 17 22:54:04.382: vmx| Command line: "/usr/lib/vmware/bin/vmware-vmx" "-#" "product=1;name=VMware Workstation;version=6.5.1;buildnumber=126130;licensename=VMware Workstation for Linux;licenseversion=6.0 build-126130;" "-@" "pipe=/tmp/vmware-pavel/vmx5795a6b86261b5db;readyEvent=144" "/home/pavel/vmware/Windows XP Professional/Windows XP Professional.vmx"
Dec 17 22:54:04.382: vmx| Msg_SetLocale: HostLocale=UTF-8 UserLocale=NULL
Dec 17 22:54:04.382: vmx| Ready event: 144
Dec 17 22:54:04.428: vmx| UI Connecting to pipe '/tmp/vmware-pavel/vmx5795a6b86261b5db' with user '(null)'
Dec 17 22:54:04.433: vmx| Setup symlink /var/run/vmware/a39f68553accf35dbbef2a2b7a487ed8 -> /var/run/vmware/pavel_1000/1229543644382477_8189
Dec 17 22:54:04.433: vmx| Sig_Init already initialized
Dec 17 22:54:04.435: vmx| Transitioned vmx/execState/val to poweredOff
Dec 17 22:54:04.435: vmx| VMMon_GetkHzEstimate: Calculated 1289989 kHz
Dec 17 22:54:04.436: vmx| CPU kHz estimates: vmmon 1289989, cpuinfo 1601000, cpufreq 1601000. Using 1601000 kHz
Dec 17 22:54:04.436: vmx| CPU # 0 TSC = 551331415920
Dec 17 22:54:04.436: vmx| CPU # 1 TSC = 551332239240
Dec 17 22:54:04.437: vmx| TSC delta 823320
Dec 17 22:54:04.437: vmx| PTSC: RefClockToTSC 1000000Hz -> 1601000000Hz
Dec 17 22:54:04.437: vmx| PTSC: RefClockToTSC ((x * 3357540352) >> 21)
Dec 17 22:54:04.437: vmx| PTSC: using reference clock
Dec 17 22:54:04.437: vmx| CPUID[0] vendor: GenuntelineI
Dec 17 22:54:04.437: vmx| CPUID[0] name: Intel(R) Core(TM)2 Duo CPU L7500 @ 1.60GHz
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000001, 0: 0x000006fb 0x00020800 0x0000e3bd 0xbfebfbff
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x4c202020
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000004, 0: 0x30303537 0x20402020 0x30362e31 0x007a4847
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[0] level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] vendor: GenuntelineI
Dec 17 22:54:04.437: vmx| CPUID[1] name: Intel(R) Core(TM)2 Duo CPU L7500 @ 1.60GHz
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000001, 0: 0x000006fb 0x01020800 0x0000e3bd 0xbfebfbff
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x4c202020
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000004, 0: 0x30303537 0x20402020 0x30362e31 0x007a4847
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| CPUID[1] level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.437: vmx| hostCPUID vendor: GenuntelineI
Dec 17 22:54:04.438: vmx| hostCPUID name: Intel(R) Core(TM)2 Duo CPU L7500 @ 1.60GHz
Dec 17 22:54:04.438: vmx| hostCPUID level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Dec 17 22:54:04.438: vmx| hostCPUID level 00000001, 0: 0x000006fb 0x00020800 0x0000e3bd 0xbfebfbff
Dec 17 22:54:04.438: vmx| hostCPUID level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Dec 17 22:54:04.438: vmx| hostCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001
Dec 17 22:54:04.438: vmx| hostCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Dec 17 22:54:04.438: vmx| hostCPUID level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Dec 17 22:54:04.438: vmx| hostCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000001 0x20100800
Dec 17 22:54:04.438: vmx| hostCPUID level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Dec 17 22:54:04.438: vmx| hostCPUID level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x4c202020
Dec 17 22:54:04.438: vmx| hostCPUID level 80000004, 0: 0x30303537 0x20402020 0x30362e31 0x007a4847
Dec 17 22:54:04.438: vmx| hostCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| hostCPUID level 80000008, 0: 0x00003024 0x00000000 0x00000000 0x00000000
Dec 17 22:54:04.438: vmx| CPUID Maximum Physical Address Bits supported across all CPUs: 36
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x480 = 0x5a08000000000b
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x480 = 0x5a08000000000b
Dec 17 22:54:04.438: vmx| Common: MSR 0x480 = 0x5a08000000000b
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x481 = 0x3f00000016
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x481 = 0x3f00000016
Dec 17 22:54:04.438: vmx| Common: MSR 0x481 = 0x3f00000016
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x482 = 0xf7f9fffe0401e172
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x482 = 0xf7f9fffe0401e172
Dec 17 22:54:04.438: vmx| Common: MSR 0x482 = 0xf7f9fffe0401e172
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x483 = 0x3efff00036dff
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x483 = 0x3efff00036dff
Dec 17 22:54:04.438: vmx| Common: MSR 0x483 = 0x3efff00036dff
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x484 = 0x1fff000011ff
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x484 = 0x1fff000011ff
Dec 17 22:54:04.438: vmx| Common: MSR 0x484 = 0x1fff000011ff
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x485 = 0x403c0
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x485 = 0x403c0
Dec 17 22:54:04.438: vmx| Common: MSR 0x485 = 0x403c0
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x486 = 0x80000021
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x486 = 0x80000021
Dec 17 22:54:04.438: vmx| Common: MSR 0x486 = 0x80000021
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x487 = 0xffffffff
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x487 = 0xffffffff
Dec 17 22:54:04.438: vmx| Common: MSR 0x487 = 0xffffffff
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x488 = 0x2000
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x488 = 0x2000
Dec 17 22:54:04.438: vmx| Common: MSR 0x488 = 0x2000
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x489 = 0x27ff
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x489 = 0x27ff
Dec 17 22:54:04.438: vmx| Common: MSR 0x489 = 0x27ff
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x48a = 0x2c
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x48a = 0x2c
Dec 17 22:54:04.438: vmx| Common: MSR 0x48a = 0x2c
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x48b = 0x100000000
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x48b = 0x100000000
Dec 17 22:54:04.438: vmx| Common: MSR 0x48b = 0x100000000
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x48c = 0
Dec 17 22:54:04.438: vmx| CPU[1]: MSR 0x48c = 0
Dec 17 22:54:04.438: vmx| Common: MSR 0x48c = 0
Dec 17 22:54:04.438: vmx| CPU[0]: MSR 0x48d = 0
Dec 17 22:54:04.439: vmx| CPU[1]: MSR 0x48d = 0
Dec 17 22:54:04.439: vmx| Common: MSR 0x48d = 0
Dec 17 22:54:04.439: vmx| CPU[0]: MSR 0x48e = 0
Dec 17 22:54:04.439: vmx| CPU[1]: MSR 0x48e = 0
Dec 17 22:54:04.439: vmx| Common: MSR 0x48e = 0
Dec 17 22:54:04.439: vmx| CPU[0]: MSR 0x48f = 0
Dec 17 22:54:04.439: vmx| CPU[1]: MSR 0x48f = 0
Dec 17 22:54:04.439: vmx| Common: MSR 0x48f = 0
Dec 17 22:54:04.439: vmx| CPU[0]: MSR 0x490 = 0
Dec 17 22:54:04.439: vmx| CPU[1]: MSR 0x490 = 0
Dec 17 22:54:04.439: vmx| Common: MSR 0x490 = 0
Dec 17 22:54:04.441: vmx| Host ACPI: can't find SRAT
Dec 17 22:54:04.441: vmx| Host: SRAT tables not found in memory
Dec 17 22:54:04.486: vmx| ACL_InitCapabilities: current IPC thread
Dec 17 22:54:04.486: vmx| ACL_InitCapabilities: done
Dec 17 22:54:04.486: vmx| changing directory to /home/pavel/vmware/Windows XP Professional/.
Dec 17 22:54:04.486: vmx| Config file: /home/pavel/vmware/Windows XP Professional/Windows XP Professional.vmx
Dec 17 22:54:04.564: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Dec 17 22:54:04.638: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state poweredOn without reset
Dec 17 22:54:04.638: vmx| PowerOn
Dec 17 22:54:04.638: vmx| VMX_PowerOn: VMX build 126130, UI build 126130
Dec 17 22:54:04.639: vmx| Host ACPI: can't find SRAT
Dec 17 22:54:04.639: vmx| Host: SRAT tables not found in memory
Dec 17 22:54:04.647: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Dec 17 22:54:04.655: vmx| HOSTINFO: Seeing Intel CPU, numCoresPerCPU 2 numThreadsPerCore 1.
Dec 17 22:54:04.655: vmx| HOSTINFO: This machine has 1 physical CPUS, 2 total cores, and 2 logical CPUs.
Dec 17 22:54:04.655: vmx| HOST sysname Linux, nodename linux-k3md, release 2.6.25.18-0.2-default, version #1 SMP 2008-10-21 16:30:26 +0200, machine x86_64, SMP, hz=250
Dec 17 22:54:04.655: vmx| DICT --- USER PREFERENCES
Dec 17 22:54:04.655: vmx| DICT pref.grabOnKeyPress = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.eula.0.appName = VMware Workstation
Dec 17 22:54:04.655: vmx| DICT pref.eula.0.buildNumber = 118166
Dec 17 22:54:04.655: vmx| DICT pref.mruDest0.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest0.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest0.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest1.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest1.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest1.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest2.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest2.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest2.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest3.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest3.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest3.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest4.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest4.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest4.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest5.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest5.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest5.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest6.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest6.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest6.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest7.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruDest7.destString =
Dec 17 22:54:04.655: vmx| DICT pref.mruDest7.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS0.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS0.atsString =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS0.domain =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS0.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS0.secure = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS0.port = 0
Dec 17 22:54:04.655: vmx| DICT pref.mruATS1.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS1.atsString =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS1.domain =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS1.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS1.secure = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS1.port = 0
Dec 17 22:54:04.655: vmx| DICT pref.mruATS2.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS2.atsString =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS2.domain =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS2.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS2.secure = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS2.port = 0
Dec 17 22:54:04.655: vmx| DICT pref.mruATS3.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS3.atsString =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS3.domain =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS3.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS3.secure = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS3.port = 0
Dec 17 22:54:04.655: vmx| DICT pref.mruATS4.present = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS4.atsString =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS4.domain =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS4.user =
Dec 17 22:54:04.655: vmx| DICT pref.mruATS4.secure = FALSE
Dec 17 22:54:04.655: vmx| DICT pref.mruATS4.port = 0
Dec 17 22:54:04.656: vmx| DICT pref.mruATS5.present = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.mruATS5.atsString =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS5.domain =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS5.user =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS5.secure = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.mruATS5.port = 0
Dec 17 22:54:04.656: vmx| DICT pref.mruATS6.present = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.mruATS6.atsString =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS6.domain =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS6.user =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS6.secure = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.mruATS6.port = 0
Dec 17 22:54:04.656: vmx| DICT pref.mruATS7.present = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.mruATS7.atsString =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS7.domain =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS7.user =
Dec 17 22:54:04.656: vmx| DICT pref.mruATS7.secure = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.mruATS7.port = 0
Dec 17 22:54:04.656: vmx| DICT pref.tip.index = 5
Dec 17 22:54:04.656: vmx| DICT pref.registrationViewed = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.usbDev.maxDevs = 0
Dec 17 22:54:04.656: vmx| DICT pref.keyboardAndMouse.maxProfiles = 0
Dec 17 22:54:04.656: vmx| DICT webUpdate.lastCheckTime = 1229375350
Dec 17 22:54:04.656: vmx| DICT pref.placement.left = 0
Dec 17 22:54:04.656: vmx| DICT pref.placement.top = 0
Dec 17 22:54:04.656: vmx| DICT pref.placement.right = 1024
Dec 17 22:54:04.656: vmx| DICT pref.placement.bottom = 715
Dec 17 22:54:04.656: vmx| DICT prefvmx.defaultVMPath = /home/pavel/vmware
Dec 17 22:54:04.656: vmx| DICT pref.eula.1.appName = VMware Player
Dec 17 22:54:04.656: vmx| DICT pref.eula.1.buildNumber = 118166
Dec 17 22:54:04.656: vmx| DICT vmWizard.mruISO0.isoLocation = /home/pavel/Downloads/Torrents/WinXP Pro SP3 Rus VL July 15/WinXPSP3_Rus_VL.iso
Dec 17 22:54:04.656: vmx| DICT vmWizard.mode = custom
Dec 17 22:54:04.656: vmx| DICT vmWizard.guestKey = winxppro
Dec 17 22:54:04.656: vmx| DICT vmWizard.installMediaType = iso
Dec 17 22:54:04.656: vmx| DICT pref.ws.openedObj0.present = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.ws.openedObj0.type = vm
Dec 17 22:54:04.656: vmx| DICT pref.ws.openedObj0.path = /vm/#5795a6b86261b5db/
Dec 17 22:54:04.656: vmx| DICT pref.ws.openedObj0.file = /home/pavel/vmware/Windows XP Professional/Windows XP Professional.vmx
Dec 17 22:54:04.656: vmx| DICT pref.ws.openedObj0.dest = /host2/#_client/
Dec 17 22:54:04.656: vmx| DICT pref.ws.openedObj.maxNum = 1
Dec 17 22:54:04.656: vmx| DICT hint.guestos.xp = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.ws.currentObj.path = /vm/#5795a6b86261b5db/
Dec 17 22:54:04.656: vmx| DICT pref.ws.currentObj.type = vm
Dec 17 22:54:04.656: vmx| DICT pref.tip.startup = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.autoFitGuestToWindow = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.view.navBar.width = 156
Dec 17 22:54:04.656: vmx| DICT pref.fullscreen.autohide = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder.maxNum = 3
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder0.enabled = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder0.vmPath = /vm/#5795a6b86261b5db/
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder0.guestName = Documents
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder0.hostPath = /home/pavel/Documents
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder1.enabled = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder1.vmPath = /vm/#5795a6b86261b5db/
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder1.guestName = Downloads
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder1.hostPath = /home/pavel/Downloads
Dec 17 22:54:04.656: vmx| DICT webUpdate.enabled = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.defaultVirtualHW.useLatest = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.defaultVirtualHW.version = 7
Dec 17 22:54:04.656: vmx| DICT hint.vmui.showAllUSBDevs = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.motionUngrab = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.autoFitFullScreen = fitGuestToHost
Dec 17 22:54:04.656: vmx| DICT pref.view.navBar = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.view.statusBar = TRUE
Dec 17 22:54:04.656: vmx| DICT pref.view.tabs = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.view.toolbars.style = default
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder2.enabled = FALSE
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder2.vmPath = /vm/#5795a6b86261b5db/
Dec 17 22:54:04.656: vmx| DICT pref.sharedFolder2.guestName = Music
Dec 17 22:54:04.657: vmx| DICT pref.sharedFolder2.hostPath = /home/pavel/Music
Dec 17 22:54:04.657: vmx| DICT webUpdate.updatesAvailable = FALSE
Dec 17 22:54:04.657: vmx| DICT hint.vmui.poweroff = FALSE
Dec 17 22:54:04.657: vmx| DICT pref.autoFit = TRUE
Dec 17 22:54:04.657: vmx| DICT pref.eula.2.appName = VMware Workstation
Dec 17 22:54:04.657: vmx| DICT pref.eula.2.buildNumber = 126130
Dec 17 22:54:04.657: vmx| DICT pref.motionGrab = TRUE
Dec 17 22:54:04.657: vmx| DICT pref.hideCursorOnUngrab = TRUE
Dec 17 22:54:04.657: vmx| DICT pref.eula.3.appName = VMware Player
Dec 17 22:54:04.657: vmx| DICT pref.eula.3.buildNumber = 126130
Dec 17 22:54:04.657: vmx| DICT pref.vmplayer.vmPos0.index = 0
Dec 17 22:54:04.657: vmx| DICT pref.vmplayer.vmPos0.vmPath = /vm/#5795a6b86261b5db/
Dec 17 22:54:04.657: vmx| DICT pref.vmplayer.vmPos0.geometry = 648x543+173+76
Dec 17 22:54:04.657: vmx| DICT pref.gamingMouseMode = absoluteMouse
Dec 17 22:54:04.657: vmx| DICT --- USER DEFAULTS
Dec 17 22:54:04.657: vmx| DICT --- HOST DEFAULTS
Dec 17 22:54:04.657: vmx| DICT product.name = VMware Workstation
Dec 17 22:54:04.657: vmx| DICT vix.libdir = /usr/lib/vmware-vix
Dec 17 22:54:04.657: vmx| DICT vmware.fullpath = /usr/bin/vmware
Dec 17 22:54:04.657: vmx| DICT NETWORKING = yes
Dec 17 22:54:04.657: vmx| DICT VMBLOCK_CONFED = yes
Dec 17 22:54:04.657: vmx| DICT gksu.rootMethod = su
Dec 17 22:54:04.657: vmx| DICT libdir = /usr/lib/vmware
Dec 17 22:54:04.657: vmx| DICT VMCI_CONFED = yes
Dec 17 22:54:04.657: vmx| DICT VSOCK_CONFED = yes
Dec 17 22:54:04.657: vmx| DICT initscriptdir = /etc/init.d
Dec 17 22:54:04.657: vmx| DICT authd.fullpath = /usr/sbin/vmware-authd
Dec 17 22:54:04.657: vmx| DICT bindir = /usr/bin
Dec 17 22:54:04.657: vmx| DICT product.buildNumber = 126130
Dec 17 22:54:04.657: vmx| DICT product.version = 6.5.1
Dec 17 22:54:04.657: vmx| DICT --- SITE DEFAULTS
Dec 17 22:54:04.657: vmx| DICT tag.help = introduction.htm
Dec 17 22:54:04.657: vmx| DICT tag.configurationEditor = config_editor_newvm.htm
Dec 17 22:54:04.657: vmx| DICT tag.ideConfig = devices_virtualdrive.htm
Dec 17 22:54:04.657: vmx| DICT tag.floppyConfig = devices_floppy.htm
Dec 17 22:54:04.657: vmx| DICT tag.mouseConfig = devices_mouse.htm
Dec 17 22:54:04.657: vmx| DICT tag.netConfig = devices_netadapter.htm
Dec 17 22:54:04.657: vmx| DICT tag.parallelConfig = devices_parallel.htm
Dec 17 22:54:04.657: vmx| DICT tag.serialConfig = devices_serial.htm
Dec 17 22:54:04.657: vmx| DICT tag.soundConfig = devices_sound.htm
Dec 17 22:54:04.657: vmx| DICT tag.memConfig = configvm_memory.htm
Dec 17 22:54:04.657: vmx| DICT tag.miscConfig = configvm.htm
Dec 17 22:54:04.657: vmx| DICT tag.usbConfig = devices_usb.htm
Dec 17 22:54:04.657: vmx| DICT tag.displayConfig = configvm_display-problems.htm
Dec 17 22:54:04.657: vmx| DICT tag.tools = vmtools.htm
Dec 17 22:54:04.657: vmx| DICT --- COMMAND LINE
Dec 17 22:54:04.657: vmx| DICT gui.available = TRUE
Dec 17 22:54:04.657: vmx| DICT --- CONFIGURATION
Dec 17 22:54:04.657: vmx| DICT config.version = 8
Dec 17 22:54:04.657: vmx| DICT virtualHW.version = 7
Dec 17 22:54:04.657: vmx| DICT numvcpus = 2
Dec 17 22:54:04.657: vmx| DICT scsi0.present = TRUE
Dec 17 22:54:04.657: vmx| DICT memsize = 512
Dec 17 22:54:04.658: vmx| DICT scsi0:0.present = TRUE
Dec 17 22:54:04.658: vmx| DICT scsi0:0.fileName = Windows XP Professional-000001.vmdk
Dec 17 22:54:04.658: vmx| DICT ide1:0.present = TRUE
Dec 17 22:54:04.658: vmx| DICT ide1:0.fileName = auto detect
Dec 17 22:54:04.658: vmx| DICT ide1:0.deviceType = cdrom-raw
Dec 17 22:54:04.658: vmx| DICT floppy0.fileType = device
Dec 17 22:54:04.658: vmx| DICT floppy0.fileName =
Dec 17 22:54:04.658: vmx| DICT floppy0.clientDevice = FALSE
Dec 17 22:54:04.658: vmx| DICT ethernet0.present = TRUE
Dec 17 22:54:04.658: vmx| DICT ethernet0.connectionType = custom
Dec 17 22:54:04.658: vmx| DICT ethernet0.wakeOnPcktRcv = FALSE
Dec 17 22:54:04.658: vmx| DICT usb.present = TRUE
Dec 17 22:54:04.658: vmx| DICT ehci.present = TRUE
Dec 17 22:54:04.658: vmx| DICT sound.present = TRUE
Dec 17 22:54:04.658: vmx| DICT sound.fileName = /dev/dsp
Dec 17 22:54:04.658: vmx| DICT sound.autodetect = FALSE
Dec 17 22:54:04.658: vmx| DICT mks.enable3d = TRUE
Dec 17 22:54:04.658: vmx| DICT pciBridge0.present = TRUE
Dec 17 22:54:04.658: vmx| DICT pciBridge4.present = TRUE
Dec 17 22:54:04.658: vmx| DICT pciBridge4.virtualDev = pcieRootPort
Dec 17 22:54:04.658: vmx| DICT pciBridge4.functions = 8
Dec 17 22:54:04.658: vmx| DICT pciBridge5.present = TRUE
Dec 17 22:54:04.658: vmx| DICT pciBridge5.virtualDev = pcieRootPort
Dec 17 22:54:04.658: vmx| DICT pciBridge5.functions = 8
Dec 17 22:54:04.658: vmx| DICT pciBridge6.present = TRUE
Dec 17 22:54:04.658: vmx| DICT pciBridge6.virtualDev = pcieRootPort
Dec 17 22:54:04.658: vmx| DICT pciBridge6.functions = 8
Dec 17 22:54:04.658: vmx| DICT pciBridge7.present = TRUE
Dec 17 22:54:04.658: vmx| DICT pciBridge7.virtualDev = pcieRootPort
Dec 17 22:54:04.658: vmx| DICT pciBridge7.functions = 8
Dec 17 22:54:04.658: vmx| DICT vmci0.present = TRUE
Dec 17 22:54:04.658: vmx| DICT buslogic.noDriver = FALSE
Dec 17 22:54:04.658: vmx| DICT roamingVM.exitBehavior = go
Dec 17 22:54:04.658: vmx| DICT displayName = Windows XP Professional
Dec 17 22:54:04.658: vmx| DICT guestOS = winxppro
Dec 17 22:54:04.658: vmx| DICT nvram = Windows XP Professional.nvram
Dec 17 22:54:04.658: vmx| DICT virtualHW.productCompatibility = hosted
Dec 17 22:54:04.658: vmx| DICT ft.secondary0.enabled = TRUE
Dec 17 22:54:04.658: vmx| DICT tools.upgrade.policy = useGlobal
Dec 17 22:54:04.658: vmx| DICT extendedConfigFile = Windows XP Professional.vmxf
Dec 17 22:54:04.658: vmx| DICT ethernet0.addressType = generated
Dec 17 22:54:04.658: vmx| DICT tools.syncTime = FALSE
Dec 17 22:54:04.658: vmx| DICT uuid.location = 56 4d c4 76 4b a5 29 d0-26 d6 b4 09 08 49 4d 7d
Dec 17 22:54:04.658: vmx| DICT uuid.bios = 56 4d c4 76 4b a5 29 d0-26 d6 b4 09 08 49 4d 7d
Dec 17 22:54:04.658: vmx| DICT scsi0:0.redo =
Dec 17 22:54:04.658: vmx| DICT vmotion.checkpointFBSize = 134217728
Dec 17 22:54:04.658: vmx| DICT pciBridge0.pciSlotNumber = 17
Dec 17 22:54:04.658: vmx| DICT pciBridge4.pciSlotNumber = 21
Dec 17 22:54:04.658: vmx| DICT pciBridge5.pciSlotNumber = 22
Dec 17 22:54:04.658: vmx| DICT pciBridge6.pciSlotNumber = 23
Dec 17 22:54:04.658: vmx| DICT pciBridge7.pciSlotNumber = 24
Dec 17 22:54:04.658: vmx| DICT scsi0.pciSlotNumber = 16
Dec 17 22:54:04.658: vmx| DICT usb.pciSlotNumber = 32
Dec 17 22:54:04.658: vmx| DICT ethernet0.pciSlotNumber = 33
Dec 17 22:54:04.658: vmx| DICT sound.pciSlotNumber = 34
Dec 17 22:54:04.658: vmx| DICT ehci.pciSlotNumber = 35
Dec 17 22:54:04.658: vmx| DICT vmci0.pciSlotNumber = 36
Dec 17 22:54:04.658: vmx| DICT usb:0.present = TRUE
Dec 17 22:54:04.658: vmx| DICT usb:1.present = TRUE
Dec 17 22:54:04.658: vmx| DICT ethernet0.generatedAddress = 00:0c:29:49:4d:7d
Dec 17 22:54:04.659: vmx| DICT ethernet0.generatedAddressOffset = 0
Dec 17 22:54:04.659: vmx| DICT vmci0.id = 139021693
Dec 17 22:54:04.659: vmx| DICT usb:1.deviceType = hub
Dec 17 22:54:04.659: vmx| DICT usb:0.deviceType = mouse
Dec 17 22:54:04.659: vmx| DICT floppy0.autodetect = TRUE
Dec 17 22:54:04.659: vmx| DICT ide1:0.autodetect = TRUE
Dec 17 22:54:04.659: vmx| DICT ide1:0.startConnected = FALSE
Dec 17 22:54:04.659: vmx| DICT floppy0.startConnected = FALSE
Dec 17 22:54:04.659: vmx| DICT usb.autoConnect.device0 = path:5/1 autoclean:1
Dec 17 22:54:04.659: vmx| DICT isolation.tools.hgfs.disable = FALSE
Dec 17 22:54:04.659: vmx| DICT sharedFolder.maxNum = 3
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.present = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.enabled = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.readAccess = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.writeAccess = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.hostPath = /home/pavel/Documents
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.guestName = Documents
Dec 17 22:54:04.659: vmx| DICT sharedFolder0.expiration = never
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.present = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.enabled = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.readAccess = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.writeAccess = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.hostPath = /home/pavel/Downloads
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.guestName = Downloads
Dec 17 22:54:04.659: vmx| DICT sharedFolder1.expiration = never
Dec 17 22:54:04.659: vmx| DICT checkpoint.vmState =
Dec 17 22:54:04.659: vmx| DICT svga.autodetect = FALSE
Dec 17 22:54:04.659: vmx| DICT svga.maxWidth = 1024
Dec 17 22:54:04.659: vmx| DICT svga.maxHeight = 768
Dec 17 22:54:04.659: vmx| DICT svga.vramSize = 134217728
Dec 17 22:54:04.659: vmx| DICT vmmouse.present = FALSE
Dec 17 22:54:04.659: vmx| DICT ethernet0.linkStatePropagation.enable = FALSE
Dec 17 22:54:04.659: vmx| DICT ethernet0.vnet = /dev/vmnet0
Dec 17 22:54:04.659: vmx| DICT usb.generic.allowHID = TRUE
Dec 17 22:54:04.659: vmx| DICT usb.autoConnect.device1 = path:3/0 autoclean:1
Dec 17 22:54:04.659: vmx| DICT usb.generic.autoconnect = TRUE
Dec 17 22:54:04.659: vmx| DICT usb.autoConnect.device2 =
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.present = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.enabled = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.readAccess = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.writeAccess = TRUE
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.hostPath = /home/pavel/Music
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.guestName = Music
Dec 17 22:54:04.659: vmx| DICT sharedFolder2.expiration = never
Dec 17 22:54:04.659: vmx| DICT sound.startConnected = FALSE
Dec 17 22:54:04.659: vmx| DICT --- USER DEFAULTS
Dec 17 22:54:04.659: vmx| DICT --- HOST DEFAULTS
Dec 17 22:54:04.659: vmx| DICT product.name = VMware Workstation
Dec 17 22:54:04.659: vmx| DICT vix.libdir = /usr/lib/vmware-vix
Dec 17 22:54:04.659: vmx| DICT vmware.fullpath = /usr/bin/vmware
Dec 17 22:54:04.660: vmx| DICT NETWORKING = yes
Dec 17 22:54:04.660: vmx| DICT VMBLOCK_CONFED = yes
Dec 17 22:54:04.660: vmx| DICT gksu.rootMethod = su
Dec 17 22:54:04.660: vmx| DICT libdir = /usr/lib/vmware
Dec 17 22:54:04.660: vmx| DICT VMCI_CONFED = yes
Dec 17 22:54:04.660: vmx| DICT VSOCK_CONFED = yes
Dec 17 22:54:04.660: vmx| DICT initscriptdir = /etc/init.d
Dec 17 22:54:04.660: vmx| DICT authd.fullpath = /usr/sbin/vmware-authd
Dec 17 22:54:04.660: vmx| DICT bindir = /usr/bin
Dec 17 22:54:04.660: vmx| DICT product.buildNumber = 126130
Dec 17 22:54:04.660: vmx| DICT product.version = 6.5.1
Dec 17 22:54:04.660: vmx| DICT --- SITE DEFAULTS
Dec 17 22:54:04.660: vmx| DICT tag.help = introduction.htm
Dec 17 22:54:04.660: vmx| DICT tag.configurationEditor = config_editor_newvm.htm
Dec 17 22:54:04.660: vmx| DICT tag.ideConfig = devices_virtualdrive.htm
Dec 17 22:54:04.660: vmx| DICT tag.floppyConfig = devices_floppy.htm
Dec 17 22:54:04.660: vmx| DICT tag.mouseConfig = devices_mouse.htm
Dec 17 22:54:04.660: vmx| DICT tag.netConfig = devices_netadapter.htm
Dec 17 22:54:04.660: vmx| DICT tag.parallelConfig = devices_parallel.htm
Dec 17 22:54:04.660: vmx| DICT tag.serialConfig = devices_serial.htm
Dec 17 22:54:04.660: vmx| DICT tag.soundConfig = devices_sound.htm
Dec 17 22:54:04.660: vmx| DICT tag.memConfig = configvm_memory.htm
Dec 17 22:54:04.660: vmx| DICT tag.miscConfig = configvm.htm
Dec 17 22:54:04.660: vmx| DICT tag.usbConfig = devices_usb.htm
Dec 17 22:54:04.660: vmx| DICT tag.displayConfig = configvm_display-problems.htm
Dec 17 22:54:04.660: vmx| DICT tag.tools = vmtools.htm
Dec 17 22:54:04.660: vmx| DICT --- GLOBAL SETTINGS
Dec 17 22:54:04.660: vmx| Msg_Hint: msg.guestos.xp (sent)
Dec 17 22:54:04.660: vmx| The Microsoft Windows XP product activation feature creates a key based on the virtual hardware in the virtual machine where it is installed. Changes in the virtual machine configuration may require you to reactivate the guest operating system. To minimize those changes, be sure to set the final memory size for the virtual machine and install VMware Tools before you activate Windows XP.
Dec 17 22:54:04.660: vmx| For more information about Windows XP product activation and virtual machines see our Web site at "http://vmware.com/info?id=50".
Dec 17 22:54:04.660: vmx| ---------------------------------------
Dec 17 22:54:04.800: vmx| hostCpuFeatures = 0x404001fc
Dec 17 22:54:04.800: vmx| hostNumPerfCounters = 2
Dec 17 22:54:04.800: vmx| CPU0: PMC: IA32, CORE 2 [c:0 f:1 e:1]
Dec 17 22:54:04.801: vmx| CPU1: PMC: IA32, CORE 2 [c:0 f:1 e:1]
Dec 17 22:54:04.801: vmx| MONITOR MODE: allowed modes : BT
Dec 17 22:54:04.801: vmx| MONITOR MODE: user requested modes : BT HV HWMMU
Dec 17 22:54:04.801: vmx| MONITOR MODE: guestOS preferred modes: HWMMU HV BT
Dec 17 22:54:04.801: vmx| MONITOR MODE: filtered list : BT
Dec 17 22:54:04.801: vmx| HV Settings: virtual exec = 'software'; virtual mmu = 'software'
Dec 17 22:54:04.859: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Dec 17 22:54:04.866: vmx| Host: Disabling thread priority boosting to work around Linux SMP bug.
Dec 17 22:54:04.866: vmx| WSSCAN: reserved mem (in MB) min=32 max=3808 recommended=3808
Dec 17 22:54:04.866: vmx| WSSCAN: used rec mem (in MB) 3808
Dec 17 22:54:04.866: vmx| PSHARE: deactivated
Dec 17 22:54:04.866: vmx| WSSCAN: Overhead 165174 paged 27158 nonpaged 32768 maxFBSize
Dec 17 22:54:04.866: vmx| WSSCAN 1 0 966656 1132544 974848 -1 50 0
Dec 17 22:54:04.867: vmx| LICENSE using: '/usr/lib/vmware/licenses/user/license.ws.6.0.200610'
Dec 17 22:54:04.885: vmx| LOG failed to remove stats/stats32-2 failed: No such file or directory
Dec 17 22:54:04.885: vmx| LOG failed to remove stats/stats64-2 failed: No such file or directory
Dec 17 22:54:04.885: vmx| LOG failed to remove stats32-2 failed: No such file or directory
Dec 17 22:54:04.885: vmx| LOG failed to remove stats64-2 failed: No such file or directory
Dec 17 22:54:04.886: vmx| Monitor_PowerOn: hostedVSMPMaxSkew is 1500 us (2401500 cycles)
Dec 17 22:54:04.886: vmx| Monitor_PowerOn: hostedVSMPYieldPoint is 50 us (80050 cycles)
Dec 17 22:54:04.887: vmx| vmm32-modules: [vmm.vmm32 .data:0x2b000-0x728 .sdata:0x2c000-0x4e4 .statvars:0x2d000-0x3a0 .peer:0x2e000-0x261c0 .shared:0x56000-0x12ac0 .bss:0x6a000-0x5c88 .rodata:0x71000-0xb310 .text:0x7d000-0x5906d .kstatvars:0x3000-0x0, mmu-pae.vmm32 .rodata:0x7c310-0x44 .data:0x2b728-0xc .peer:0x541c0-0x16c0 .shared:0x68ac0-0x2c0 .bss:0x6fca0-0x518 .text:0xd6070-0xa4e7 .comment:0x40000d26-0x10e .statvars:0x2000-0x0 .kstatvars:0x2000-0x0 .scb:0x400038a0-0x180 .shared_meta:0x40003c00-0x390 .peer_meta:0x40001020-0x210, sharedmmu-none.vmm32 .text:0xe0558-0x32 .comment:0x40000e34-0x12, pv-none.vmm32 .shared:0x68d80-0x180 .bss:0x701c0-0x84 .text:0xe058c-0xe6 .comment:0x40000e46-0x48 .shared_meta:0x40003f90-0x90, vprobe-none.vmm32 .text:0xe0674-0x79 .comment:0x40000e8e-0x12, hv-none.vmm32 .rodata:0x7c354-0x4 .data:0x1000-0x0 .peer:0x1000-0x0 .shared:0x1000-0x0 .bss:0x1000-0x0 .text:0xe06f0-0x2d .comment:0x40000ea0-0x12 .statvars:0x1000-0x0 .kstatvars:0x1000-0x0, gphys-sw.vmm32 .peer:0x55880-0x40 .shared:0x68f00-0x140 .bss:0x2000-0x0 .text:0xe0720-0xb43 .comment:0x40000eb2-0x12 .scb:0x40003a20-0x60 .shared_meta:0x40004020-0x2a0 .peer_meta:0x40001230-0x60, vassert-none.vmm32 .text:0xe1264-0xf .comment:0x40000ec4-0x12, vmsafe-none.vmm32 .text:0xe1274-0xd .comment:0x40000ed6-0x12, buslogic-buslogic.vmm32 .shared:0x69040-0x40 .bss:0x1000-0x0 .text:0xe1290-0xc9 .comment:0x40000ee8-0x12 .scb:0x40003a80-0x60 .shared_meta:0x400042c0-0x60, {SharedAreaReservations} .shared:0x69080-0x40, <MonSrcFile> .rodata:0x7c358-0x38c]
Dec 17 22:54:04.891: vmx| KHZEstimate 1601000
Dec 17 22:54:04.891: vmx| MHZEstimate 1601
Dec 17 22:54:04.891: vmx| NumVCPUs 2
Dec 17 22:54:04.891: vmx| PShare: enabled 0, scanRate 0, checkRate 16
Dec 17 22:54:04.891: vmx| UUID: SMBIOS UUID is reported as 'c7 6e 2e 81 49 96 11 cb-8f 6a cb 90 72 54 64 27'.
Dec 17 22:54:04.891: vmx| UUID: location-UUID is 56 4d c4 76 4b a5 29 d0-26 d6 b4 09 08 49 4d 7d
Dec 17 22:54:04.891: vmx| AIOGNRC: numThreads=18 ide=0, scsi=1, passthru=1
Dec 17 22:54:04.891: vmx| WORKER: Creating new group with numThreads=18 (18)
Dec 17 22:54:04.892: vmx| Replay State = 0
Dec 17 22:54:04.892: vmx| minDEThreshold: 70
Dec 17 22:54:04.892: vmx| MM: Using partialmap, 131072 pages AC 0 CE 1 TM 0 DOHU 0
Dec 17 22:54:04.892: vmx| UUID: location-UUID is 56 4d c4 76 4b a5 29 d0-26 d6 b4 09 08 49 4d 7d
Dec 17 22:54:04.893: vmx| MM: using '/home/pavel/vmware/Windows XP Professional/564dc476-4ba5-29d0-26d6-b40908494d7d.vmem' as a paging file
Dec 17 22:54:04.893: vmx| Opened paging file /home/pavel/vmware/Windows XP Professional/564dc476-4ba5-29d0-26d6-b40908494d7d.vmem
Dec 17 22:54:04.910: vmx| Mapped mainmem as pageable
Dec 17 22:54:04.910: vmx| MMCHK: Disabling checks which are not forced, cannot do checks on certain processors.
Dec 17 22:54:04.910: vmx| MStat: Creating Stat vm.uptime
Dec 17 22:54:04.910: vmx| MStat: Creating Stat vm.suspendTime
Dec 17 22:54:04.910: vmx| MStat: Creating Stat vm.powerOnTimeStamp
Dec 17 22:54:04.910: vmx| VMXAIOMGR: Using: simple=Generic unbuf=Generic
Dec 17 22:54:04.920: vmx| VMXVmdb_LoadRawConfig: Loading raw config
Dec 17 22:54:04.926: vmx| DISK: OPEN scsi0:0 '/home/pavel/vmware/Windows XP Professional/Windows XP Professional-000001.vmdk' persistent R[]
Dec 17 22:54:04.932: vmx| DISKLIB-DSCPTR: Opened [0]: "Windows XP Professional-000001-s001.vmdk" (0xa)
Dec 17 22:54:04.939: vmx| DISKLIB-DSCPTR: Opened [1]: "Windows XP Professional-000001-s002.vmdk" (0xa)
Dec 17 22:54:04.944: vmx| DISKLIB-DSCPTR: Opened [2]: "Windows XP Professional-000001-s003.vmdk" (0xa)
Dec 17 22:54:04.950: vmx| DISKLIB-DSCPTR: Opened [3]: "Windows XP Professional-000001-s004.vmdk" (0xa)
Dec 17 22:54:04.963: vmx| DISKLIB-DSCPTR: Opened [4]: "Windows XP Professional-000001-s005.vmdk" (0xa)
Dec 17 22:54:04.963: vmx| DISKLIB-DSCPTR: Opened [5]: "Windows XP Professional-000001-s006.vmdk" (0xa)
Dec 17 22:54:04.963: vmx| DISKLIB-LINK : Opened '/home/pavel/vmware/Windows XP Professional/Windows XP Professional-000001.vmdk' (0xa): twoGbMaxExtentSparse, 20971520 sectors / 10 GB.
Dec 17 22:54:04.964: vmx| DISKLIB-DSCPTR: Opened [0]: "Windows XP Professional-s001.vmdk" (0xe)
Dec 17 22:54:04.964: vmx| DISKLIB-DSCPTR: Opened [1]: "Windows XP Professional-s002.vmdk" (0xe)
Dec 17 22:54:04.964: vmx| DISKLIB-DSCPTR: Opened [2]: "Windows XP Professional-s003.vmdk" (0xe)
Dec 17 22:54:04.964: vmx| DISKLIB-DSCPTR: Opened [3]: "Windows XP Professional-s004.vmdk" (0xe)
Dec 17 22:54:04.964: vmx| DISKLIB-DSCPTR: Opened [4]: "Windows XP Professional-s005.vmdk" (0xe)
Dec 17 22:54:04.964: vmx| DISKLIB-DSCPTR: Opened [5]: "Windows XP Professional-s006.vmdk" (0xe)
Dec 17 22:54:04.964: vmx| DISKLIB-LINK : Opened '/home/pavel/vmware/Windows XP Professional/Windows XP Professional.vmdk' (0xe): twoGbMaxExtentSparse, 20971520 sectors / 10 GB.
Dec 17 22:54:04.964: vmx| DISKLIB-LIB : Opened "/home/pavel/vmware/Windows XP Professional/Windows XP Professional-000001.vmdk" (flags 0xa).
Dec 17 22:54:04.964: vmx| DiskGetGeometry: Reading of disk partition table
Dec 17 22:54:04.964: vmx| DISK: OPEN '/home/pavel/vmware/Windows XP Professional/Windows XP Professional-000001.vmdk' Geo (1305/255/63) BIOS Geo (1305/255/63) freeSpace=13897 MB, buslogic
Dec 17 22:54:05.334: vmx| TimeTracker host to guest rate conversion 552768929951 @ 1601000000Hz -> 552768929951 @ 1601000000Hz
Dec 17 22:54:05.334: vmx| TimeTracker host to guest rate conversion ((x * 2147483648) >> 31) + 0
Dec 17 22:54:05.335: vmx| USB: Search for USB devices to connect [path:5/1 autoclean:1]
Dec 17 22:54:05.335: vmx| USB: Search for USB devices to connect [path:3/0 autoclean:1]
Dec 17 22:54:05.336: vmx| USB: Initializing 'Generic' backend
Dec 17 22:54:05.336: vmx| USBGL: Usbfs found at /proc/bus/usb
Dec 17 22:54:57.903: vmx| USB: Initializing 'Virtual Hub' backend
Dec 17 22:54:57.903: vmx| USB: Initializing 'Virtual Mouse' backend
Dec 17 22:54:57.903: vmx| USB: Initializing 'Virtual Keyboard' backend
Dec 17 22:54:57.903: vmx| USB: Initializing 'Virtual Mass Storage' backend
Dec 17 22:54:57.903: vmx| USB: Initializing 'Virtual CCID' backend
Dec 17 22:54:57.903: vmx| USB-CCID: dlopened default libpcsclite.so.1.
Dec 17 22:54:57.903: vmx| USB-CCID: Could not establish resource manager context for card ops: SCARD_E_NO_SERVICE(0x8010001d).
Dec 17 22:54:57.903: vmx| USB: Unable to initialize 'Virtual CCID' backend
Dec 17 22:54:58.358: vmx| XINFO X fd is 133
Dec 17 22:54:58.358: vmx| XINFO depth 24 bpp 32 class 4
Dec 17 22:54:58.365: vmx| GLPrimary_Alloc, thread vmx
Dec 17 22:54:58.368: vmx| WORKER: Creating new group with numThreads=1 (19)
Dec 17 22:54:58.368: vmx| MKS REMOTE Loading VNC Configuration from VM config file
Dec 17 22:54:58.371: vmx| VLANCE: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks
Dec 17 22:54:58.371: vmx| VMXNET: send cluster threshold is 80, size = 2 recalcInterval is 2 ticks, dontClusterSize is 128
Dec 17 22:54:58.372: vmx| NetPkt: checksum cycles/kB: C=2673 asm1=2945 asm2=2705
Dec 17 22:54:58.373: vmx| NetPkt: copy and sum cycles/kB: C=2635 asm1=3218 asm2=2668
Dec 17 22:54:58.388: vmx| Chipset version: 0x13
Dec 17 22:54:58.526: vmx| DISKUTIL: ide1:0 : capacity=0
Dec 17 22:54:58.526: vmx| DISKUTIL: ide1:0 : geometry=0/0/0
Dec 17 22:54:58.526: vmx| SCSI0: UNTAGGED commands will be converted to ORDER tags.
Dec 17 22:54:58.526: vmx| DISKUTIL: scsi0:0 : capacity=20971520
Dec 17 22:54:58.526: vmx| DISKUTIL: scsi0:0 : geometry=1305/255/63
Dec 17 22:54:58.527: vmx| SVGA: Advertising 3D acceleration.
Dec 17 22:54:58.527: vmx| USB: Initializing 'UHCI' host controller
Dec 17 22:54:58.528: vmx| Ethernet0 MAC Address: 00:0c:29:49:4d:7d
Dec 17 22:54:58.528: vmx| USB: Initializing 'EHCI' host controller
Dec 17 22:54:58.677: vmx| MStat: Creating Stat vm.heartbeat
Dec 17 22:54:58.678: vmx| DISKUTIL: scsi0:0 : toolsVersion = 7428
Dec 17 22:54:58.678: vmx| TOOLS INSTALL initializing state to IDLE on power on.
Dec 17 22:54:58.682: vmx| PTSC to VMI Wallclock (nsec) 638178981891 @ 1601000000Hz -> 1229543698000000000 @ 1000000000Hz
Dec 17 22:54:58.682: vmx| PTSC to VMI Wallclock (nsec) ((x * 2682677886) >> 32) + 1229543299387269323
Dec 17 22:54:58.682: vmx| PTSC to ParaTime RealCycles 0 @ 1601000000Hz -> 0 @ 1601000000Hz
Dec 17 22:54:58.682: vmx| PTSC to ParaTime RealCycles ((x * 1) >> 0) + 0
Dec 17 22:54:58.682: vmx| ParaTime RealCycles to PTSC 0 @ 1601000000Hz -> 0 @ 1601000000Hz
Dec 17 22:54:58.682: vmx| ParaTime RealCycles to PTSC ((x * 1) >> 0) + 0
Dec 17 22:54:58.682: vmx| memoryHotplug: Current size = 512MB, Minimum size = 512MB, Maximum size = 512MB
Dec 17 22:54:58.682: vmx| memoryHotplug: Entry[0]: 00000000000000A0-00000000000A0000
Dec 17 22:54:58.683: vmx| memoryHotplug: Entry[1]: 00000000001000A0-0000000020000000
Dec 17 22:54:58.685: vmx| guestCpuFeatures = 0x404001f8
Dec 17 22:54:58.685: vmx| guestCPUID vendor: GenuntelineI
Dec 17 22:54:58.685: vmx| guestCPUID name: Intel(R) Core(TM)2 Duo CPU L7500 @ 1.60GHz
Dec 17 22:54:58.685: vmx| guestCPUID level 00000000, 0: 0x0000000a 0x756e6547 0x6c65746e 0x49656e69
Dec 17 22:54:58.685: vmx| guestCPUID level 00000001, 0: 0x000006fb 0x00010800 0x80000201 0x0febfbff
Dec 17 22:54:58.685: vmx| guestCPUID level 00000002, 0: 0x05b0b101 0x005657f0 0x00000000 0x2cb43049
Dec 17 22:54:58.685: vmx| guestCPUID level 00000003, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 00000004, 0: 0x04000121 0x01c0003f 0x0000003f 0x00000001
Dec 17 22:54:58.685: vmx| guestCPUID level 00000005, 0: 0x00000040 0x00000040 0x00000003 0x00022220
Dec 17 22:54:58.685: vmx| guestCPUID level 00000006, 0: 0x00000003 0x00000002 0x00000001 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 00000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 00000008, 0: 0x00000400 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 00000009, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 0000000a, 0: 0x07280202 0x00000000 0x00000000 0x00000503
Dec 17 22:54:58.685: vmx| guestCPUID level 40000000, 0: 0x40000010 0x61774d56 0x4d566572 0x65726177
Dec 17 22:54:58.685: vmx| guestCPUID level 40000010, 0: 0x00186de8 0x000101d0 0x00000000 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 80000000, 0: 0x80000008 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.685: vmx| guestCPUID level 80000001, 0: 0x00000000 0x00000000 0x00000000 0x00100800
Dec 17 22:54:58.685: vmx| guestCPUID level 80000002, 0: 0x65746e49 0x2952286c 0x726f4320 0x4d542865
Dec 17 22:54:58.686: vmx| guestCPUID level 80000003, 0: 0x44203229 0x43206f75 0x20205550 0x4c202020
Dec 17 22:54:58.686: vmx| guestCPUID level 80000004, 0: 0x30303537 0x20402020 0x30362e31 0x007a4847
Dec 17 22:54:58.686: vmx| guestCPUID level 80000005, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.686: vmx| guestCPUID level 80000006, 0: 0x00000000 0x00000000 0x10008040 0x00000000
Dec 17 22:54:58.686: vmx| guestCPUID level 80000007, 0: 0x00000000 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.686: vmx| guestCPUID level 80000008, 0: 0x00003028 0x00000000 0x00000000 0x00000000
Dec 17 22:54:58.696: vmx| BusMemSample: initPercent 75 touched 98304
Dec 17 22:54:58.696: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '1'
Dec 17 22:54:58.697: vmx| TOOLS received request in VMX to set option 'copypaste' -> '1'
Dec 17 22:54:58.739: vmx| USB: Autoconnecting device "Hewlett-Packard HP ScanJet 4400c" matching pattern [path:5/1 autoclean:1]
Dec 17 22:54:58.739: vmx| USB: Connecting device 0x5000203f00705
Dec 17 22:54:58.739: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:54:58.739: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:54:58.739: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:54:58.739: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:54:58.740: vmx| USB: Removing stale autoconnect pattern [path:3/0 autoclean:1]
Dec 17 22:54:58.740: vmx| USB: Removing autoconnect pattern from slot 1
Dec 17 22:54:58.889: vmx| Msg_Hint: msg.usb.autoConnectFailed (sent)
Dec 17 22:54:58.889: vmx| A USB device that was previously attached to this VM could not be automatically reconnected. If the device is still available but resides on a different USB port, you will need to reconnect it manually.
Dec 17 22:54:58.889: vmx| ---------------------------------------
Dec 17 22:57:57.440: vmx| VMX_PowerOn: ModuleTable_PowerOn = 1
Dec 17 22:57:57.440: vmx| VMX setting maximum IPC write buffers to 0 packets, 0 bytes
Dec 17 22:57:57.440: mks| Async MKS thread is alive
Dec 17 22:57:57.440: mks| GLPrimaryInit3D, thread mks
Dec 17 22:57:57.441: mks| GLPrimaryHostConnect thread mks
Dec 17 22:57:57.459: mks| VMGL_UpdateConnection: Updating extension strings for new connection.
Dec 17 22:57:57.459: mks| OpenGL Vendor: "Tungsten Graphics, Inc"
Dec 17 22:57:57.459: mks| OpenGL Renderer: "Mesa DRI Intel(R) 965GM 4.1.3002"
Dec 17 22:57:57.459: mks| OpenGL Version: "1.4 Mesa 7.0.3" (1.4.0)
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ARB_depth_texture GL_ARB_fragment_program GL_ARB_imaging GL_ARB_multisample GL_ARB_multitexture
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ARB_point_parameters GL_ARB_shadow GL_ARB_texture_border_clamp GL_ARB_texture_compression
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ARB_texture_cube_map GL_ARB_texture_env_add GL_ARB_texture_env_combine
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ARB_texture_env_crossbar GL_ARB_texture_env_dot3 GL_ARB_texture_mirrored_repeat
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ARB_texture_non_power_of_two GL_ARB_texture_rectangle GL_ARB_transpose_matrix
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ARB_vertex_buffer_object GL_ARB_vertex_program GL_ARB_window_pos GL_EXT_abgr GL_EXT_bgra
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_blend_color GL_EXT_blend_equation_separate GL_EXT_blend_func_separate GL_EXT_blend_logic_op
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_blend_minmax GL_EXT_blend_subtract GL_EXT_clip_volume_hint GL_EXT_cull_vertex
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_compiled_vertex_array GL_EXT_convolution GL_EXT_copy_texture GL_EXT_draw_range_elements
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_fog_coord GL_EXT_histogram GL_EXT_multi_draw_arrays GL_EXT_packed_pixels
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_point_parameters GL_EXT_polygon_offset GL_EXT_rescale_normal GL_EXT_secondary_color
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_separate_specular_color GL_EXT_shadow_funcs GL_EXT_stencil_wrap GL_EXT_subtexture
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_texture GL_EXT_texture3D GL_EXT_texture_edge_clamp GL_EXT_texture_env_add
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_texture_env_combine GL_EXT_texture_env_dot3 GL_EXT_texture_filter_anisotropic
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_EXT_texture_lod_bias GL_EXT_texture_object GL_EXT_texture_rectangle GL_EXT_vertex_array
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_3DFX_texture_compression_FXT1 GL_APPLE_client_storage GL_APPLE_packed_pixels
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_ATI_blend_equation_separate GL_IBM_rasterpos_clip GL_IBM_texture_mirrored_repeat
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_INGR_blend_func_separate GL_MESA_pack_invert GL_MESA_ycbcr_texture GL_MESA_window_pos
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_NV_blend_square GL_NV_light_max_exponent GL_NV_texture_rectangle GL_NV_texgen_reflection
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_OES_read_format GL_SGI_color_matrix GL_SGI_color_table GL_SGIS_generate_mipmap
Dec 17 22:57:57.459: mks| OpenGL Extensions: GL_SGIS_texture_border_clamp GL_SGIS_texture_edge_clamp GL_SGIS_texture_lod GL_SGIX_depth_texture
Dec 17 22:57:57.460: mks| OpenGL Extensions: GL_SUN_multi_draw_arrays
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_ARB_shader_objects
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_ARB_vertex_shader
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing required extension GL_EXT_texture_compression_s3tc
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_NV_texture_shader
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing required extension GL_EXT_framebuffer_object
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_EXT_texture_mirror_clamp
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_ARB_vertex_blend
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_EXT_stencil_two_side
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_ARB_occlusion_query
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_ARB_shader_texture_lod
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_EXT_framebuffer_blit
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_EXT_packed_depth_stencil
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_ATI_shader_texture_lod
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_EXT_gpu_shader4
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_NV_packed_depth_stencil
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_APPLE_fence
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_NV_fence
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_NV_half_float
Dec 17 22:57:57.460: mks| GLUtil_InstallExtensionLists: Missing extension GL_APPLE_flush_buffer_range
Dec 17 22:57:57.462: mks| Finish HostDisconnect: thread mks
Dec 17 22:57:57.463: vmx| USBG: CONNREQ: Dequeued head request after 178724 ms for [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:57:57.466: vmx| DnDRegisterRpc: DnD rpc already set to 1
Dec 17 22:57:57.466: vmx| CopyPasteRegisterRpc: already set to 1
Dec 17 22:57:57.474: vcpu-0| APIC: version = 0x14, max LVT = 5
Dec 17 22:57:57.474: vcpu-0| APIC: LDR = 0x1000000, DFR = 0xffffffff
Dec 17 22:57:57.497: mks| Connecting to window system.
Dec 17 22:57:57.598: mks| XINFO X fd is 133
Dec 17 22:57:57.599: mks| XINFO depth 24 bpp 32 class 4
Dec 17 22:57:57.619: mks| rasterops MMXEXT accelerations enabled
Dec 17 22:57:57.619: mks| XINFO unsupported XF86VidMode version: 2.2
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 0: 1024x768 flags: 0xa
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 1: 1024x768 flags: 0xa
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 2: 1024x768 flags: 0x0
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 3: 1024x768 flags: 0x9
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 4: 800x600 flags: 0x5
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 5: 800x600 flags: 0x0
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 6: 800x600 flags: 0x5
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 7: 800x600 flags: 0x9
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 8: 640x480 flags: 0xa
Dec 17 22:57:57.619: mks| XINFO XFree86 VidMode 9: 640x480 flags: 0xa
Dec 17 22:57:57.619: mks| KHBKL: Unable to parse keystring at: ''
Dec 17 22:57:57.627: mks| Msg_Post: Information
Dec 17 22:57:57.627: mks| [msg.glBackend.initFailed] 3D graphics acceleration will be disabled. This computer does not have a 3D graphics system supported by VMware Workstation. ----------------------------------------
Dec 17 22:57:57.627: vmx| POLL device deleted
Dec 17 22:57:57.720: vcpu-0| guestCpuFeatures = 0x404001f8
Dec 17 22:57:57.891: vcpu-0| CPU reset: hard
Dec 17 22:57:57.891: vcpu-0| memoryHotplug: Entry[0]: 00000000000000A0-00000000000A0000
Dec 17 22:57:57.891: vcpu-0| memoryHotplug: Entry[1]: 00000000001000A0-0000000020000000
Dec 17 22:57:57.892: vcpu-0| VNET: Notification enabled for Ethernet0
Dec 17 22:57:57.895: vcpu-0| Transitioned vmx/execState/val to poweredOn
Dec 17 22:57:57.896: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:57:57.896: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:57:57.896: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:57:57.896: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:57:57.896: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:57:57.964: vcpu-0| sz=2992080
Dec 17 22:57:57.969: vcpu-1| APIC: version = 0x14, max LVT = 5
Dec 17 22:57:57.969: vcpu-1| APIC: LDR = 0x2000000, DFR = 0xffffffff
Dec 17 22:57:58.054: vcpu-1| guestCpuFeatures = 0x404001f8
Dec 17 22:57:58.065: vcpu-1| CPU reset: hard
Dec 17 22:57:58.078: vcpu-1| sz=2994144
Dec 17 22:57:58.082: vcpu-0| vmm32 initialized: Releasebuild-126130. cflags: 0x00000000.00000080.03000180.00000900
Dec 17 22:57:58.133: vcpu-1| vmm32 initialized: Releasebuild-126130. cflags: 0x00000000.00000080.03000180.00000900
Dec 17 22:57:58.201: vcpu-0| MonitorInitNumaUnmapVMM32
Dec 17 22:57:58.241: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:57:58.619: vcpu-1| CPU reset: soft
Dec 17 22:57:59.363: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0x0) and 0xd8000000(0x0)
Dec 17 22:57:59.371: vcpu-0| SVGA: Unregistering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:57:59.661: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:57:59.673: vcpu-0| SVGA: Unregistering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:57:59.717: vcpu-0| SVGA: Registering IOSpace at 0x10f0
Dec 17 22:57:59.717: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:57:59.727: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.729: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.731: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.733: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.735: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.737: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.739: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.742: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.744: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.746: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.748: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.750: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.752: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.754: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.756: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.758: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.760: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.762: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.764: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.766: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.767: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.770: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.772: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.774: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.776: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.778: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.780: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.782: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.784: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.786: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.788: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.792: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:57:59.796: vcpu-1| CPU reset: soft
Dec 17 22:57:59.890: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:57:59.890: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:57:59.991: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:57:59.998: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:00.264: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.267: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.269: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.272: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.274: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.276: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.278: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.281: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.283: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.285: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.287: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.289: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.291: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.294: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.296: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.298: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.300: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.302: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.304: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.306: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.308: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.310: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.312: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.314: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.316: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.318: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.320: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.322: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.325: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.327: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.329: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.331: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:00.346: vcpu-0| DISKUTIL: scsi0:0 : geometry=1305/255/63
Dec 17 22:58:00.478: vcpu-1| CPU reset: soft
Dec 17 22:58:00.638: vcpu-0| BIOS-UUID is 56 4d c4 76 4b a5 29 d0-26 d6 b4 09 08 49 4d 7d
Dec 17 22:58:01.173: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:01.262: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.262: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.264: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.264: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.267: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.267: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.342: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.342: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.345: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.345: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.426: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.426: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.446: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.446: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.461: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:01.475: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:01.563: vcpu-0| BUSLOGIC: Store HAL[20] = 0x00fb
Dec 17 22:58:01.563: vcpu-0| BUSLOGIC: Store HAL[22] = 0x0400
Dec 17 22:58:01.563: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.563: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.603: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.603: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.610: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.610: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:01.612: vcpu-0| BUSLOGIC: Store HAL[16] = 0xffff
Dec 17 22:58:01.612: vcpu-0| BUSLOGIC: Store HAL[18] = 0xfe01
Dec 17 22:58:02.209: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:02.641: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:02.643: mks| Ignoring update request in VGA_Expose (mode change pending).
Dec 17 22:58:02.762: vcpu-1| CPU reset: soft
Dec 17 22:58:05.777: mks| SVGA: display status changed, using optimizations for local consoles.
Dec 17 22:58:05.926: vmx| USB: Disconnecting device 0x5000203f00705
Dec 17 22:58:05.926: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Dec 17 22:58:05.926: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:05.926: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:06.780: vcpu-1| PatchSetProcessOne: Remote EagerValidate Enabled
Dec 17 22:58:06.861: vcpu-0| PatchSetProcessOne: Remote EagerValidate Enabled
Dec 17 22:58:07.243: vmx| USB: Autoconnecting device "Hewlett-Packard HP ScanJet 4400c" matching pattern [path:5/1 autoclean:1]
Dec 17 22:58:07.243: vmx| USB: Connecting device 0x5000703f00705
Dec 17 22:58:07.243: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:07.243: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:07.244: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:07.244: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:07.244: vmx| USBG: CONNREQ: Dequeued head request after 0 ms for [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:07.246: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:07.246: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:07.246: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:07.246: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:07.246: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:13.078: vcpu-0| SVGA: Unregistering IOSpace at 0x10f0
Dec 17 22:58:13.079: vcpu-0| SVGA: Unregistering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:58:13.182: vcpu-0| SVGA: Registering IOSpace at 0x10f0
Dec 17 22:58:13.183: vcpu-0| SVGA: Registering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:58:13.196: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.197: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.200: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.201: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.205: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.205: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.209: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.210: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.214: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.214: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.218: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.218: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.222: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.223: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.227: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.227: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.230: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.231: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.235: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.236: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.240: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.240: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.244: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.245: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.249: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.249: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.253: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.254: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.258: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.258: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.262: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.263: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.266: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.266: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.270: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.270: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.274: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.275: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.280: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.281: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.285: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.285: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.289: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.290: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.294: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.294: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.298: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.299: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.302: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.302: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.306: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.306: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.310: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.311: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.314: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.315: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.324: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.325: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.330: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.331: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.335: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.335: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.339: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:13.340: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:17.333: vmx| USB: Disconnecting device 0x5000703f00705
Dec 17 22:58:17.334: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Dec 17 22:58:17.334: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:17.334: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:18.639: vmx| USB: Autoconnecting device "Hewlett-Packard HP ScanJet 4400c" matching pattern [path:5/1 autoclean:1]
Dec 17 22:58:18.639: vmx| USB: Connecting device 0x5000803f00705
Dec 17 22:58:18.639: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:18.639: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:18.639: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:18.639: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:18.639: vmx| USBG: CONNREQ: Dequeued head request after 0 ms for [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:18.660: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:18.660: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:18.661: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:18.661: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:18.661: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:20.557: vmx| USB: Disconnecting device 0x5000803f00705
Dec 17 22:58:20.557: vmx| VMXVmdbLoadUsbDevices: New set of 2 USB devices
Dec 17 22:58:20.557: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:20.557: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:21.858: vmx| USB: Autoconnecting device "Hewlett-Packard HP ScanJet 4400c" matching pattern [path:5/1 autoclean:1]
Dec 17 22:58:21.858: vmx| USB: Connecting device 0x5000903f00705
Dec 17 22:58:21.858: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:21.858: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:21.858: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:21.858: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:21.859: vmx| USBG: CONNREQ: Dequeued head request after 0 ms for [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:21.861: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:21.861: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:21.861: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:21.861: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:21.861: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:26.601: vcpu-0| PCIBridge4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:26.663: vcpu-0| pciBridge4:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:26.726: vcpu-0| pciBridge4:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:26.790: vcpu-0| pciBridge4:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:26.851: vcpu-0| pciBridge4:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:26.913: vcpu-0| pciBridge4:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:26.975: vcpu-0| pciBridge4:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.037: vcpu-0| pciBridge4:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.103: vcpu-0| PCIBridge5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.163: vcpu-0| pciBridge5:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.225: vcpu-0| pciBridge5:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.292: vcpu-0| pciBridge5:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.371: vcpu-0| pciBridge5:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.444: vcpu-0| pciBridge5:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.506: vcpu-0| pciBridge5:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.569: vcpu-0| pciBridge5:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.646: vcpu-0| PCIBridge6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.710: vcpu-0| pciBridge6:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.772: vcpu-0| pciBridge6:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.830: vcpu-0| pciBridge6:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.901: vcpu-0| pciBridge6:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:27.961: vcpu-0| pciBridge6:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.022: vcpu-0| pciBridge6:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.098: vcpu-0| pciBridge6:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.161: vcpu-0| PCIBridge7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.235: vcpu-0| pciBridge7:1: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.331: vcpu-0| pciBridge7:2: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.396: vcpu-0| pciBridge7:3: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.460: vcpu-0| pciBridge7:4: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.521: vcpu-0| pciBridge7:5: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.585: vcpu-0| pciBridge7:6: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:28.664: vcpu-0| pciBridge7:7: ISA/VGA decoding enabled (ctrl 0004)
Dec 17 22:58:31.671: vcpu-0| CDROM: Mode Sense for Unsupported Page 0x1B
Dec 17 22:58:31.671: vcpu-0| SCSI DEVICE (ide1:0): MODE SENSE(10) for unsupported page 0x1b
Dec 17 22:58:31.793: vcpu-0| DISKUTIL: scsi0:0 : geometry=1305/255/63
Dec 17 22:58:31.793: vcpu-0| SCSI0: RESET BUS
Dec 17 22:58:31.809: vcpu-0| DISKUTIL: scsi0:0 : geometry=1305/255/63
Dec 17 22:58:31.863: vcpu-1| SCSI DEVICE (scsi0:0): INQUIRY request with EVPD set
Dec 17 22:58:32.018: vcpu-0| SCSI DEVICE (scsi0:0): MODE SENSE(6) for unsupported page 0x1c
Dec 17 22:58:32.184: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:32.185: vmx| VMXVmdbLoadUsbDevices: New set of 4 USB devices
Dec 17 22:58:32.185: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:32.185: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:32.185: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:32.185: vmx| USB: Found device [name:Hewlett-Packard\ HP\ LaserJet\ 1020 vid:03f0 pid:2b17 path:3/0 speed:high family:printer]
Dec 17 22:58:34.898: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:34.898: vmx| VMXVmdbLoadUsbDevices: New set of 3 USB devices
Dec 17 22:58:34.898: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:34.898: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:34.898: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:35.998: vcpu-1| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Dec 17 22:58:35.998: vcpu-1| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Dec 17 22:58:35.999: vcpu-1| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Dec 17 22:58:35.999: vcpu-1| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Dec 17 22:58:37.432: vcpu-1| SVGA: Unregistering IOSpace at 0x10f0
Dec 17 22:58:37.432: vcpu-1| SVGA: Unregistering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:58:37.497: vcpu-1| SVGA: Registering IOSpace at 0x10f0
Dec 17 22:58:37.509: vcpu-1| SVGA: Registering MemSpace at 0xd0000000(0xd0000000) and 0xd8000000(0xd8000000)
Dec 17 22:58:38.356: vcpu-1| Guest OS = 0x5008
Dec 17 22:58:38.465: vcpu-1| UHCI: Global Reset
Dec 17 22:58:38.690: vcpu-0| VNET: Notification enabled for Ethernet0
Dec 17 22:58:38.706: vcpu-1| Guest: VMXNET: Initialization completed successfully. Version 2.0 Jul 9 2008.
Dec 17 22:58:38.707: vcpu-1| Guest: VMXNET: Features:
Dec 17 22:58:38.708: vcpu-1| Guest: VMXNET: Vmxnet rx ringLen1 = 100, ringLen2 = 1
Dec 17 22:58:41.975: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:41.975: vmx| VMXVmdbLoadUsbDevices: New set of 4 USB devices
Dec 17 22:58:41.975: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:41.975: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:41.975: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:41.975: vmx| USB: Found device [name:Hewlett-Packard\ HP\ LaserJet\ 1020 vid:03f0 pid:2b17 path:3/0 speed:high family:printer]
Dec 17 22:58:42.666: vmx| USBGL: SETCONFIGURATION=1 failed -1:16:Device or resource busy, work around triggered
Dec 17 22:58:42.793: mks| MKS switching absolute mouse on
Dec 17 22:58:45.024: mks| SVGA: enabling escape command
Dec 17 22:58:45.025: vcpu-0| Guest display topology changed: numDisplays 1
Dec 17 22:58:45.029: vcpu-0| Guest: vmx_fb: SVGADBG: ready
Dec 17 22:58:45.033: vcpu-0| Guest: vmx_fb: This is the primary surface: PPDEV e18b8010
Dec 17 22:58:45.033: vcpu-0| Guest: vmx_fb: Display driver is out of sync with virtual hardware. Disabling 3d.
Dec 17 22:58:45.033: vcpu-0| Guest: vmx_fb: Current hardware revision: 0.0.
Dec 17 22:58:45.033: vcpu-0| Guest: vmx_fb: Driver compiled against: 2.0.
Dec 17 22:58:45.033: vcpu-0| Guest: vmx_fb: Display Acceleration: DirectDraw:ok, Direct3D:disabled.
Dec 17 22:58:45.033: vcpu-0| Guest: vmx_fb: Current hardware revision: 0.0.
Dec 17 22:58:45.034: vcpu-0| Guest: vmx_fb: Driver compiled against: 2.0.
Dec 17 22:58:45.034: vcpu-0| Guest: vmx_fb: DrvGetDirectDrawInfo: Overlay flags set
Dec 17 22:58:45.034: vcpu-0| Guest: vmx_fb: This is the primary surface: PPDEV e18b8010
Dec 17 22:58:45.034: vcpu-0| Guest: vmx_fb: Display driver is out of sync with virtual hardware. Disabling 3d.
Dec 17 22:58:45.035: vcpu-0| Guest: vmx_fb: Current hardware revision: 0.0.
Dec 17 22:58:45.035: vcpu-0| Guest: vmx_fb: Driver compiled against: 2.0.
Dec 17 22:58:45.035: vcpu-0| Guest: vmx_fb: Display Acceleration: DirectDraw:ok, Direct3D:disabled.
Dec 17 22:58:45.035: vcpu-0| Guest: vmx_fb: Current hardware revision: 0.0.
Dec 17 22:58:45.035: vcpu-0| Guest: vmx_fb: Driver compiled against: 2.0.
Dec 17 22:58:45.035: vcpu-0| Guest: vmx_fb: DrvGetDirectDrawInfo: Overlay flags set
Dec 17 22:58:45.601: mks| HostOps showCursor before defineCursor!
Dec 17 22:58:47.707: vmx| USB: Connecting device 0x3000b03f02b17
Dec 17 22:58:47.707: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:47.707: vmx| USBG: CONNREQ: Dequeued head request after 0 ms for [name:Hewlett-Packard\ HP\ LaserJet\ 1020 vid:03f0 pid:2b17 path:3/0 speed:high family:printer]
Dec 17 22:58:47.709: vmx| Msg_Hint: msg.usb.disconnectHostDriver (sent)
Dec 17 22:58:47.709: vmx| The specified device appears to be claimed by another driver (usblp) on the host operating system which means that the device may be in use. To continue, the device will first be disconnected from its current driver.
Dec 17 22:58:47.709: vmx| ---------------------------------------
Dec 17 22:58:48.747: vmx| USB: Adding autoconnect pattern [path:3/0 autoclean:1] in slot 1
Dec 17 22:58:48.834: vmx| POLL device deleted
Dec 17 22:58:48.834: vmx| USB: Device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other] should already be connected
Dec 17 22:58:48.834: vmx| USB: Device [name:Hewlett-Packard\ HP\ LaserJet\ 1020 vid:03f0 pid:2b17 path:3/0 speed:high family:printer] should already be connected
Dec 17 22:58:48.834: vmx| VMXVmdbLoadUsbDevices: New set of 4 USB devices
Dec 17 22:58:48.834: vmx| USB: Found device [name:Logitech\ USB\ Receiver vid:046d pid:c518 path:4/0 speed:low family:hid,hid-bootable]
Dec 17 22:58:48.834: vmx| USB: Found device [name:SGS\ Thomson\ Biometric\ Coprocessor vid:0483 pid:2016 path:1/1 speed:full family:vendor]
Dec 17 22:58:48.834: vmx| USB: Found device [name:Hewlett-Packard\ HP\ ScanJet\ 4400c vid:03f0 pid:0705 path:5/1 speed:full family:other]
Dec 17 22:58:48.834: vmx| USB: Found device [name:Hewlett-Packard\ HP\ LaserJet\ 1020 vid:03f0 pid:2b17 path:3/0 speed:high family:printer]
Dec 17 22:58:57.254: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 0
Dec 17 22:58:57.255: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 30
Dec 17 22:58:57.255: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 31
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 32
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 33
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 35
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 36
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 38
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 45
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 46
Dec 17 22:58:57.256: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 47
Dec 17 22:58:57.257: vcpu-0| CDROM: Emulate GET CONFIGURATION RT 0 start feature 259
Dec 17 22:59:04.987: vcpu-0| MKS Backdoor get pointer: first time, notify tools are running
Dec 17 22:59:14.356: vcpu-1| TOOLS unified loop capability requested by 'toolbox-dnd'; now sending options via TCLO
Dec 17 22:59:16.798: vcpu-0| GuestRpc: Channel 1, guest application toolbox-dnd.
Dec 17 22:59:16.830: vmx| DnDRegisterRpc: DnD rpc already set to 1
Dec 17 22:59:16.830: vmx| CopyPasteRegisterRpc: already set to 1
Dec 17 22:59:17.158: vmx| DnDRegisterRpc: DnD rpc already set to 1
Dec 17 22:59:17.158: vmx| CopyPasteRegisterRpc: already set to 1
Dec 17 22:59:17.818: vcpu-0| GuestRpc: Channel 2, guest application toolbox.
Dec 17 22:59:17.842: vcpu-0| TOOLS autoupgrade protocol version 2
Dec 17 22:59:17.847: vcpu-0| TOOLS ToolsCapabilityGuestTempDirectory received 1 C:\WINDOWS\TEMP
Dec 17 22:59:17.848: vcpu-1| TOOLS ToolsCapabilityGuestConfDirectory received C:\Documents and Settings\All Users\Application Data\VMware\VMware Tools
Dec 17 22:59:17.853: vcpu-1| TOOLS setting the tools version to '7428'
Dec 17 22:59:17.908: vcpu-0| Compared tools manifest from host and from the guest. Status = 2.
Dec 17 22:59:17.908: vcpu-0| TOOLS installed legacy version 7428, available legacy version 7428
Dec 17 22:59:17.908: vcpu-0| TOOLS manifest update status is 2 (1-out of date, 2-ok, 3-unknown)
Dec 17 22:59:17.908: vcpu-0| TOOLS will not be autoupgraded.
Dec 17 22:59:17.908: vcpu-0| TOOLS Setting autoupgrade-checked TRUE.
Dec 17 22:59:17.973: vcpu-1| Guest: toolbox: Version: build-126130
Dec 17 22:59:17.974: vcpu-1| TOOLS unified loop capability requested by 'toolbox'; now sending options via TCLO
Dec 17 22:59:40.869: mks| MKS lost grab
Dec 17 23:05:58.653: mks| MKS lost grab
Dec 17 23:06:01.501: mks| MKS lost grab
Dec 17 23:06:01.980: vmx| VMXVmdbCbVmVmxExecState: Exec state change requested to state poweredOff without reset
Dec 17 23:06:01.980: vmx| Stopping VCPU threads...
Dec 17 23:06:02.098: mks| Detaching from window system.
Dec 17 23:06:02.100: mks| XINFO: Reserved fds 133 and 286 for X connection
Dec 17 23:06:02.100: mks| Async MKS thread is exiting
Dec 17 23:06:02.100: vmx| USB: Disconnecting device 0x3000b03f02b17
Dec 17 23:06:02.101: vmx| USBGL: USBDEVFS_CONNECT(0) failed 1:11:Resource temporarily unavailable
Dec 17 23:06:02.101: vmx| USB: Disconnecting device 0x5000903f00705
Dec 17 23:06:02.104: vmx| TOOLS received request in VMX to set option 'enableDnD' -> '0'
Dec 17 23:06:02.104: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0'
Dec 17 23:06:02.104: vmx| TOOLS received request in VMX to set option 'copypaste' -> '0'
Dec 17 23:06:02.106: vmx| USB: Disconnecting device 0x200000010e0f0002
Dec 17 23:06:02.106: vmx| USB: Disconnecting device 0x400000010e0f0003
Dec 17 23:06:02.111: vmx| GLPrimaryDestroy, thread vmx
Dec 17 23:06:02.130: vmx| MKS local poweroff
Dec 17 23:06:02.130: vmx| scsi0:0: numIOs = 10624 numMergedIOs = 1742 numSplitIOs = 198 (10.2%)
Dec 17 23:06:02.319: vmx| WORKER: asyncOps=10982 maxActiveOps=11 maxPending=4 maxCompleted=4
Dec 17 23:06:02.415: vmx| Transitioned vmx/execState/val to poweredOff
Dec 17 23:06:02.826: vmx| vmdbPipe_Streams Couldn't read: OVL_STATUS_EOF
Dec 17 23:06:02.827: vmx| VMX idle exit
Dec 17 23:06:02.829: vmx| Flushing VMX VMDB connections
Dec 17 23:06:02.829: vmx| IPC_exit: disconnecting all threads
Dec 17 23:06:02.829: vmx| VMX exit (0).